builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-069 starttime: 1468251858.06 results: success (0) buildid: 20160711072027 builduid: 8c0a39d96ea04c579e36446382b35903 revision: f9cae1b84fe26ada12aaa1ef08173948a6b54e83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.057726) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.058589) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.058971) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.090614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.091082) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 08:44:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-07-11 08:44:18 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.066243 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.175631) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.176367) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021234 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.229831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.230639) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f9cae1b84fe26ada12aaa1ef08173948a6b54e83 --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 f9cae1b84fe26ada12aaa1ef08173948a6b54e83 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 08:44:18,973 truncating revision to first 12 chars 2016-07-11 08:44:18,973 Setting DEBUG logging. 2016-07-11 08:44:18,973 attempt 1/10 2016-07-11 08:44:18,973 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f9cae1b84fe2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 08:44:19,279 unpacking tar archive at: mozilla-central-f9cae1b84fe2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.664953 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.913852) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.914172) ========= script_repo_revision: f9cae1b84fe26ada12aaa1ef08173948a6b54e83 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.914612) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.914925) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.925363) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-11 08:44:18.925972) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:44:19 INFO - MultiFileLogger online at 20160711 08:44:19 in /builds/slave/test 08:44:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:44:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:44:19 INFO - {'append_to_log': False, 08:44:19 INFO - 'base_work_dir': '/builds/slave/test', 08:44:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:44:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:44:19 INFO - 'branch': 'Firefox-Non-PGO', 08:44:19 INFO - 'buildbot_json_path': 'buildprops.json', 08:44:19 INFO - 'config_files': ('talos/linux_config.py',), 08:44:19 INFO - 'default_actions': ('clobber', 08:44:19 INFO - 'read-buildbot-config', 08:44:19 INFO - 'download-and-extract', 08:44:19 INFO - 'populate-webroot', 08:44:19 INFO - 'create-virtualenv', 08:44:19 INFO - 'install', 08:44:19 INFO - 'run-tests'), 08:44:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:44:19 INFO - 'download_minidump_stackwalk': True, 08:44:19 INFO - 'download_symbols': 'ondemand', 08:44:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:44:19 INFO - 'tooltool.py': '/tools/tooltool.py', 08:44:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:44:19 INFO - '/tools/misc-python/virtualenv.py')}, 08:44:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:44:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:44:19 INFO - 'installer_path': 'installer.exe', 08:44:19 INFO - 'log_level': 'info', 08:44:19 INFO - 'log_name': 'talos', 08:44:19 INFO - 'log_to_console': True, 08:44:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:44:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:44:19 INFO - 'opt_config_files': (), 08:44:19 INFO - 'pip_index': False, 08:44:19 INFO - 'sps_profile': False, 08:44:19 INFO - 'sps_profile_interval': 0, 08:44:19 INFO - 'suite': 'dromaeojs-e10s', 08:44:19 INFO - 'system_bits': '32', 08:44:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:44:19 INFO - 'title': 'talos-linux64-ix-069', 08:44:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:44:19 INFO - 'use_talos_json': True, 08:44:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:44:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:44:19 INFO - 'work_dir': 'build'} 08:44:19 INFO - ##### 08:44:19 INFO - ##### Running clobber step. 08:44:19 INFO - ##### 08:44:19 INFO - Running pre-action listener: _resource_record_pre_action 08:44:19 INFO - Running main action method: clobber 08:44:19 INFO - rmtree: /builds/slave/test/build 08:44:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:44:20 INFO - Running post-action listener: _resource_record_post_action 08:44:20 INFO - ##### 08:44:20 INFO - ##### Finished clobber step (success) 08:44:20 INFO - ##### 08:44:20 INFO - ##### 08:44:20 INFO - ##### Running read-buildbot-config step. 08:44:20 INFO - ##### 08:44:20 INFO - Running pre-action listener: _resource_record_pre_action 08:44:20 INFO - Running main action method: read_buildbot_config 08:44:20 INFO - Using buildbot properties: 08:44:20 INFO - { 08:44:20 INFO - "project": "", 08:44:20 INFO - "product": "firefox", 08:44:20 INFO - "script_repo_revision": "production", 08:44:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:44:20 INFO - "repository": "", 08:44:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:44:20 INFO - "buildid": "20160711072027", 08:44:20 INFO - "pgo_build": "False", 08:44:20 INFO - "basedir": "/builds/slave/test", 08:44:20 INFO - "buildnumber": 112, 08:44:20 INFO - "slavename": "talos-linux64-ix-069", 08:44:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:44:20 INFO - "platform": "ubuntu64_hw", 08:44:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:44:20 INFO - "branch": "mozilla-central", 08:44:20 INFO - "repo_path": "mozilla-central", 08:44:20 INFO - "revision": "f9cae1b84fe26ada12aaa1ef08173948a6b54e83", 08:44:20 INFO - "stage_platform": "linux64", 08:44:20 INFO - "builduid": "8c0a39d96ea04c579e36446382b35903", 08:44:20 INFO - "slavebuilddir": "test" 08:44:20 INFO - } 08:44:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:44:20 INFO - Running post-action listener: _resource_record_post_action 08:44:20 INFO - ##### 08:44:20 INFO - ##### Finished read-buildbot-config step (success) 08:44:20 INFO - ##### 08:44:20 INFO - ##### 08:44:20 INFO - ##### Running download-and-extract step. 08:44:20 INFO - ##### 08:44:20 INFO - Running pre-action listener: _resource_record_pre_action 08:44:20 INFO - Running main action method: download_and_extract 08:44:20 INFO - mkdir: /builds/slave/test/build/tests 08:44:20 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')]} 08:44:20 INFO - https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:44:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:44:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:44:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/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 08:44:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/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 08:44:23 INFO - Downloaded 1361 bytes. 08:44:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:44:23 INFO - Using the following test package requirements: 08:44:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:44:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:44:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:44:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:23 INFO - u'jsshell-linux-x86_64.zip'], 08:44:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:44:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:44:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:44:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:44:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:44:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:44:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:44: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')]} 08:44:23 INFO - https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:44:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:44:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:44:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/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 08:44:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/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 08:44:24 INFO - Downloaded 22735220 bytes. 08:44:24 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'] 08:44:24 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 08:44:26 INFO - Return code: 0 08:44:26 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 08:44:26 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')]} 08:44:26 INFO - https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:44:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:44:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:44:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/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 08:44:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/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 08:44:27 INFO - Downloaded 22735220 bytes. 08:44:27 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'] 08:44:27 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 08:44:28 INFO - Return code: 0 08:44:28 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')]} 08:44:28 INFO - https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:44:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:44:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:44:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/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 08:44:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/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 08:44:29 INFO - Downloaded 14403333 bytes. 08:44:29 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'] 08:44:29 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 08:44:29 INFO - Return code: 0 08:44:29 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')]} 08:44:29 INFO - https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:44:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:44:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:44:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/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 08:44:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/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 08:44:31 INFO - Downloaded 56658725 bytes. 08:44:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:44:31 INFO - mkdir: /builds/slave/test/properties 08:44:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:44:31 INFO - Writing to file /builds/slave/test/properties/build_url 08:44:31 INFO - Contents: 08:44:31 INFO - build_url:https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:44:32 INFO - Running post-action listener: _resource_record_post_action 08:44:32 INFO - Running post-action listener: set_extra_try_arguments 08:44:32 INFO - ##### 08:44:32 INFO - ##### Finished download-and-extract step (success) 08:44:32 INFO - ##### 08:44:32 INFO - ##### 08:44:32 INFO - ##### Running populate-webroot step. 08:44:32 INFO - ##### 08:44:32 INFO - Running pre-action listener: _resource_record_pre_action 08:44:32 INFO - Running main action method: populate_webroot 08:44:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:44:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:44:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:44:32 INFO - '--tppagecycles', 08:44:32 INFO - '7'], 08:44:32 INFO - 'tests': ['tsvgm']}}, 08:44:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:44:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:44:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:44:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:44:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:44:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:44:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:32 INFO - 'talos_options': ['--disable-e10s'], 08:44:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:32 INFO - 'talos_options': ['--disable-e10s'], 08:44:32 INFO - 'tests': ['damp', 'tps']}, 08:44:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:32 INFO - 'tests': ['damp', 'tps']}, 08:44:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:44:32 INFO - 'tests': ['dromaeo_dom']}, 08:44:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:44:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:44:32 INFO - 'tests': ['basic_compositor_video']}, 08:44:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:44:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:44:32 INFO - 'tests': ['a11yr', 08:44:32 INFO - 'ts_paint', 08:44:32 INFO - 'tpaint', 08:44:32 INFO - 'sessionrestore', 08:44:32 INFO - 'sessionrestore_no_auto_restore', 08:44:32 INFO - 'tabpaint']}, 08:44:32 INFO - 'other-e10s': {'tests': ['a11yr', 08:44:32 INFO - 'ts_paint', 08:44:32 INFO - 'tpaint', 08:44:32 INFO - 'sessionrestore', 08:44:32 INFO - 'sessionrestore_no_auto_restore', 08:44:32 INFO - 'tabpaint']}, 08:44:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:44:32 INFO - 'ts_paint', 08:44:32 INFO - 'tpaint', 08:44:32 INFO - 'sessionrestore', 08:44:32 INFO - 'sessionrestore_no_auto_restore', 08:44:32 INFO - 'tabpaint']}, 08:44:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:44:32 INFO - 'ts_paint', 08:44:32 INFO - 'tpaint', 08:44:32 INFO - 'sessionrestore', 08:44:32 INFO - 'sessionrestore_no_auto_restore', 08:44:32 INFO - 'tabpaint']}, 08:44:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:44:32 INFO - 'tests': ['a11yr', 08:44:32 INFO - 'ts_paint', 08:44:32 INFO - 'tpaint', 08:44:32 INFO - 'sessionrestore', 08:44:32 INFO - 'sessionrestore_no_auto_restore', 08:44:32 INFO - 'tabpaint']}, 08:44:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:44:32 INFO - 'tests': ['a11yr', 08:44:32 INFO - 'ts_paint', 08:44:32 INFO - 'tpaint', 08:44:32 INFO - 'sessionrestore', 08:44:32 INFO - 'sessionrestore_no_auto_restore', 08:44:32 INFO - 'tabpaint']}, 08:44:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:44:32 INFO - 'tests': ['tsvgx', 08:44:32 INFO - 'tsvgr_opacity', 08:44:32 INFO - 'tart', 08:44:32 INFO - 'tscrollx', 08:44:32 INFO - 'cart']}, 08:44:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:44:32 INFO - 'tsvgr_opacity', 08:44:32 INFO - 'tart', 08:44:32 INFO - 'tscrollx', 08:44:32 INFO - 'cart']}, 08:44:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:32 INFO - 'talos_options': ['--disable-e10s'], 08:44:32 INFO - 'tests': ['tp5o']}, 08:44:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:32 INFO - 'tests': ['tp5o']}, 08:44:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:32 INFO - 'talos_options': ['--disable-e10s', 08:44:32 INFO - '--xperf_path', 08:44:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:32 INFO - 'tests': ['tp5n']}, 08:44:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:32 INFO - 'talos_options': ['--xperf_path', 08:44:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:32 INFO - 'tests': ['tp5n']}}, 08:44:32 INFO - 'talos.zip': {'path': '', 08:44:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:44:32 INFO - Running post-action listener: _resource_record_post_action 08:44:32 INFO - ##### 08:44:32 INFO - ##### Finished populate-webroot step (success) 08:44:32 INFO - ##### 08:44:32 INFO - ##### 08:44:32 INFO - ##### Running create-virtualenv step. 08:44:32 INFO - ##### 08:44:32 INFO - Running pre-action listener: _resource_record_pre_action 08:44:32 INFO - Running main action method: create_virtualenv 08:44:32 INFO - Creating virtualenv /builds/slave/test/build/venv 08:44:32 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 08:44:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:44:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:44:32 INFO - Using real prefix '/usr' 08:44:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:44:32 INFO - Installing distribute.............................................................................................................................................................................................done. 08:44:34 INFO - Installing pip.................done. 08:44:34 INFO - Return code: 0 08:44:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:44:34 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')]} 08:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:34 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')]} 08:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:34 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 0x2329030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7570>, '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 0x25e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', '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 08:44:34 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 08:44:34 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 08:44:34 INFO - Using env: {'DISPLAY': ':0', 08:44:34 INFO - 'HOME': '/home/cltbld', 08:44:34 INFO - 'LANG': 'en_US.UTF-8', 08:44:34 INFO - 'LANGUAGE': 'en_US:en', 08:44:34 INFO - 'LOGNAME': 'cltbld', 08:44:34 INFO - 'MAIL': '/var/mail/cltbld', 08:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:34 INFO - 'MOZ_NO_REMOTE': '1', 08:44:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:34 INFO - 'NO_EM_RESTART': '1', 08:44:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:34 INFO - 'PWD': '/builds/slave/test', 08:44:34 INFO - 'SHELL': '/bin/bash', 08:44:34 INFO - 'SHLVL': '1', 08:44:34 INFO - 'TERM': 'linux', 08:44:34 INFO - 'TMOUT': '86400', 08:44:34 INFO - 'USER': 'cltbld', 08:44:34 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', 08:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:34 INFO - '_': '/tools/buildbot/bin/python'} 08:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:35 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 08:44:35 INFO - Cleaning up... 08:44:35 INFO - Return code: 0 08:44:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:35 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 0x2329030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7570>, '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 0x25e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', '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 08:44:35 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 08:44:35 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 08:44:35 INFO - Using env: {'DISPLAY': ':0', 08:44:35 INFO - 'HOME': '/home/cltbld', 08:44:35 INFO - 'LANG': 'en_US.UTF-8', 08:44:35 INFO - 'LANGUAGE': 'en_US:en', 08:44:35 INFO - 'LOGNAME': 'cltbld', 08:44:35 INFO - 'MAIL': '/var/mail/cltbld', 08:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:35 INFO - 'MOZ_NO_REMOTE': '1', 08:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:35 INFO - 'NO_EM_RESTART': '1', 08:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:35 INFO - 'PWD': '/builds/slave/test', 08:44:35 INFO - 'SHELL': '/bin/bash', 08:44:35 INFO - 'SHLVL': '1', 08:44:35 INFO - 'TERM': 'linux', 08:44:35 INFO - 'TMOUT': '86400', 08:44:35 INFO - 'USER': 'cltbld', 08:44:35 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', 08:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:35 INFO - '_': '/tools/buildbot/bin/python'} 08:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:35 INFO - Downloading/unpacking psutil>=3.1.1 08:44:35 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 08:44:35 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 08:44:35 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 08:44:35 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 08:44:35 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 08:44:35 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 08:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:44:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:37 INFO - Installing collected packages: psutil 08:44:37 INFO - Running setup.py install for psutil 08:44:37 INFO - building 'psutil._psutil_linux' extension 08:44:37 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 08:44:37 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 08:44:37 INFO - building 'psutil._psutil_posix' extension 08:44:37 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 08:44:37 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 08:44:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:37 INFO - Successfully installed psutil 08:44:37 INFO - Cleaning up... 08:44:37 INFO - Return code: 0 08:44:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:37 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 0x2329030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7570>, '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 0x25e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', '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 08:44:37 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 08:44:37 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 08:44:37 INFO - Using env: {'DISPLAY': ':0', 08:44:37 INFO - 'HOME': '/home/cltbld', 08:44:37 INFO - 'LANG': 'en_US.UTF-8', 08:44:37 INFO - 'LANGUAGE': 'en_US:en', 08:44:37 INFO - 'LOGNAME': 'cltbld', 08:44:37 INFO - 'MAIL': '/var/mail/cltbld', 08:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:37 INFO - 'MOZ_NO_REMOTE': '1', 08:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:37 INFO - 'NO_EM_RESTART': '1', 08:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:37 INFO - 'PWD': '/builds/slave/test', 08:44:37 INFO - 'SHELL': '/bin/bash', 08:44:37 INFO - 'SHLVL': '1', 08:44:37 INFO - 'TERM': 'linux', 08:44:37 INFO - 'TMOUT': '86400', 08:44:37 INFO - 'USER': 'cltbld', 08:44:37 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', 08:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:37 INFO - '_': '/tools/buildbot/bin/python'} 08:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:44:38 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 08:44:38 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 08:44:38 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 08:44:38 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 08:44:38 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 08:44:38 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 08:44:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:44:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:44:40 INFO - Installing collected packages: mozsystemmonitor 08:44:40 INFO - Running setup.py install for mozsystemmonitor 08:44:40 INFO - Successfully installed mozsystemmonitor 08:44:40 INFO - Cleaning up... 08:44:40 INFO - Return code: 0 08:44:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:40 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 0x2329030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7570>, '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 0x25e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', '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 08:44:40 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 08:44:40 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 08:44:40 INFO - Using env: {'DISPLAY': ':0', 08:44:40 INFO - 'HOME': '/home/cltbld', 08:44:40 INFO - 'LANG': 'en_US.UTF-8', 08:44:40 INFO - 'LANGUAGE': 'en_US:en', 08:44:40 INFO - 'LOGNAME': 'cltbld', 08:44:40 INFO - 'MAIL': '/var/mail/cltbld', 08:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:40 INFO - 'MOZ_NO_REMOTE': '1', 08:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:40 INFO - 'NO_EM_RESTART': '1', 08:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:40 INFO - 'PWD': '/builds/slave/test', 08:44:40 INFO - 'SHELL': '/bin/bash', 08:44:40 INFO - 'SHLVL': '1', 08:44:40 INFO - 'TERM': 'linux', 08:44:40 INFO - 'TMOUT': '86400', 08:44:40 INFO - 'USER': 'cltbld', 08:44:40 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', 08:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:40 INFO - '_': '/tools/buildbot/bin/python'} 08:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:40 INFO - Downloading/unpacking jsonschema==2.5.1 08:44:40 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 08:44:40 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 08:44:40 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 08:44:40 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 08:44:40 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 08:44:40 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 08:44:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:44:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:44:42 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 08:44:42 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 08:44:42 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 08:44:42 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 08:44:42 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 08:44:42 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 08:44:42 INFO - Downloading functools32-3.2.3-2.tar.gz 08:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:44:42 INFO - warning: no files found matching '*.txt' 08:44:42 INFO - no previously-included directories found matching 'build' 08:44:42 INFO - no previously-included directories found matching 'dist' 08:44:42 INFO - no previously-included directories found matching '.git*' 08:44:42 INFO - Installing collected packages: jsonschema, functools32 08:44:42 INFO - Running setup.py install for functools32 08:44:42 INFO - warning: no files found matching '*.txt' 08:44:42 INFO - no previously-included directories found matching 'build' 08:44:42 INFO - no previously-included directories found matching 'dist' 08:44:42 INFO - no previously-included directories found matching '.git*' 08:44:42 INFO - Successfully installed jsonschema functools32 08:44:42 INFO - Cleaning up... 08:44:42 INFO - Return code: 0 08:44:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:42 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 0x2329030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7570>, '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 0x25e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', '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 08:44:42 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 08:44:42 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 08:44:42 INFO - Using env: {'DISPLAY': ':0', 08:44:42 INFO - 'HOME': '/home/cltbld', 08:44:42 INFO - 'LANG': 'en_US.UTF-8', 08:44:42 INFO - 'LANGUAGE': 'en_US:en', 08:44:42 INFO - 'LOGNAME': 'cltbld', 08:44:42 INFO - 'MAIL': '/var/mail/cltbld', 08:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:42 INFO - 'MOZ_NO_REMOTE': '1', 08:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:42 INFO - 'NO_EM_RESTART': '1', 08:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:42 INFO - 'PWD': '/builds/slave/test', 08:44:42 INFO - 'SHELL': '/bin/bash', 08:44:42 INFO - 'SHLVL': '1', 08:44:42 INFO - 'TERM': 'linux', 08:44:42 INFO - 'TMOUT': '86400', 08:44:42 INFO - 'USER': 'cltbld', 08:44:42 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', 08:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:42 INFO - '_': '/tools/buildbot/bin/python'} 08:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:42 INFO - Downloading/unpacking blobuploader==1.2.4 08:44:42 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 08:44:42 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 08:44:42 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 08:44:42 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 08:44:42 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 08:44:42 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 08:44:44 INFO - Downloading blobuploader-1.2.4.tar.gz 08:44:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:44:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:44:44 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 08:44:44 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 08:44:44 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 08:44:44 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 08:44:44 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 08:44:44 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 08:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:44:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:44:45 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 08:44:45 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 08:44:45 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 08:44:45 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 08:44:45 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 08:44:45 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 08:44:45 INFO - Downloading docopt-0.6.1.tar.gz 08:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:44:45 INFO - Installing collected packages: blobuploader, requests, docopt 08:44:45 INFO - Running setup.py install for blobuploader 08:44:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:44:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:44:45 INFO - Running setup.py install for requests 08:44:46 INFO - Running setup.py install for docopt 08:44:46 INFO - Successfully installed blobuploader requests docopt 08:44:46 INFO - Cleaning up... 08:44:46 INFO - Return code: 0 08:44:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:46 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 0x2329030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7570>, '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 0x25e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', '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 08:44:46 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 08:44:46 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 08:44:46 INFO - Using env: {'DISPLAY': ':0', 08:44:46 INFO - 'HOME': '/home/cltbld', 08:44:46 INFO - 'LANG': 'en_US.UTF-8', 08:44:46 INFO - 'LANGUAGE': 'en_US:en', 08:44:46 INFO - 'LOGNAME': 'cltbld', 08:44:46 INFO - 'MAIL': '/var/mail/cltbld', 08:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:46 INFO - 'MOZ_NO_REMOTE': '1', 08:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:46 INFO - 'NO_EM_RESTART': '1', 08:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:46 INFO - 'PWD': '/builds/slave/test', 08:44:46 INFO - 'SHELL': '/bin/bash', 08:44:46 INFO - 'SHLVL': '1', 08:44:46 INFO - 'TERM': 'linux', 08:44:46 INFO - 'TMOUT': '86400', 08:44:46 INFO - 'USER': 'cltbld', 08:44:46 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', 08:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:46 INFO - '_': '/tools/buildbot/bin/python'} 08:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:46 INFO - Running setup.py (path:/tmp/pip-1WTXJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:46 INFO - Running setup.py (path:/tmp/pip-IQMxUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:46 INFO - Running setup.py (path:/tmp/pip-_uwfUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:46 INFO - Running setup.py (path:/tmp/pip-p2NYJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:46 INFO - Running setup.py (path:/tmp/pip-n_eIIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:46 INFO - Running setup.py (path:/tmp/pip-GH2osT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:46 INFO - Running setup.py (path:/tmp/pip-vLEn5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:46 INFO - Running setup.py (path:/tmp/pip-7UPu91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:46 INFO - Running setup.py (path:/tmp/pip-oNurlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:47 INFO - Running setup.py (path:/tmp/pip-IQ04w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:47 INFO - Running setup.py (path:/tmp/pip-JkYukK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:47 INFO - Running setup.py (path:/tmp/pip-f44mHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:47 INFO - Running setup.py (path:/tmp/pip-r2FRhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:47 INFO - Running setup.py (path:/tmp/pip-yarGBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:47 INFO - Running setup.py (path:/tmp/pip-R9Ngca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:47 INFO - Running setup.py (path:/tmp/pip-yiC0bF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:47 INFO - Running setup.py (path:/tmp/pip-vTXHov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:44:47 INFO - Running setup.py install for manifestparser 08:44:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:44:47 INFO - Running setup.py install for mozcrash 08:44:47 INFO - Running setup.py install for mozdebug 08:44:47 INFO - Running setup.py install for mozdevice 08:44:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:44:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:44:48 INFO - Running setup.py install for mozfile 08:44:48 INFO - Running setup.py install for mozhttpd 08:44:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:44:48 INFO - Running setup.py install for mozinfo 08:44:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:44:48 INFO - Running setup.py install for mozInstall 08:44:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:44:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:44:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:44:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:44:48 INFO - Running setup.py install for mozleak 08:44:48 INFO - Running setup.py install for mozlog 08:44:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:44:48 INFO - Running setup.py install for moznetwork 08:44:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:44:48 INFO - Running setup.py install for mozprocess 08:44:48 INFO - Running setup.py install for mozprofile 08:44:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:44:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:44:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:44:49 INFO - Running setup.py install for mozrunner 08:44:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:44:49 INFO - Running setup.py install for mozscreenshot 08:44:49 INFO - Running setup.py install for moztest 08:44:49 INFO - Running setup.py install for mozversion 08:44:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:44:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:44:49 INFO - Cleaning up... 08:44:49 INFO - Return code: 0 08:44:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:49 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 0x2329030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7570>, '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 0x25e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', '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 08:44:49 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 08:44:49 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 08:44:49 INFO - Using env: {'DISPLAY': ':0', 08:44:49 INFO - 'HOME': '/home/cltbld', 08:44:49 INFO - 'LANG': 'en_US.UTF-8', 08:44:49 INFO - 'LANGUAGE': 'en_US:en', 08:44:49 INFO - 'LOGNAME': 'cltbld', 08:44:49 INFO - 'MAIL': '/var/mail/cltbld', 08:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:49 INFO - 'MOZ_NO_REMOTE': '1', 08:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:49 INFO - 'NO_EM_RESTART': '1', 08:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:49 INFO - 'PWD': '/builds/slave/test', 08:44:49 INFO - 'SHELL': '/bin/bash', 08:44:49 INFO - 'SHLVL': '1', 08:44:49 INFO - 'TERM': 'linux', 08:44:49 INFO - 'TMOUT': '86400', 08:44:49 INFO - 'USER': 'cltbld', 08:44:49 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', 08:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:49 INFO - '_': '/tools/buildbot/bin/python'} 08:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:49 INFO - Running setup.py (path:/tmp/pip-wKPHuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:49 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)) 08:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:49 INFO - Running setup.py (path:/tmp/pip-jlNZj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:49 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)) 08:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:49 INFO - Running setup.py (path:/tmp/pip-2qLulA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:49 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)) 08:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:49 INFO - Running setup.py (path:/tmp/pip-txVOg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:49 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)) 08:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:49 INFO - Running setup.py (path:/tmp/pip-dlpuyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:50 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)) 08:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:50 INFO - Running setup.py (path:/tmp/pip-RjY_Yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:50 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)) 08:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:50 INFO - Running setup.py (path:/tmp/pip-tIgmBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:50 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)) 08:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:50 INFO - Running setup.py (path:/tmp/pip-EvLG25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:50 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)) 08:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:50 INFO - Running setup.py (path:/tmp/pip-yXtw3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:50 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)) 08:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:50 INFO - Running setup.py (path:/tmp/pip-Baa2JZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:50 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)) 08:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:50 INFO - Running setup.py (path:/tmp/pip-_hYoK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:50 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)) 08:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:50 INFO - Running setup.py (path:/tmp/pip-qlRd8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:50 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)) 08:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:50 INFO - Running setup.py (path:/tmp/pip-QOkgbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:50 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)) 08:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:50 INFO - Running setup.py (path:/tmp/pip-gq_N5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:50 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)) 08:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:50 INFO - Running setup.py (path:/tmp/pip-ST2B1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:50 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)) 08:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:50 INFO - Running setup.py (path:/tmp/pip-Vz64G5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:50 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)) 08:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:50 INFO - Running setup.py (path:/tmp/pip-gJIQ9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:50 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)) 08:44:50 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)) 08:44:50 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)) 08:44:50 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)) 08:44:50 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)) 08:44:50 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)) 08:44:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:44:50 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 08:44:50 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 08:44:50 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 08:44:50 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 08:44:50 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 08:44:50 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 08:44:52 INFO - Downloading blessings-1.6.tar.gz 08:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:44:52 INFO - Installing collected packages: blessings 08:44:52 INFO - Running setup.py install for blessings 08:44:53 INFO - Successfully installed blessings 08:44:53 INFO - Cleaning up... 08:44:53 INFO - Return code: 0 08:44:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:44:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:53 INFO - Reading from file tmpfile_stdout 08:44:53 INFO - Current package versions: 08:44:53 INFO - argparse == 1.2.1 08:44:53 INFO - blessings == 1.6 08:44:53 INFO - blobuploader == 1.2.4 08:44:53 INFO - docopt == 0.6.1 08:44:53 INFO - functools32 == 3.2.3-2 08:44:53 INFO - jsonschema == 2.5.1 08:44:53 INFO - manifestparser == 1.1 08:44:53 INFO - mozInstall == 1.12 08:44:53 INFO - mozcrash == 0.17 08:44:53 INFO - mozdebug == 0.1 08:44:53 INFO - mozdevice == 0.48 08:44:53 INFO - mozfile == 1.2 08:44:53 INFO - mozhttpd == 0.7 08:44:53 INFO - mozinfo == 0.9 08:44:53 INFO - mozleak == 0.1 08:44:53 INFO - mozlog == 3.2 08:44:53 INFO - moznetwork == 0.27 08:44:53 INFO - mozprocess == 0.23 08:44:53 INFO - mozprofile == 0.28 08:44:53 INFO - mozrunner == 6.12 08:44:53 INFO - mozscreenshot == 0.1 08:44:53 INFO - mozsystemmonitor == 0.3 08:44:53 INFO - moztest == 0.7 08:44:53 INFO - mozversion == 1.4 08:44:53 INFO - psutil == 3.1.1 08:44:53 INFO - requests == 1.2.3 08:44:53 INFO - wsgiref == 0.1.2 08:44:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:53 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')]} 08:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:53 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')]} 08:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:53 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 0x2329030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7570>, '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 0x25e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', '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 08:44:53 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 08:44:53 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 08:44:53 INFO - Using env: {'DISPLAY': ':0', 08:44:53 INFO - 'HOME': '/home/cltbld', 08:44:53 INFO - 'LANG': 'en_US.UTF-8', 08:44:53 INFO - 'LANGUAGE': 'en_US:en', 08:44:53 INFO - 'LOGNAME': 'cltbld', 08:44:53 INFO - 'MAIL': '/var/mail/cltbld', 08:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:53 INFO - 'MOZ_NO_REMOTE': '1', 08:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:53 INFO - 'NO_EM_RESTART': '1', 08:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:53 INFO - 'PWD': '/builds/slave/test', 08:44:53 INFO - 'SHELL': '/bin/bash', 08:44:53 INFO - 'SHLVL': '1', 08:44:53 INFO - 'TERM': 'linux', 08:44:53 INFO - 'TMOUT': '86400', 08:44:53 INFO - 'USER': 'cltbld', 08:44:53 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', 08:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:53 INFO - '_': '/tools/buildbot/bin/python'} 08:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:53 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)) 08:44:53 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)) 08:44:53 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)) 08:44:53 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)) 08:44:53 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)) 08:44:53 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)) 08:44:53 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)) 08:44:53 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)) 08:44:53 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)) 08:44:53 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)) 08:44:53 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)) 08:44:53 INFO - Cleaning up... 08:44:53 INFO - Return code: 0 08:44:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:44:53 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')]} 08:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:53 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')]} 08:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:53 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 0x2329030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7570>, '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 0x25e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', '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 08:44:53 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 08:44:53 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 08:44:53 INFO - Using env: {'DISPLAY': ':0', 08:44:53 INFO - 'HOME': '/home/cltbld', 08:44:53 INFO - 'LANG': 'en_US.UTF-8', 08:44:53 INFO - 'LANGUAGE': 'en_US:en', 08:44:53 INFO - 'LOGNAME': 'cltbld', 08:44:53 INFO - 'MAIL': '/var/mail/cltbld', 08:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:53 INFO - 'MOZ_NO_REMOTE': '1', 08:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:53 INFO - 'NO_EM_RESTART': '1', 08:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:53 INFO - 'PWD': '/builds/slave/test', 08:44:53 INFO - 'SHELL': '/bin/bash', 08:44:53 INFO - 'SHLVL': '1', 08:44:53 INFO - 'TERM': 'linux', 08:44:53 INFO - 'TMOUT': '86400', 08:44:53 INFO - 'USER': 'cltbld', 08:44:53 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', 08:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:53 INFO - '_': '/tools/buildbot/bin/python'} 08:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:44:53 INFO - Cleaning up... 08:44:53 INFO - Return code: 0 08:44:53 INFO - Running post-action listener: _resource_record_post_action 08:44:53 INFO - Running post-action listener: _start_resource_monitoring 08:44:53 INFO - Starting resource monitoring. 08:44:53 INFO - ##### 08:44:53 INFO - ##### Finished create-virtualenv step (success) 08:44:53 INFO - ##### 08:44:53 INFO - ##### 08:44:53 INFO - ##### Running install step. 08:44:53 INFO - ##### 08:44:53 INFO - Running pre-action listener: _resource_record_pre_action 08:44:53 INFO - Running main action method: install 08:44:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:53 INFO - Reading from file tmpfile_stdout 08:44:53 INFO - Detecting whether we're running mozinstall >=1.0... 08:44:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:44:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:44:54 INFO - Reading from file tmpfile_stdout 08:44:54 INFO - Output received: 08:44:54 INFO - Usage: mozinstall [options] installer 08:44:54 INFO - Options: 08:44:54 INFO - -h, --help show this help message and exit 08:44:54 INFO - -d DEST, --destination=DEST 08:44:54 INFO - Directory to install application into. [default: 08:44:54 INFO - "/builds/slave/test"] 08:44:54 INFO - --app=APP Application being installed. [default: firefox] 08:44:54 INFO - mkdir: /builds/slave/test/build/application 08:44:54 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'] 08:44:54 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 08:45:10 INFO - Reading from file tmpfile_stdout 08:45:10 INFO - Output received: 08:45:10 INFO - /builds/slave/test/build/application/firefox/firefox 08:45:10 INFO - Running post-action listener: _resource_record_post_action 08:45:10 INFO - ##### 08:45:10 INFO - ##### Finished install step (success) 08:45:10 INFO - ##### 08:45:10 INFO - ##### 08:45:10 INFO - ##### Running run-tests step. 08:45:10 INFO - ##### 08:45:10 INFO - Running pre-action listener: _resource_record_pre_action 08:45:10 INFO - Running main action method: run_tests 08:45:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:45:10 INFO - Python 2.7.3 08:45:10 INFO - Return code: 0 08:45:10 INFO - grabbing minidump binary from tooltool 08:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:10 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 0x25e7570>, '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 0x25e8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e8900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:45:10 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 08:45:10 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 08:45:10 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 08:45:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:45:10 INFO - Return code: 0 08:45:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:45:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:45:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:45:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:45:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:45:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 08:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 08:45:10 INFO - Using env: {'DISPLAY': ':0', 08:45:10 INFO - 'HOME': '/home/cltbld', 08:45:10 INFO - 'LANG': 'en_US.UTF-8', 08:45:10 INFO - 'LANGUAGE': 'en_US:en', 08:45:10 INFO - 'LOGNAME': 'cltbld', 08:45:10 INFO - 'MAIL': '/var/mail/cltbld', 08:45:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:45:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:10 INFO - 'MOZ_NO_REMOTE': '1', 08:45:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:10 INFO - 'NO_EM_RESTART': '1', 08:45:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:10 INFO - 'PWD': '/builds/slave/test', 08:45:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:45:10 INFO - 'SHELL': '/bin/bash', 08:45:10 INFO - 'SHLVL': '1', 08:45:10 INFO - 'TERM': 'linux', 08:45:10 INFO - 'TMOUT': '86400', 08:45:10 INFO - 'USER': 'cltbld', 08:45:10 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761', 08:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:10 INFO - '_': '/tools/buildbot/bin/python'} 08:45:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 08:45:10 INFO - mozversion application_buildid: 20160711072027 08:45:10 INFO - mozversion application_changeset: f9cae1b84fe26ada12aaa1ef08173948a6b54e83 08:45:10 INFO - mozversion application_display_name: Nightly 08:45:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:45:10 INFO - mozversion application_name: Firefox 08:45:10 INFO - mozversion application_remotingname: firefox 08:45:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:45:10 INFO - mozversion application_vendor: Mozilla 08:45:10 INFO - mozversion application_version: 50.0a1 08:45:10 INFO - mozversion platform_buildid: 20160711072027 08:45:10 INFO - mozversion platform_changeset: f9cae1b84fe26ada12aaa1ef08173948a6b54e83 08:45:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:45:10 INFO - mozversion platform_version: 50.0a1 08:45:10 INFO - using testdate: 1468251910 08:45:10 INFO - actual date: 1468251910 08:45:10 INFO - starting webserver on 'localhost:52134' 08:45:10 INFO - SUITE-START | Running 2 tests 08:45:10 INFO - TEST-START | dromaeo_css 08:45:10 INFO - operating with platform_type : linux_ 08:45:10 INFO - Initialising browser for dromaeo_css test... 08:45:10 INFO - TEST-INFO | started process 22042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3CLhMT/profile http://localhost:52134/getInfo.html) 08:45:15 INFO - PROCESS | 22042 | __metrics Screen width/height:1600/1200 08:45:15 INFO - PROCESS | 22042 | colorDepth:24 08:45:15 INFO - PROCESS | 22042 | Browser inner width/height: 1024/697 08:45:15 INFO - PROCESS | 22042 | __metrics 08:45:16 ERROR - PROCESS | 22042 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 08:45:17 INFO - TEST-INFO | 22042: exit 0 08:45:17 INFO - Browser initialized. 08:45:17 INFO - Running cycle 1/1 for dromaeo_css test... 08:45:17 INFO - TEST-INFO | started process 22159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3CLhMT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:45:29 INFO - PROCESS | 22159 | RSS: Main: 168775680 08:45:29 INFO - PROCESS | 22159 | 08:46:18 INFO - PROCESS | 22159 | 1468251978800 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] 08:48:31 INFO - PROCESS | 22159 | Cycle 1(1): loaded http://localhost:52134/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52134/tests/dromaeo/cssquery-ext.html) 08:48:32 INFO - PROCESS | 22159 | RSS: Main: 169111552 08:48:32 INFO - PROCESS | 22159 | 08:51:34 INFO - PROCESS | 22159 | Cycle 1(1): loaded http://localhost:52134/tests/dromaeo/cssquery-ext.html (next: http://localhost:52134/tests/dromaeo/cssquery-jquery.html) 08:51:35 INFO - PROCESS | 22159 | RSS: Main: 168505344 08:51:35 INFO - PROCESS | 22159 | 08:54:37 INFO - PROCESS | 22159 | Cycle 1(1): loaded http://localhost:52134/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52134/tests/dromaeo/cssquery-mootools.html) 08:54:37 INFO - PROCESS | 22159 | RSS: Main: 171446272 08:54:37 INFO - PROCESS | 22159 | 08:57:39 INFO - PROCESS | 22159 | Cycle 1(1): loaded http://localhost:52134/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52134/tests/dromaeo/cssquery-prototype.html) 08:57:40 INFO - PROCESS | 22159 | RSS: Main: 167088128 08:57:40 INFO - PROCESS | 22159 | 09:00:43 INFO - PROCESS | 22159 | Cycle 1(1): loaded http://localhost:52134/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52134/tests/dromaeo/cssquery-yui.html) 09:00:43 INFO - PROCESS | 22159 | RSS: Main: 169189376 09:00:43 INFO - PROCESS | 22159 | 09:03:46 INFO - PROCESS | 22159 | Cycle 1(1): loaded http://localhost:52134/tests/dromaeo/cssquery-yui.html (next: http://localhost:52134/tests/dromaeo/cssquery-dojo.html) 09:03:46 INFO - PROCESS | 22159 | RSS: Main: 169738240 09:03:46 INFO - PROCESS | 22159 | 09:03:46 INFO - PROCESS | 22159 | __start_tp_report 09:03:46 INFO - PROCESS | 22159 | _x_x_mozilla_page_load 09:03:46 INFO - PROCESS | 22159 | _x_x_mozilla_page_load_details 09:03:46 INFO - PROCESS | 22159 | |i|pagename|runs| 09:03:46 INFO - PROCESS | 22159 | |0;dojo.html;2596.182202606179;2603.908863189788;2606.270244331587;2628.684557853058;2636.644053052837;4665.790039448225;4682.461516925555;4694.788734506947;4762.285657151429;4786.641001924852;4633.281841314593;4654.534546545352;4658.953410465894;4677.74272415017;4680.6021488173465;4240.342746874239;4310.353446982962;4349.151915376503;4379.912401751963;4389.6049355558;112.6424818277963;4254.574542545752;4315.417418648473;4320.049589090411;4345.652347812167;4271.829126834923;4344.869653910388;4351.042770590465;4352.151330490556;4399.78001099947;4352.042550638855;4362.040351122748;4368.060866913629;4368.956310436918;4372.781360931941;4259.084296876186;4297.871063868089;4320.20076285885;4330.155619654169;4338.956610433918;4691.15559199344;4700.4359476862655;4705.670603057787;4728.621710263205;4731.597814185764;4940.456549779521;4968.850934471971;5009.148444764399;5018.673786203922;5042.445331013622;5016.2224855147515;5031.270465782478;5031.345925029759;5036.496350364934;5044.218146187347;4709.293605959099;4723.834665786681;4732.73969931657;4773.7374444405195;4829.9999999999645;5098.1842905135;5174.172132458789;5201.531862132426;5210.213570025639;5260.0531904257605;4966.776495057731;4987.401511818605;4989.101961646938;4996.6502344836235;5018.322526458881;5038;5069.44236134025;5080.74596270185;5085.949140508547;5087.796488140507;4951.5048495150195;4991.500849915052;4992.301077849104;5007.349044624176;5009.799608015712;4971.45314015458;4994.300797888299;4995.900081998339;4998.450170481244;5016.648834581544;4205;4293.720908140961;4317.395564620955;4354.586314300136;4386.320120381346;3682.8895133146048;3766.7928263945746;3787.450819631138;3805.4101614249835;3820.446035324918;4323.848665296762;4337.566243375701;4338.327559228324;4371.912561748811;4437.933430998538;4940.481249468754;5096.61775366849;5098.260752190911;5111.744412779346;5121.795128194905;4324.697271191049;4370.147821174904;4375.606195442426;4381.9123617527475;4389.868303950887;4597.655175861757;4605.286180641939;4611.100835337144;4613.0543238636;4643.837465688753;4623.976880115578;4635.629149668086;4697.224957881979;4726.527347265246;4738.3129446230105;4986.950130498793;5005.849824505271;5024.6231532634465;5083.847484575469;5091.439941606494;4660.8135674574;4664.39362882823;4692.131955588227;4701.717896926195;4708.952910470852;4778;4827.986122914227;4842.080004799077;4855.708657480563;4904.117258893433;5024.522670346311;5047.343845300087;5058.064258112261;5066.986602679405;5116.718580478109;4870.196417591058;4879.146149423766;4893.926591101207;4894.437139728977;4931.778069986931;4693.624510039257;4873.342098816756;4892.559669629751;4894.216925291937;4913.459519452929;4760.9047819042735;4779.832705855279;4814.15752243349;4859.854204373874;4861.392325959255;4905.583025442735;4908.214685650279;4915.18899381598;4944.134776414185;4964.503549645006;4622.537746225351;4710.293455981493;4724.740139292372;4805.5915247204375;4861.854144375674 09:03:46 INFO - PROCESS | 22159 | |1;ext.html;548.5721137512742;553.9252200952872;571.6484362117296;573.3349314794839;574.2047264538613;36093.27813443733;40051.79974100129;40165.7991710041;40205.798971005104;40231.39652905209;39825.60174398255;40121;40150.59849401505;40158.79920600393;40314.395284070764;7827;7905.565193914361;7915.287624113828;7959.044914610255;7962.880556791652;7660.463767536246;7693.384529237647;7698.345640620554;7738.729144479944;7762.45662803604;7948.642311095986;7960.4825686330205;8000.439969202158;8018.198180181965;8023.518588884656;7958.721444749435;7983.081945576275;8005.4796438231915;8005.839883202361;8013.839723205561;7933.444658873881;7945.960270198612;7977.840443191104;8005.759827205193;8010.319122874563;38263;38613.61386386157;38746.41880371797;38772.41841372382;38782.80608596967;2415.613501839715;2721.2788611018095;2750.1612008337447;2860.099068793344;2887.5235586128265;26398.73601263982;27432.588511172347;28500.287492812637;28739.56890646642;29189.27026824325;3244.0916543367894;3248.3990461764647;3293.5883014623173;3338.232206592473;3361.344537815127;237157;237317;238124;238276.99999999825;238979;32194.67805321917;32280.35439291201;32631.18422039468;33185.170370740925;33384.16539586481;31462.842685786425;31465.685343146277;31522;31536.211594710316;31604.841975789976;12014.15900886947;12116.636500904988;12126.818097728541;12130.090243231616;12151.635450936486;9448.811023779486;9490.90509094914;9497.097775711296;9502.097300756417;9589.184919281799;7960.681572737026;7978.6808527659405;8081.83836323282;8091.39314551411;8129.674813007532;3092.304231547884;3096.5819614352226;3097.4734295169874;3136.34136831268;3166.825824579624;881.8633111867671;915.4187091197138;933.6452148183782;943.7404713703786;947.393668052447;28555.714442855722;29007.85496072506;30615.540766888513;31017.224569385948;32298.35403291921;935.8461983116939;945.5414124149781;965.0928127560211;1063.0113993985667;1067.3489171605315;14791.852081479048;15304.770428443582;15309.259027864551;15462.458813941457;15511.767323490156;400341;407986;409022;410079;410141;48306.758466207444;48383.5161648379;48546.514534854905;48587.51412485901;48702.51297487051;1155.7804017236867;1191.1661836714334;1211.7758214730127;1224.675461002835;1229.7048708309942;26963.460730785668;28260.293492662848;28270.71729282681;28837.711622883504;30591.694083059774;46718;47470.76264618655;47921.041579168916;47976.52023479721;48115;380308;380711;381575;382001;382063.8071286854;37599.43600846044;38196.236075278895;39396;39407;39511;39742.801285994545;40846.795766022165;46595;48433.27350089681;48798.51201488082;37522.437163442024;37968.24063518659;38200.426993595676;38413.4237986436;38511.22977540489;37628.623713762514;37679;38319.42520862134;38661.260243288554;39015.60984390233;33159.50260746139;33923.15192120118;33937.15157121092;34124.488132677536;34470.82764586161;30663.700222482956;30972;31007;31292.217694557818;31294.374112517165;24227;24463.502153987596;24545.877270614248;24557.63163552584;24835.751642483345 09:03:46 INFO - PROCESS | 22159 | |2;jquery.html;366.3387585408338;368.48964184604324;371.25748502994014;379.5653976197253;385.70300868331384;16313.592160195985;17428;18028.18873150708;18146.364877229298;18162.091895405243;16159.676806463893;16289.918550407261;16999.405020824273;17024.574385640364;17657.55856103598;4695.1548721230165;4872.537108974641;4902.754862256873;4907.631927605426;4909.607231421495;3045.5279431688014;4817.90364192716;5383.919241211385;5663.235463212455;5678.233438485813;5704.572157088214;5728.484436400723;5740.397258287882;5747.913781293284;5757.424257574251;5568.3596386415675;5594.049011668006;5682.488576028157;5701.173329867167;5774.105013722879;5497.147942068986;5501.284832971688;5539.113741801292;5553.861153471155;5574.554035677136;20401.795982040137;20603.48491287715;21057.578848422945;21151.47121321964;21537.56924861494;1607.5097095385902;1658.6102265967488;1695.3727120965198;1709.350446830209;2067.214458505758;9360.953195234048;9478.763030924212;9972.451515166664;11032.669019929335;13582.320883955861;1749.5363728611928;1800.7659004329485;1827.3604238516546;1869.8597605179666;1922.7404300419405;69059.65470172667;69479;69663.30336696669;70947;71282;10010.249231307682;10222.335548189343;10267.127294179929;10360.430176340224;10410.531526081344;13935.512257070954;13964.371603277878;13964.511242106477;14075.2962351882;14090.36593353281;6918.619475928772;6954.200266969262;6975.755848545378;7139.535930164523;7148.285171482914;6291.748330066746;6304.779332723424;6361.300256971729;6409;6421.743130274736;4334.5882141196535;4372.540883207281;4405;4436;4447.977760111179;1667.2747354900657;1732.1685590916431;1780.8772691219785;1820.981790182081;1914.2343062775;747.2975403121048;876.9079246679134;890.6392910871108;898.2006014646969;910.3218102513538;16573.08848013371;16835.915820420818;16868.746968795233;16946.322147114224;17283.222254998556;849.7705619482705;857.648364170687;865.3942240431597;870.5473153959905;899.3030401438937;9199.63201471947;9567.61729530811;9646;9720.659776907774;9827.656032038843;350244;354171;355165;357790;357853;70582.64708676527;72321;73134.63432682803;73448.26551734521;73464.63267683628;874.9868751968726;877.0308808766349;880.6389380354024;909.60432211988;927.3508544019079;14775.778363324343;15165.24173791328;15219.391224350902;15362.155081470179;15696.529104126894;25962;26831.865840671453;35412.114697132776;37225.627743722216;37399.43900841435;48505.27242091301;48797;50315.496845031084;50574;51254.74372628262;7156.642167891689;7223.349898509159;7316.597587132759;7413.740519081806;7421.554706717614;9428.15146636806;10618.469076545987;10888.346699198073;10975.560977560808;11140.944295278796;9440.716778496657;9569.473678947725;9644.469554174588;9736.610535578497;9901.653442129491;8852.734417967471;9531.857022144535;9709.174720148867;9968.50157492137;10093.444860532742;10026.799464010825;10109.949450252701;10312.381257124596;10637.680869573616;10679.733006674895;7481.364084052916;7527.2849079337375;7584;7602.96198519026;7607.885881711668;7467.813304667427;9347.439153650803;9931.503424828585;10052.246081544059;10281.588736450458 09:03:46 INFO - PROCESS | 22159 | |3;mootools.html;1332.860049694782;1341.2489006156547;1363.0050063453677;1401.677614148745;1406.972909775863;6464.256610489795;7211.387032102271;7225.421966242701;7612.124605670357;7749.573773442466;7486;7738.535687858733;7742.458027938046;7753.496022758517;7776.805579860506;2181.999999999996;2210.071769856656;2216.1467834883524;2225.087714037245;2229.721284839395;2107.0509778454866;2123.596516661837;2213.4023813570325;2214.081156320125;2214.6235140026233;2159.211887661008;2169.1865550418593;2169.3383518026994;2175.2712841198218;2183.2140429445385;2186.1474025130133;2186.835987300959;2187.507810742586;2187.671849222613;2199.692043113965;2017;2107.5363420047565;2113.830893528514;2122.4481634774916;2130.9147634094616;7612.543247405173;7617.238276172394;7646.541207527566;7647.579383133925;7693.807654808675;4547.136044151601;4594.0122873582;4617.053504031665;4660.067986402699;4668.323093151508;2749.408877091435;2797.5244208484605;2810.7610853077513;2813.8733756980782;2840.744333010018;896.9596368163449;931.2782593490032;933.6358820060182;946.5314669238771;946.9005754395827;10070.395776253448;10072.740907386577;10086.243531735076;10099.848502272473;10131.746706332327;3974.0859602291634;4160.646345060703;4176.352665336878;4220.07158425146;4263.232618128766;8816.823663526693;8854.911450885538;8858.247049000778;8873.334499912533;8891.555422228863;4665.066986602693;4668.019715859639;4668.5564871337165;4674.6026587740425;4692.741899195509;3647;4064.146529228895;4252.744835309892;4294.7852607369505;4298.63461605767;3623.5289412376223;3667.963320366762;3710.777353358807;3766.5291838520184;3915.236528876899;1187.9109066820024;1212.6362091372553;1217.15407791584;1224.406163010939;1229.391451231646;775.2441369664645;777.6811507281988;778.3967425245366;782.3858271257036;811.1604489353608;5097.898042039138;5103.795848166032;5132.615053870974;5226.869328266824;5261.500157485033;385.677958904318;394.8835093647381;400.89576710055013;401.9095703466755;414.5398607545622;3542.4863394807608;3558.733095017884;3618.2944325856733;3648.5256916600674;3669.4128939370107;9143.222826059726;9529.714108576754;9639.614415423444;9655.179309758749;9687.17658998979;9361.391509551993;9370.437773733598;9381.718548443421;9434.433933963985;9516.571754270935;7017.157941047107;7109.502334836512;7133.750318738819;7140.750073747394;7181.281871812777;4987.551120399182;5023.372078490189;5138.100832354248;5230.555402790653;5304.60215483848;8807;8896.199342058986;8899.555022248991;8907.955460222658;8973.596188171417;8703.47779133254;8979.371443998858;9017.278617710435;9053.592588333673;9067;5898.528117750484;6405.583637063576;6623.701933412912;6774.762883299061;6812.62530560804;7404.481686281909;7413.258674132544;7423.888641670487;7478.2895624915545;7486.588237646982;6365.3316401779;6588.8023359299295;6615.569987950767;6630.933690663224;6692.364225398579;6246.531510136849;6303.9684801575695;6347.873042539216;6427.3251308611925;6448.742050317935;6118.724657390517;6228.844278892882;6242.564210231763;6262.655553944577;6263.530235232284;4437.933430998473;4604.792784324646;4630.560096790799;4671.509491503479;4699.788509517149;4542.772861356985;4573.062522182878;4581.175388430114;4626.236670949255;4629.606483448944 09:03:46 INFO - PROCESS | 22159 | |4;prototype.html;290.67299288300677;300.2239211637916;304.7531499485417;309.9364630250799;309.94885843835766;4871;4937.444704917948;4983.850484485462;5047.974760126203;5053.519915608016;4974.228994505857;4974.900501989958;5019.59843212543;5022.497750224985;5033.062271025654;3987.501562304712;4005.118873847749;4010.4585880905997;4015.9196816063663;4025.476688030552;3947.467091942594;3949.7630142191415;4000.239954408653;4031.737937034098;4039.7778122203267;3939.9606003940025;3952.565217826037;3954;3959.742616729903;3965.4250133730593;3950.7036972227056;3957.5448823385245;3972.1261322509004;3991.341428664267;4006.1587066715733;3533.3993221152464;3544.6987006104514;3548.183917698918;3555.715542756573;3561.0919215599856;4889.486603906575;4892.559669629715;4910.386201724785;4926.408830940274;4991.800327986876;4526.841560545365;4538.273876179828;4551.3173024046655;4556.430446194226;4582.312653102028;5304.949653948995;5315.44187860273;5331.413544510101;5344.679319240858;5348.625596208267;3719.696440858806;3801.7148713846573;3832.156925476391;3876.6511014008875;3884.028992751812;5471.972640136813;5486.231927530149;5488.7530061147345;5496.203050557647;5568.52667523257;3947.802609869495;3952.466417033721;3959.4852669152824;3973.920521589552;3981.124152686404;3666.9083272917856;4026.9395959060053;4027.6979226558124;4033.556308806029;4035.9596404035583;4391.187630288407;4397.2085024695225;4410.448693913261;4416.984093658477;4470.173017991682;5222.9216561750845;5300.469953004668;5302.814401495929;5331.920550985119;5338.8665283367445;1261.88953720727;1346.6767975685764;1380.9906585917465;1382.4539306973688;1389.715108402775;952.1097773581723;952.6332362040664;967.2020583019038;980.6026412362355;986.6941248213077;4045.37296719009;4077.1845630873945;4089.4683691119963;4115.609017143426;4136.627703506699;4748.501407352247;4768.880777980509;4794.760261986957;4804.975975120102;4823.638227132979;4160.583941605815;4168.249715051259;4170.540310891164;4177.644900183458;4185.644220241253;2522.243327001892;2549.3244290263096;2551.668283123182;2556.5014822109883;2572.215474280325;4455.710378825366;4494.393256910341;4501.254234916698;4505.481869584974;4514.232580461329;4822.397200349957;4841.337264504508;4842.491538388418;4870.587529616371;4909.410870695539;4502.797374118172;4640.373549570832;5073.21365188389;5075.974620126875;5079.87300317495;5440.428754980829;5452.127659574449;5497.615166938276;5550.27846379968;5564.638298510584;5234.633575649668;5375.16684913839;5410.756515956713;5435.945640543544;5467.316585426822;5068.518490743373;5075.700794483468;5085.135526960499;5092.287079808903;5099.6175286852895;3726.3045314381347;3790.8673196437994;3799.6010418905616;3821.2166505866785;3825.808709564455;4891.413030436371;5478.753456094406;5506.201600767786;5510.448955104457;5512.145617429305;5208.453112423141;5218.739063046908;5247.291615631993;5260.947390526046;5294.761735721825;5195.896082078413;5258.132408152765;5287.788488460418;5304.294809647031;5330.920036199538;4886.364772579542;5160.535551800356;5166.689998600096;5197.518707168439;5209.062368773657;5237.450067742832;5253.001929633358;5255.871372094308;5265.394479634738;5296.788128474972;5101.744912754421;5158.587313014875;5168.612354073534;5178.145605974972;5201.401838788588 09:03:46 INFO - PROCESS | 22159 | |5;yui.html;606.1059936593525;634.3181080338636;691.3708525242031;718.4826924614279;728.5410191579305;11807.586734464296;11962.700932476682;12268.447919843606;12381.319027453497;12416.627501174968;12725.490980360797;13027.478900843955;13033.674158146028;13064.085514014023;13070.215787052783;617.3517806303386;763.9541627502367;774.0633833061987;795.0340336491162;801.3068695578341;791.2325044706625;791.651673263765;793.9761807145795;797.6450479536609;798.2177466083242;834.6953362022879;834.8330333933208;837.5184269045293;838.8238469921324;841.032812265893;813.2111851504031;816.2042009041197;822.0956947357888;823.2919689067397;827.3505298340834;605.8061420345491;606.1544145916466;606.4481321997006;607.7295603456464;609.0194786393902;13165;13308.600741977756;13315.201087934658;13335.666608334772;13429.462821487226;13685.521006764715;13733.939749803378;13851.51519696816;14057.929710351485;14301.92849035748;9492.525373731354;9552.61789528418;9652.324337296392;9663.13031827139;9769.755756106084;3232.6444091149956;3237.6114866216203;3291.374638818617;3301.6698330167033;3354.3794398036443;53275.73362133203;55457;55486;68552.6572367135;68943;9840.458774767456;10256.487175641189;10445.11216546587;10641.893581064245;10695.572177112828;18843;19239.90380048119;19244.326448574513;19259.807401926082;19261.325853595055;6541.901871471931;6568.312131108561;6645.06969024337;6801.795946121624;6865.141857267841;3486.38988177068;3495.667911548399;3557.8932632021083;3594.2452085061905;3599.38810402227;2843.4170994945985;2891;2917.3144311086876;2938.133250691051;2942.440936222111;513.7508308470389;542.5659472422126;543.6384804105226;547.731611510365;548.6872482684911;508.7863097499059;559.2645670942698;562.7833284185618;597.9431953964366;618.7957973868613;8109.797255068671;8169.877451838108;8340.499570025819;8368.707095251759;8381.161883811692;556.0824639345113;589.0208898102372;601.3955974245943;602.457787990803;615.6767696959042;3623.9456408153897;3935.311320518955;3988.760674359548;4037.0916543777416;4044.838206471767;59852;60453.0932036011;75516;111554;111741;94413.52793236128;95974;97739.51130244303;98153;98213.50893245632;86151.56924215339;86406.56796715976;86488.56755716307;87404.12595874087;87749.56125219334;7526.564787106945;7552.28253315956;7622.8094297643;7679.692812287446;7760.88358674609;48497.75751121222;48563.75718121387;48701.26948095852;50135.49864501308;50441.495585045144;72165;73456.63271683607;74256.25743742494;76577.61711191408;77096;9606.51967401641;9696.127348538665;9728.9027109728;9849.162821160282;10058.29591928558;11492.195546311677;11502.194846360675;11576.768464630828;12234.082443816571;12328.876711232773;10950.452477376259;10977;11109.833352499558;11190.944045280046;11298.60454884075;11036.668899933014;11198.832017519906;11231.71920701989;11336.206465547333;11899.702507437383;9582.281328900499;9591.520423978913;9625.133737963617;10743.570257189625;10873.782524349626;8699.391042626956;8799.648014079621;8824.426412283181;8864.645414183618;9198.724038278862;9321;9330.766730831512;9355.158035776813;9366.625334986524;9420.057994200524 09:03:46 INFO - PROCESS | 22159 | __end_tp_report 09:03:46 INFO - PROCESS | 22159 | __start_cc_report 09:03:46 INFO - PROCESS | 22159 | _x_x_mozilla_cycle_collect,360 09:03:46 INFO - PROCESS | 22159 | __end_cc_report 09:03:46 INFO - PROCESS | 22159 | __startTimestamp1468253026473__endTimestamp 09:03:46 INFO - PROCESS | 22159 | 09:03:46 INFO - PROCESS | 22159 | ------- Summary: start ------- 09:03:46 INFO - PROCESS | 22159 | Number of tests: 6 09:03:46 INFO - PROCESS | 22159 | 09:03:46 INFO - PROCESS | 22159 | [#0] dojo.html Cycles:165 Average:4624.16 Median:4731.60 stddev:596.85 (12.6%) stddev-sans-first:577.09 09:03:46 INFO - PROCESS | 22159 | Values: 2596.2 2603.9 2606.3 2628.7 2636.6 4665.8 4682.5 4694.8 4762.3 4786.6 4633.3 4654.5 4659.0 4677.7 4680.6 4240.3 4310.4 4349.2 4379.9 4389.6 112.6 4254.6 4315.4 4320.0 4345.7 4271.8 4344.9 4351.0 4352.2 4399.8 4352.0 4362.0 4368.1 4369.0 4372.8 4259.1 4297.9 4320.2 4330.2 4339.0 4691.2 4700.4 4705.7 4728.6 4731.6 4940.5 4968.9 5009.1 5018.7 5042.4 5016.2 5031.3 5031.3 5036.5 5044.2 4709.3 4723.8 4732.7 4773.7 4830.0 5098.2 5174.2 5201.5 5210.2 5260.1 4966.8 4987.4 4989.1 4996.7 5018.3 5038.0 5069.4 5080.7 5085.9 5087.8 4951.5 4991.5 4992.3 5007.3 5009.8 4971.5 4994.3 4995.9 4998.5 5016.6 4205.0 4293.7 4317.4 4354.6 4386.3 3682.9 3766.8 3787.5 3805.4 3820.4 4323.8 4337.6 4338.3 4371.9 4437.9 4940.5 5096.6 5098.3 5111.7 5121.8 4324.7 4370.1 4375.6 4381.9 4389.9 4597.7 4605.3 4611.1 4613.1 4643.8 4624.0 4635.6 4697.2 4726.5 4738.3 4987.0 5005.8 5024.6 5083.8 5091.4 4660.8 4664.4 4692.1 4701.7 4709.0 4778.0 4828.0 4842.1 4855.7 4904.1 5024.5 5047.3 5058.1 5067.0 5116.7 4870.2 4879.1 4893.9 4894.4 4931.8 4693.6 4873.3 4892.6 4894.2 4913.5 4760.9 4779.8 4814.2 4859.9 4861.4 4905.6 4908.2 4915.2 4944.1 4964.5 4622.5 4710.3 4724.7 4805.6 4861.9 09:03:46 INFO - PROCESS | 22159 | 09:03:46 INFO - PROCESS | 22159 | [#1] ext.html Cycles:180 Average:48310.67 Median:38291.21 stddev:92757.76 (242.2%) stddev-sans-first:92948.65 09:03:46 INFO - PROCESS | 22159 | Values: 548.6 553.9 571.6 573.3 574.2 36093.3 40051.8 40165.8 40205.8 40231.4 39825.6 40121.0 40150.6 40158.8 40314.4 7827.0 7905.6 7915.3 7959.0 7962.9 7660.5 7693.4 7698.3 7738.7 7762.5 7948.6 7960.5 8000.4 8018.2 8023.5 7958.7 7983.1 8005.5 8005.8 8013.8 7933.4 7946.0 7977.8 8005.8 8010.3 38263.0 38613.6 38746.4 38772.4 38782.8 2415.6 2721.3 2750.2 2860.1 2887.5 26398.7 27432.6 28500.3 28739.6 29189.3 3244.1 3248.4 3293.6 3338.2 3361.3 237157.0 237317.0 238124.0 238277.0 238979.0 32194.7 32280.4 32631.2 33185.2 33384.2 31462.8 31465.7 31522.0 31536.2 31604.8 12014.2 12116.6 12126.8 12130.1 12151.6 9448.8 9490.9 9497.1 9502.1 9589.2 7960.7 7978.7 8081.8 8091.4 8129.7 3092.3 3096.6 3097.5 3136.3 3166.8 881.9 915.4 933.6 943.7 947.4 28555.7 29007.9 30615.5 31017.2 32298.4 935.8 945.5 965.1 1063.0 1067.3 14791.9 15304.8 15309.3 15462.5 15511.8 400341.0 407986.0 409022.0 410079.0 410141.0 48306.8 48383.5 48546.5 48587.5 48702.5 1155.8 1191.2 1211.8 1224.7 1229.7 26963.5 28260.3 28270.7 28837.7 30591.7 46718.0 47470.8 47921.0 47976.5 48115.0 380308.0 380711.0 381575.0 382001.0 382063.8 37599.4 38196.2 39396.0 39407.0 39511.0 39742.8 40846.8 46595.0 48433.3 48798.5 37522.4 37968.2 38200.4 38413.4 38511.2 37628.6 37679.0 38319.4 38661.3 39015.6 33159.5 33923.2 33937.2 34124.5 34470.8 30663.7 30972.0 31007.0 31292.2 31294.4 24227.0 24463.5 24545.9 24557.6 24835.8 09:03:46 INFO - PROCESS | 22159 | 09:03:46 INFO - PROCESS | 22159 | [#2] jquery.html Cycles:180 Average:23045.75 Median:4905.19 stddev:58767.24 (1198.1%) stddev-sans-first:58907.42 09:03:46 INFO - PROCESS | 22159 | Values: 366.3 368.5 371.3 379.6 385.7 16313.6 17428.0 18028.2 18146.4 18162.1 16159.7 16289.9 16999.4 17024.6 17657.6 4695.2 4872.5 4902.8 4907.6 4909.6 3045.5 4817.9 5383.9 5663.2 5678.2 5704.6 5728.5 5740.4 5747.9 5757.4 5568.4 5594.0 5682.5 5701.2 5774.1 5497.1 5501.3 5539.1 5553.9 5574.6 20401.8 20603.5 21057.6 21151.5 21537.6 1607.5 1658.6 1695.4 1709.4 2067.2 9361.0 9478.8 9972.5 11032.7 13582.3 1749.5 1800.8 1827.4 1869.9 1922.7 69059.7 69479.0 69663.3 70947.0 71282.0 10010.2 10222.3 10267.1 10360.4 10410.5 13935.5 13964.4 13964.5 14075.3 14090.4 6918.6 6954.2 6975.8 7139.5 7148.3 6291.7 6304.8 6361.3 6409.0 6421.7 4334.6 4372.5 4405.0 4436.0 4448.0 1667.3 1732.2 1780.9 1821.0 1914.2 747.3 876.9 890.6 898.2 910.3 16573.1 16835.9 16868.7 16946.3 17283.2 849.8 857.6 865.4 870.5 899.3 9199.6 9567.6 9646.0 9720.7 9827.7 350244.0 354171.0 355165.0 357790.0 357853.0 70582.6 72321.0 73134.6 73448.3 73464.6 875.0 877.0 880.6 909.6 927.4 14775.8 15165.2 15219.4 15362.2 15696.5 25962.0 26831.9 35412.1 37225.6 37399.4 48505.3 48797.0 50315.5 50574.0 51254.7 7156.6 7223.3 7316.6 7413.7 7421.6 9428.2 10618.5 10888.3 10975.6 11140.9 9440.7 9569.5 9644.5 9736.6 9901.7 8852.7 9531.9 9709.2 9968.5 10093.4 10026.8 10109.9 10312.4 10637.7 10679.7 7481.4 7527.3 7584.0 7603.0 7607.9 7467.8 9347.4 9931.5 10052.2 10281.6 09:03:46 INFO - PROCESS | 22159 | 09:03:46 INFO - PROCESS | 22159 | [#3] mootools.html Cycles:180 Average:5036.77 Median:5005.46 stddev:2814.76 (56.2%) stddev-sans-first:2808.90 09:03:46 INFO - PROCESS | 22159 | Values: 1332.9 1341.2 1363.0 1401.7 1407.0 6464.3 7211.4 7225.4 7612.1 7749.6 7486.0 7738.5 7742.5 7753.5 7776.8 2182.0 2210.1 2216.1 2225.1 2229.7 2107.1 2123.6 2213.4 2214.1 2214.6 2159.2 2169.2 2169.3 2175.3 2183.2 2186.1 2186.8 2187.5 2187.7 2199.7 2017.0 2107.5 2113.8 2122.4 2130.9 7612.5 7617.2 7646.5 7647.6 7693.8 4547.1 4594.0 4617.1 4660.1 4668.3 2749.4 2797.5 2810.8 2813.9 2840.7 897.0 931.3 933.6 946.5 946.9 10070.4 10072.7 10086.2 10099.8 10131.7 3974.1 4160.6 4176.4 4220.1 4263.2 8816.8 8854.9 8858.2 8873.3 8891.6 4665.1 4668.0 4668.6 4674.6 4692.7 3647.0 4064.1 4252.7 4294.8 4298.6 3623.5 3668.0 3710.8 3766.5 3915.2 1187.9 1212.6 1217.2 1224.4 1229.4 775.2 777.7 778.4 782.4 811.2 5097.9 5103.8 5132.6 5226.9 5261.5 385.7 394.9 400.9 401.9 414.5 3542.5 3558.7 3618.3 3648.5 3669.4 9143.2 9529.7 9639.6 9655.2 9687.2 9361.4 9370.4 9381.7 9434.4 9516.6 7017.2 7109.5 7133.8 7140.8 7181.3 4987.6 5023.4 5138.1 5230.6 5304.6 8807.0 8896.2 8899.6 8908.0 8973.6 8703.5 8979.4 9017.3 9053.6 9067.0 5898.5 6405.6 6623.7 6774.8 6812.6 7404.5 7413.3 7423.9 7478.3 7486.6 6365.3 6588.8 6615.6 6630.9 6692.4 6246.5 6304.0 6347.9 6427.3 6448.7 6118.7 6228.8 6242.6 6262.7 6263.5 4437.9 4604.8 4630.6 4671.5 4699.8 4542.8 4573.1 4581.2 4626.2 4629.6 09:03:46 INFO - PROCESS | 22159 | 09:03:46 INFO - PROCESS | 22159 | [#4] prototype.html Cycles:180 Average:4302.63 Median:4813.69 stddev:1241.74 (25.8%) stddev-sans-first:1208.16 09:03:46 INFO - PROCESS | 22159 | Values: 290.7 300.2 304.8 309.9 309.9 4871.0 4937.4 4983.9 5048.0 5053.5 4974.2 4974.9 5019.6 5022.5 5033.1 3987.5 4005.1 4010.5 4015.9 4025.5 3947.5 3949.8 4000.2 4031.7 4039.8 3940.0 3952.6 3954.0 3959.7 3965.4 3950.7 3957.5 3972.1 3991.3 4006.2 3533.4 3544.7 3548.2 3555.7 3561.1 4889.5 4892.6 4910.4 4926.4 4991.8 4526.8 4538.3 4551.3 4556.4 4582.3 5304.9 5315.4 5331.4 5344.7 5348.6 3719.7 3801.7 3832.2 3876.7 3884.0 5472.0 5486.2 5488.8 5496.2 5568.5 3947.8 3952.5 3959.5 3973.9 3981.1 3666.9 4026.9 4027.7 4033.6 4036.0 4391.2 4397.2 4410.4 4417.0 4470.2 5222.9 5300.5 5302.8 5331.9 5338.9 1261.9 1346.7 1381.0 1382.5 1389.7 952.1 952.6 967.2 980.6 986.7 4045.4 4077.2 4089.5 4115.6 4136.6 4748.5 4768.9 4794.8 4805.0 4823.6 4160.6 4168.2 4170.5 4177.6 4185.6 2522.2 2549.3 2551.7 2556.5 2572.2 4455.7 4494.4 4501.3 4505.5 4514.2 4822.4 4841.3 4842.5 4870.6 4909.4 4502.8 4640.4 5073.2 5076.0 5079.9 5440.4 5452.1 5497.6 5550.3 5564.6 5234.6 5375.2 5410.8 5435.9 5467.3 5068.5 5075.7 5085.1 5092.3 5099.6 3726.3 3790.9 3799.6 3821.2 3825.8 4891.4 5478.8 5506.2 5510.4 5512.1 5208.5 5218.7 5247.3 5260.9 5294.8 5195.9 5258.1 5287.8 5304.3 5330.9 4886.4 5160.5 5166.7 5197.5 5209.1 5237.5 5253.0 5255.9 5265.4 5296.8 5101.7 5158.6 5168.6 5178.1 5201.4 09:03:46 INFO - PROCESS | 22159 | 09:03:46 INFO - PROCESS | 22159 | [#5] yui.html Cycles:180 Average:18285.00 Median:30527.78 stddev:27159.85 (89.0%) stddev-sans-first:27203.60 09:03:46 INFO - PROCESS | 22159 | Values: 606.1 634.3 691.4 718.5 728.5 11807.6 11962.7 12268.4 12381.3 12416.6 12725.5 13027.5 13033.7 13064.1 13070.2 617.4 764.0 774.1 795.0 801.3 791.2 791.7 794.0 797.6 798.2 834.7 834.8 837.5 838.8 841.0 813.2 816.2 822.1 823.3 827.4 605.8 606.2 606.4 607.7 609.0 13165.0 13308.6 13315.2 13335.7 13429.5 13685.5 13733.9 13851.5 14057.9 14301.9 9492.5 9552.6 9652.3 9663.1 9769.8 3232.6 3237.6 3291.4 3301.7 3354.4 53275.7 55457.0 55486.0 68552.7 68943.0 9840.5 10256.5 10445.1 10641.9 10695.6 18843.0 19239.9 19244.3 19259.8 19261.3 6541.9 6568.3 6645.1 6801.8 6865.1 3486.4 3495.7 3557.9 3594.2 3599.4 2843.4 2891.0 2917.3 2938.1 2942.4 513.8 542.6 543.6 547.7 548.7 508.8 559.3 562.8 597.9 618.8 8109.8 8169.9 8340.5 8368.7 8381.2 556.1 589.0 601.4 602.5 615.7 3623.9 3935.3 3988.8 4037.1 4044.8 59852.0 60453.1 75516.0 111554.0 111741.0 94413.5 95974.0 97739.5 98153.0 98213.5 86151.6 86406.6 86488.6 87404.1 87749.6 7526.6 7552.3 7622.8 7679.7 7760.9 48497.8 48563.8 48701.3 50135.5 50441.5 72165.0 73456.6 74256.3 76577.6 77096.0 9606.5 9696.1 9728.9 9849.2 10058.3 11492.2 11502.2 11576.8 12234.1 12328.9 10950.5 10977.0 11109.8 11190.9 11298.6 11036.7 11198.8 11231.7 11336.2 11899.7 9582.3 9591.5 9625.1 10743.6 10873.8 8699.4 8799.6 8824.4 8864.6 9198.7 9321.0 9330.8 9355.2 9366.6 9420.1 09:03:46 INFO - PROCESS | 22159 | -------- Summary: end -------- 09:03:46 INFO - PROCESS | 22159 | 09:03:47 INFO - TEST-INFO | 22159: exit 0 09:03:47 INFO - TEST-OK | dromaeo_css | took 1116642ms 09:03:47 INFO - TEST-START | kraken 09:03:47 INFO - operating with platform_type : linux_ 09:03:47 INFO - Initialising browser for kraken test... 09:03:47 INFO - TEST-INFO | started process 22403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeRfLVz/profile http://localhost:52134/getInfo.html) 09:03:52 INFO - PROCESS | 22403 | __metrics Screen width/height:1600/1200 09:03:52 INFO - PROCESS | 22403 | colorDepth:24 09:03:52 INFO - PROCESS | 22403 | Browser inner width/height: 1024/697 09:03:52 INFO - PROCESS | 22403 | __metrics 09:03:53 ERROR - PROCESS | 22403 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 09:03:53 INFO - TEST-INFO | 22403: exit 0 09:03:53 INFO - Browser initialized. 09:03:53 INFO - Running cycle 1/1 for kraken test... 09:03:53 INFO - TEST-INFO | started process 22525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeRfLVz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:05 INFO - PROCESS | 22525 | RSS: Main: 168837120 09:04:05 INFO - PROCESS | 22525 | 09:04:08 INFO - PROCESS | 22525 | Cycle 1(1): loaded http://localhost:52134/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52134/tests/kraken/driver.html?testName=audio-beat-detection) 09:04:09 INFO - PROCESS | 22525 | RSS: Main: 173105152 09:04:09 INFO - PROCESS | 22525 | 09:04:12 INFO - PROCESS | 22525 | Cycle 1(1): loaded http://localhost:52134/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52134/tests/kraken/driver.html?testName=audio-dft) 09:04:12 INFO - PROCESS | 22525 | RSS: Main: 172883968 09:04:12 INFO - PROCESS | 22525 | 09:04:15 INFO - PROCESS | 22525 | Cycle 1(1): loaded http://localhost:52134/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52134/tests/kraken/driver.html?testName=audio-fft) 09:04:16 INFO - PROCESS | 22525 | RSS: Main: 168292352 09:04:16 INFO - PROCESS | 22525 | 09:04:18 INFO - PROCESS | 22525 | Cycle 1(1): loaded http://localhost:52134/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52134/tests/kraken/driver.html?testName=audio-oscillator) 09:04:19 INFO - PROCESS | 22525 | RSS: Main: 169185280 09:04:19 INFO - PROCESS | 22525 | 09:04:21 INFO - PROCESS | 22525 | Cycle 1(1): loaded http://localhost:52134/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52134/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:04:22 INFO - PROCESS | 22525 | RSS: Main: 169881600 09:04:22 INFO - PROCESS | 22525 | 09:04:25 INFO - PROCESS | 22525 | Cycle 1(1): loaded http://localhost:52134/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52134/tests/kraken/driver.html?testName=imaging-darkroom) 09:04:25 INFO - PROCESS | 22525 | RSS: Main: 169017344 09:04:25 INFO - PROCESS | 22525 | 09:04:29 INFO - PROCESS | 22525 | Cycle 1(1): loaded http://localhost:52134/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52134/tests/kraken/driver.html?testName=imaging-desaturate) 09:04:30 INFO - PROCESS | 22525 | RSS: Main: 166174720 09:04:30 INFO - PROCESS | 22525 | 09:04:33 INFO - PROCESS | 22525 | Cycle 1(1): loaded http://localhost:52134/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52134/tests/kraken/driver.html?testName=json-parse-financial) 09:04:33 INFO - PROCESS | 22525 | RSS: Main: 167739392 09:04:33 INFO - PROCESS | 22525 | 09:04:35 INFO - PROCESS | 22525 | Cycle 1(1): loaded http://localhost:52134/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52134/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:04:35 INFO - PROCESS | 22525 | RSS: Main: 168652800 09:04:35 INFO - PROCESS | 22525 | 09:04:37 INFO - PROCESS | 22525 | Cycle 1(1): loaded http://localhost:52134/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52134/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:04:38 INFO - PROCESS | 22525 | RSS: Main: 168890368 09:04:38 INFO - PROCESS | 22525 | 09:04:40 INFO - PROCESS | 22525 | Cycle 1(1): loaded http://localhost:52134/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52134/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:04:41 INFO - PROCESS | 22525 | RSS: Main: 169537536 09:04:41 INFO - PROCESS | 22525 | 09:04:44 INFO - PROCESS | 22525 | Cycle 1(1): loaded http://localhost:52134/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52134/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:04:44 INFO - PROCESS | 22525 | RSS: Main: 169885696 09:04:44 INFO - PROCESS | 22525 | 09:04:47 INFO - PROCESS | 22525 | Cycle 1(1): loaded http://localhost:52134/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52134/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:04:48 INFO - PROCESS | 22525 | RSS: Main: 170119168 09:04:48 INFO - PROCESS | 22525 | 09:04:50 INFO - PROCESS | 22525 | Cycle 1(1): loaded http://localhost:52134/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52134/tests/kraken/driver.html?testName=ai-astar) 09:04:50 INFO - PROCESS | 22525 | RSS: Main: 170500096 09:04:50 INFO - PROCESS | 22525 | 09:04:50 INFO - PROCESS | 22525 | __start_tp_report 09:04:50 INFO - PROCESS | 22525 | _x_x_mozilla_page_load 09:04:50 INFO - PROCESS | 22525 | _x_x_mozilla_page_load_details 09:04:50 INFO - PROCESS | 22525 | |i|pagename|runs| 09:04:50 INFO - PROCESS | 22525 | |0;ai-astar;110;117;110;116;116;117;116;116;117;117 09:04:50 INFO - PROCESS | 22525 | |1;audio-beat-detection;154;129;151;172;123;155;152;126;181;129 09:04:50 INFO - PROCESS | 22525 | |2;audio-dft;163;163;165;166;169;163;162;165;164;166 09:04:50 INFO - PROCESS | 22525 | |3;audio-fft;76;76;75;152;79;76;77;76;165;79 09:04:50 INFO - PROCESS | 22525 | |4;audio-oscillator;90;86;140;87;85;86;147;84;85;135 09:04:50 INFO - PROCESS | 22525 | |5;imaging-gaussian-blur;117;117;117;117;118;118;118;119;119;118 09:04:50 INFO - PROCESS | 22525 | |6;imaging-darkroom;151;147;148;148;148;148;148;148;148;147 09:04:50 INFO - PROCESS | 22525 | |7;imaging-desaturate;95;95;95;96;96;96;97;96;95;96 09:04:50 INFO - PROCESS | 22525 | |8;json-parse-financial;68;64;64;65;64;64;64;64;63;65 09:04:50 INFO - PROCESS | 22525 | |9;json-stringify-tinderbox;66;66;65;65;66;65;66;66;65;66 09:04:50 INFO - PROCESS | 22525 | |10;stanford-crypto-aes;80;83;86;88;81;82;80;89;85;80 09:04:50 INFO - PROCESS | 22525 | |11;stanford-crypto-ccm;151;138;135;144;131;133;135;138;181;135 09:04:50 INFO - PROCESS | 22525 | |12;stanford-crypto-pbkdf2;171;169;173;166;174;170;173;170;166;169 09:04:50 INFO - PROCESS | 22525 | |13;stanford-crypto-sha256-iterative;70;72;69;73;70;68;67;70;68;68 09:04:50 INFO - PROCESS | 22525 | __end_tp_report 09:04:50 INFO - PROCESS | 22525 | __start_cc_report 09:04:50 INFO - PROCESS | 22525 | _x_x_mozilla_cycle_collect,995 09:04:50 INFO - PROCESS | 22525 | __end_cc_report 09:04:50 INFO - PROCESS | 22525 | __startTimestamp1468253090445__endTimestamp 09:04:50 INFO - PROCESS | 22525 | 09:04:50 INFO - PROCESS | 22525 | ------- Summary: start ------- 09:04:50 INFO - PROCESS | 22525 | Number of tests: 14 09:04:50 INFO - PROCESS | 22525 | 09:04:50 INFO - PROCESS | 22525 | [#0] ai-astar Cycles:10 Average:115.20 Median:116.50 stddev:2.78 (2.4%) stddev-sans-first:2.22 09:04:50 INFO - PROCESS | 22525 | Values: 110.0 117.0 110.0 116.0 116.0 117.0 116.0 116.0 117.0 117.0 09:04:50 INFO - PROCESS | 22525 | 09:04:50 INFO - PROCESS | 22525 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:153.00 stddev:20.00 (13.1%) stddev-sans-first:21.06 09:04:50 INFO - PROCESS | 22525 | Values: 154.0 129.0 151.0 172.0 123.0 155.0 152.0 126.0 181.0 129.0 09:04:50 INFO - PROCESS | 22525 | 09:04:50 INFO - PROCESS | 22525 | [#2] audio-dft Cycles:10 Average:164.60 Median:165.00 stddev:2.07 (1.3%) stddev-sans-first:2.11 09:04:50 INFO - PROCESS | 22525 | Values: 163.0 163.0 165.0 166.0 169.0 163.0 162.0 165.0 164.0 166.0 09:04:50 INFO - PROCESS | 22525 | 09:04:50 INFO - PROCESS | 22525 | [#3] audio-fft Cycles:10 Average:93.10 Median:76.00 stddev:34.63 (45.6%) stddev-sans-first:36.17 09:04:50 INFO - PROCESS | 22525 | Values: 76.0 76.0 75.0 152.0 79.0 76.0 77.0 76.0 165.0 79.0 09:04:50 INFO - PROCESS | 22525 | 09:04:50 INFO - PROCESS | 22525 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:85.50 stddev:26.54 (31.0%) stddev-sans-first:27.76 09:04:50 INFO - PROCESS | 22525 | Values: 90.0 86.0 140.0 87.0 85.0 86.0 147.0 84.0 85.0 135.0 09:04:50 INFO - PROCESS | 22525 | 09:04:50 INFO - PROCESS | 22525 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 09:04:50 INFO - PROCESS | 22525 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 118.0 119.0 119.0 118.0 09:04:50 INFO - PROCESS | 22525 | 09:04:50 INFO - PROCESS | 22525 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.10 (0.7%) stddev-sans-first:0.44 09:04:50 INFO - PROCESS | 22525 | Values: 151.0 147.0 148.0 148.0 148.0 148.0 148.0 148.0 148.0 147.0 09:04:50 INFO - PROCESS | 22525 | 09:04:50 INFO - PROCESS | 22525 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 09:04:50 INFO - PROCESS | 22525 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 97.0 96.0 95.0 96.0 09:04:50 INFO - PROCESS | 22525 | 09:04:50 INFO - PROCESS | 22525 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.00 stddev:1.35 (2.1%) stddev-sans-first:0.60 09:04:50 INFO - PROCESS | 22525 | Values: 68.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 63.0 65.0 09:04:50 INFO - PROCESS | 22525 | 09:04:50 INFO - PROCESS | 22525 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 09:04:50 INFO - PROCESS | 22525 | Values: 66.0 66.0 65.0 65.0 66.0 65.0 66.0 66.0 65.0 66.0 09:04:50 INFO - PROCESS | 22525 | 09:04:50 INFO - PROCESS | 22525 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:84.00 stddev:3.41 (4.1%) stddev-sans-first:3.38 09:04:50 INFO - PROCESS | 22525 | Values: 80.0 83.0 86.0 88.0 81.0 82.0 80.0 89.0 85.0 80.0 09:04:50 INFO - PROCESS | 22525 | 09:04:50 INFO - PROCESS | 22525 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:138.00 stddev:14.86 (10.8%) stddev-sans-first:15.41 09:04:50 INFO - PROCESS | 22525 | Values: 151.0 138.0 135.0 144.0 131.0 133.0 135.0 138.0 181.0 135.0 09:04:50 INFO - PROCESS | 22525 | 09:04:50 INFO - PROCESS | 22525 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:170.50 stddev:2.77 (1.6%) stddev-sans-first:2.92 09:04:50 INFO - PROCESS | 22525 | Values: 171.0 169.0 173.0 166.0 174.0 170.0 173.0 170.0 166.0 169.0 09:04:50 INFO - PROCESS | 22525 | 09:04:50 INFO - PROCESS | 22525 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:1.90 (2.7%) stddev-sans-first:2.01 09:04:50 INFO - PROCESS | 22525 | Values: 70.0 72.0 69.0 73.0 70.0 68.0 67.0 70.0 68.0 68.0 09:04:50 INFO - PROCESS | 22525 | -------- Summary: end -------- 09:04:50 INFO - PROCESS | 22525 | 09:04:51 INFO - TEST-INFO | 22525: exit 0 09:04:51 INFO - TEST-OK | kraken | took 64328ms 09:04:51 INFO - SUITE-END | took 1180s 09:04:51 INFO - Completed test suite (00:19:40) 09:04:51 INFO - javascript benchmark 09:04:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6292.658135654292, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2596.182202606179, 2603.908863189788, 2606.270244331587, 2628.684557853058, 2636.644053052837, 4665.790039448225, 4682.461516925555, 4694.788734506947, 4762.285657151429, 4786.641001924852, 4633.281841314593, 4654.534546545352, 4658.953410465894, 4677.74272415017, 4680.6021488173465, 4240.342746874239, 4310.353446982962, 4349.151915376503, 4379.912401751963, 4389.6049355558, 112.6424818277963, 4254.574542545752, 4315.417418648473, 4320.049589090411, 4345.652347812167, 4271.829126834923, 4344.869653910388, 4351.042770590465, 4352.151330490556, 4399.78001099947, 4352.042550638855, 4362.040351122748, 4368.060866913629, 4368.956310436918, 4372.781360931941, 4259.084296876186, 4297.871063868089, 4320.20076285885, 4330.155619654169, 4338.956610433918, 4691.15559199344, 4700.4359476862655, 4705.670603057787, 4728.621710263205, 4731.597814185764, 4940.456549779521, 4968.850934471971, 5009.148444764399, 5018.673786203922, 5042.445331013622, 5016.2224855147515, 5031.270465782478, 5031.345925029759, 5036.496350364934, 5044.218146187347, 4709.293605959099, 4723.834665786681, 4732.73969931657, 4773.7374444405195, 4829.9999999999645, 5098.1842905135, 5174.172132458789, 5201.531862132426, 5210.213570025639, 5260.0531904257605, 4966.776495057731, 4987.401511818605, 4989.101961646938, 4996.6502344836235, 5018.322526458881, 5038.0, 5069.44236134025, 5080.74596270185, 5085.949140508547, 5087.796488140507, 4951.5048495150195, 4991.500849915052, 4992.301077849104, 5007.349044624176, 5009.799608015712, 4971.45314015458, 4994.300797888299, 4995.900081998339, 4998.450170481244, 5016.648834581544, 4205.0, 4293.720908140961, 4317.395564620955, 4354.586314300136, 4386.320120381346, 3682.8895133146048, 3766.7928263945746, 3787.450819631138, 3805.4101614249835, 3820.446035324918, 4323.848665296762, 4337.566243375701, 4338.327559228324, 4371.912561748811, 4437.933430998538, 4940.481249468754, 5096.61775366849, 5098.260752190911, 5111.744412779346, 5121.795128194905, 4324.697271191049, 4370.147821174904, 4375.606195442426, 4381.9123617527475, 4389.868303950887, 4597.655175861757, 4605.286180641939, 4611.100835337144, 4613.0543238636, 4643.837465688753, 4623.976880115578, 4635.629149668086, 4697.224957881979, 4726.527347265246, 4738.3129446230105, 4986.950130498793, 5005.849824505271, 5024.6231532634465, 5083.847484575469, 5091.439941606494, 4660.8135674574, 4664.39362882823, 4692.131955588227, 4701.717896926195, 4708.952910470852, 4778.0, 4827.986122914227, 4842.080004799077, 4855.708657480563, 4904.117258893433, 5024.522670346311, 5047.343845300087, 5058.064258112261, 5066.986602679405, 5116.718580478109, 4870.196417591058, 4879.146149423766, 4893.926591101207, 4894.437139728977, 4931.778069986931, 4693.624510039257, 4873.342098816756, 4892.559669629751, 4894.216925291937, 4913.459519452929, 4760.9047819042735, 4779.832705855279, 4814.15752243349, 4859.854204373874, 4861.392325959255, 4905.583025442735, 4908.214685650279, 4915.18899381598, 4944.134776414185, 4964.503549645006, 4622.537746225351, 4710.293455981493, 4724.740139292372, 4805.5915247204375, 4861.854144375674], "value": 4588.725965599147, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.5721137512742, 553.9252200952872, 571.6484362117296, 573.3349314794839, 574.2047264538613, 36093.27813443733, 40051.79974100129, 40165.7991710041, 40205.798971005104, 40231.39652905209, 39825.60174398255, 40121.0, 40150.59849401505, 40158.79920600393, 40314.395284070764, 7827.0, 7905.565193914361, 7915.287624113828, 7959.044914610255, 7962.880556791652, 7660.463767536246, 7693.384529237647, 7698.345640620554, 7738.729144479944, 7762.45662803604, 7948.642311095986, 7960.4825686330205, 8000.439969202158, 8018.198180181965, 8023.518588884656, 7958.721444749435, 7983.081945576275, 8005.4796438231915, 8005.839883202361, 8013.839723205561, 7933.444658873881, 7945.960270198612, 7977.840443191104, 8005.759827205193, 8010.319122874563, 38263.0, 38613.61386386157, 38746.41880371797, 38772.41841372382, 38782.80608596967, 2415.613501839715, 2721.2788611018095, 2750.1612008337447, 2860.099068793344, 2887.5235586128265, 26398.73601263982, 27432.588511172347, 28500.287492812637, 28739.56890646642, 29189.27026824325, 3244.0916543367894, 3248.3990461764647, 3293.5883014623173, 3338.232206592473, 3361.344537815127, 237157.0, 237317.0, 238124.0, 238276.99999999825, 238979.0, 32194.67805321917, 32280.35439291201, 32631.18422039468, 33185.170370740925, 33384.16539586481, 31462.842685786425, 31465.685343146277, 31522.0, 31536.211594710316, 31604.841975789976, 12014.15900886947, 12116.636500904988, 12126.818097728541, 12130.090243231616, 12151.635450936486, 9448.811023779486, 9490.90509094914, 9497.097775711296, 9502.097300756417, 9589.184919281799, 7960.681572737026, 7978.6808527659405, 8081.83836323282, 8091.39314551411, 8129.674813007532, 3092.304231547884, 3096.5819614352226, 3097.4734295169874, 3136.34136831268, 3166.825824579624, 881.8633111867671, 915.4187091197138, 933.6452148183782, 943.7404713703786, 947.393668052447, 28555.714442855722, 29007.85496072506, 30615.540766888513, 31017.224569385948, 32298.35403291921, 935.8461983116939, 945.5414124149781, 965.0928127560211, 1063.0113993985667, 1067.3489171605315, 14791.852081479048, 15304.770428443582, 15309.259027864551, 15462.458813941457, 15511.767323490156, 400341.0, 407986.0, 409022.0, 410079.0, 410141.0, 48306.758466207444, 48383.5161648379, 48546.514534854905, 48587.51412485901, 48702.51297487051, 1155.7804017236867, 1191.1661836714334, 1211.7758214730127, 1224.675461002835, 1229.7048708309942, 26963.460730785668, 28260.293492662848, 28270.71729282681, 28837.711622883504, 30591.694083059774, 46718.0, 47470.76264618655, 47921.041579168916, 47976.52023479721, 48115.0, 380308.0, 380711.0, 381575.0, 382001.0, 382063.8071286854, 37599.43600846044, 38196.236075278895, 39396.0, 39407.0, 39511.0, 39742.801285994545, 40846.795766022165, 46595.0, 48433.27350089681, 48798.51201488082, 37522.437163442024, 37968.24063518659, 38200.426993595676, 38413.4237986436, 38511.22977540489, 37628.623713762514, 37679.0, 38319.42520862134, 38661.260243288554, 39015.60984390233, 33159.50260746139, 33923.15192120118, 33937.15157121092, 34124.488132677536, 34470.82764586161, 30663.700222482956, 30972.0, 31007.0, 31292.217694557818, 31294.374112517165, 24227.0, 24463.502153987596, 24545.877270614248, 24557.63163552584, 24835.751642483345], "value": 16492.07867487208, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.3387585408338, 368.48964184604324, 371.25748502994014, 379.5653976197253, 385.70300868331384, 16313.592160195985, 17428.0, 18028.18873150708, 18146.364877229298, 18162.091895405243, 16159.676806463893, 16289.918550407261, 16999.405020824273, 17024.574385640364, 17657.55856103598, 4695.1548721230165, 4872.537108974641, 4902.754862256873, 4907.631927605426, 4909.607231421495, 3045.5279431688014, 4817.90364192716, 5383.919241211385, 5663.235463212455, 5678.233438485813, 5704.572157088214, 5728.484436400723, 5740.397258287882, 5747.913781293284, 5757.424257574251, 5568.3596386415675, 5594.049011668006, 5682.488576028157, 5701.173329867167, 5774.105013722879, 5497.147942068986, 5501.284832971688, 5539.113741801292, 5553.861153471155, 5574.554035677136, 20401.795982040137, 20603.48491287715, 21057.578848422945, 21151.47121321964, 21537.56924861494, 1607.5097095385902, 1658.6102265967488, 1695.3727120965198, 1709.350446830209, 2067.214458505758, 9360.953195234048, 9478.763030924212, 9972.451515166664, 11032.669019929335, 13582.320883955861, 1749.5363728611928, 1800.7659004329485, 1827.3604238516546, 1869.8597605179666, 1922.7404300419405, 69059.65470172667, 69479.0, 69663.30336696669, 70947.0, 71282.0, 10010.249231307682, 10222.335548189343, 10267.127294179929, 10360.430176340224, 10410.531526081344, 13935.512257070954, 13964.371603277878, 13964.511242106477, 14075.2962351882, 14090.36593353281, 6918.619475928772, 6954.200266969262, 6975.755848545378, 7139.535930164523, 7148.285171482914, 6291.748330066746, 6304.779332723424, 6361.300256971729, 6409.0, 6421.743130274736, 4334.5882141196535, 4372.540883207281, 4405.0, 4436.0, 4447.977760111179, 1667.2747354900657, 1732.1685590916431, 1780.8772691219785, 1820.981790182081, 1914.2343062775, 747.2975403121048, 876.9079246679134, 890.6392910871108, 898.2006014646969, 910.3218102513538, 16573.08848013371, 16835.915820420818, 16868.746968795233, 16946.322147114224, 17283.222254998556, 849.7705619482705, 857.648364170687, 865.3942240431597, 870.5473153959905, 899.3030401438937, 9199.63201471947, 9567.61729530811, 9646.0, 9720.659776907774, 9827.656032038843, 350244.0, 354171.0, 355165.0, 357790.0, 357853.0, 70582.64708676527, 72321.0, 73134.63432682803, 73448.26551734521, 73464.63267683628, 874.9868751968726, 877.0308808766349, 880.6389380354024, 909.60432211988, 927.3508544019079, 14775.778363324343, 15165.24173791328, 15219.391224350902, 15362.155081470179, 15696.529104126894, 25962.0, 26831.865840671453, 35412.114697132776, 37225.627743722216, 37399.43900841435, 48505.27242091301, 48797.0, 50315.496845031084, 50574.0, 51254.74372628262, 7156.642167891689, 7223.349898509159, 7316.597587132759, 7413.740519081806, 7421.554706717614, 9428.15146636806, 10618.469076545987, 10888.346699198073, 10975.560977560808, 11140.944295278796, 9440.716778496657, 9569.473678947725, 9644.469554174588, 9736.610535578497, 9901.653442129491, 8852.734417967471, 9531.857022144535, 9709.174720148867, 9968.50157492137, 10093.444860532742, 10026.799464010825, 10109.949450252701, 10312.381257124596, 10637.680869573616, 10679.733006674895, 7481.364084052916, 7527.2849079337375, 7584.0, 7602.96198519026, 7607.885881711668, 7467.813304667427, 9347.439153650803, 9931.503424828585, 10052.246081544059, 10281.588736450458], "value": 8072.017950618988, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.860049694782, 1341.2489006156547, 1363.0050063453677, 1401.677614148745, 1406.972909775863, 6464.256610489795, 7211.387032102271, 7225.421966242701, 7612.124605670357, 7749.573773442466, 7486.0, 7738.535687858733, 7742.458027938046, 7753.496022758517, 7776.805579860506, 2181.999999999996, 2210.071769856656, 2216.1467834883524, 2225.087714037245, 2229.721284839395, 2107.0509778454866, 2123.596516661837, 2213.4023813570325, 2214.081156320125, 2214.6235140026233, 2159.211887661008, 2169.1865550418593, 2169.3383518026994, 2175.2712841198218, 2183.2140429445385, 2186.1474025130133, 2186.835987300959, 2187.507810742586, 2187.671849222613, 2199.692043113965, 2017.0, 2107.5363420047565, 2113.830893528514, 2122.4481634774916, 2130.9147634094616, 7612.543247405173, 7617.238276172394, 7646.541207527566, 7647.579383133925, 7693.807654808675, 4547.136044151601, 4594.0122873582, 4617.053504031665, 4660.067986402699, 4668.323093151508, 2749.408877091435, 2797.5244208484605, 2810.7610853077513, 2813.8733756980782, 2840.744333010018, 896.9596368163449, 931.2782593490032, 933.6358820060182, 946.5314669238771, 946.9005754395827, 10070.395776253448, 10072.740907386577, 10086.243531735076, 10099.848502272473, 10131.746706332327, 3974.0859602291634, 4160.646345060703, 4176.352665336878, 4220.07158425146, 4263.232618128766, 8816.823663526693, 8854.911450885538, 8858.247049000778, 8873.334499912533, 8891.555422228863, 4665.066986602693, 4668.019715859639, 4668.5564871337165, 4674.6026587740425, 4692.741899195509, 3647.0, 4064.146529228895, 4252.744835309892, 4294.7852607369505, 4298.63461605767, 3623.5289412376223, 3667.963320366762, 3710.777353358807, 3766.5291838520184, 3915.236528876899, 1187.9109066820024, 1212.6362091372553, 1217.15407791584, 1224.406163010939, 1229.391451231646, 775.2441369664645, 777.6811507281988, 778.3967425245366, 782.3858271257036, 811.1604489353608, 5097.898042039138, 5103.795848166032, 5132.615053870974, 5226.869328266824, 5261.500157485033, 385.677958904318, 394.8835093647381, 400.89576710055013, 401.9095703466755, 414.5398607545622, 3542.4863394807608, 3558.733095017884, 3618.2944325856733, 3648.5256916600674, 3669.4128939370107, 9143.222826059726, 9529.714108576754, 9639.614415423444, 9655.179309758749, 9687.17658998979, 9361.391509551993, 9370.437773733598, 9381.718548443421, 9434.433933963985, 9516.571754270935, 7017.157941047107, 7109.502334836512, 7133.750318738819, 7140.750073747394, 7181.281871812777, 4987.551120399182, 5023.372078490189, 5138.100832354248, 5230.555402790653, 5304.60215483848, 8807.0, 8896.199342058986, 8899.555022248991, 8907.955460222658, 8973.596188171417, 8703.47779133254, 8979.371443998858, 9017.278617710435, 9053.592588333673, 9067.0, 5898.528117750484, 6405.583637063576, 6623.701933412912, 6774.762883299061, 6812.62530560804, 7404.481686281909, 7413.258674132544, 7423.888641670487, 7478.2895624915545, 7486.588237646982, 6365.3316401779, 6588.8023359299295, 6615.569987950767, 6630.933690663224, 6692.364225398579, 6246.531510136849, 6303.9684801575695, 6347.873042539216, 6427.3251308611925, 6448.742050317935, 6118.724657390517, 6228.844278892882, 6242.564210231763, 6262.655553944577, 6263.530235232284, 4437.933430998473, 4604.792784324646, 4630.560096790799, 4671.509491503479, 4699.788509517149, 4542.772861356985, 4573.062522182878, 4581.175388430114, 4626.236670949255, 4629.606483448944], "value": 3994.1493387795194, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.67299288300677, 300.2239211637916, 304.7531499485417, 309.9364630250799, 309.94885843835766, 4871.0, 4937.444704917948, 4983.850484485462, 5047.974760126203, 5053.519915608016, 4974.228994505857, 4974.900501989958, 5019.59843212543, 5022.497750224985, 5033.062271025654, 3987.501562304712, 4005.118873847749, 4010.4585880905997, 4015.9196816063663, 4025.476688030552, 3947.467091942594, 3949.7630142191415, 4000.239954408653, 4031.737937034098, 4039.7778122203267, 3939.9606003940025, 3952.565217826037, 3954.0, 3959.742616729903, 3965.4250133730593, 3950.7036972227056, 3957.5448823385245, 3972.1261322509004, 3991.341428664267, 4006.1587066715733, 3533.3993221152464, 3544.6987006104514, 3548.183917698918, 3555.715542756573, 3561.0919215599856, 4889.486603906575, 4892.559669629715, 4910.386201724785, 4926.408830940274, 4991.800327986876, 4526.841560545365, 4538.273876179828, 4551.3173024046655, 4556.430446194226, 4582.312653102028, 5304.949653948995, 5315.44187860273, 5331.413544510101, 5344.679319240858, 5348.625596208267, 3719.696440858806, 3801.7148713846573, 3832.156925476391, 3876.6511014008875, 3884.028992751812, 5471.972640136813, 5486.231927530149, 5488.7530061147345, 5496.203050557647, 5568.52667523257, 3947.802609869495, 3952.466417033721, 3959.4852669152824, 3973.920521589552, 3981.124152686404, 3666.9083272917856, 4026.9395959060053, 4027.6979226558124, 4033.556308806029, 4035.9596404035583, 4391.187630288407, 4397.2085024695225, 4410.448693913261, 4416.984093658477, 4470.173017991682, 5222.9216561750845, 5300.469953004668, 5302.814401495929, 5331.920550985119, 5338.8665283367445, 1261.88953720727, 1346.6767975685764, 1380.9906585917465, 1382.4539306973688, 1389.715108402775, 952.1097773581723, 952.6332362040664, 967.2020583019038, 980.6026412362355, 986.6941248213077, 4045.37296719009, 4077.1845630873945, 4089.4683691119963, 4115.609017143426, 4136.627703506699, 4748.501407352247, 4768.880777980509, 4794.760261986957, 4804.975975120102, 4823.638227132979, 4160.583941605815, 4168.249715051259, 4170.540310891164, 4177.644900183458, 4185.644220241253, 2522.243327001892, 2549.3244290263096, 2551.668283123182, 2556.5014822109883, 2572.215474280325, 4455.710378825366, 4494.393256910341, 4501.254234916698, 4505.481869584974, 4514.232580461329, 4822.397200349957, 4841.337264504508, 4842.491538388418, 4870.587529616371, 4909.410870695539, 4502.797374118172, 4640.373549570832, 5073.21365188389, 5075.974620126875, 5079.87300317495, 5440.428754980829, 5452.127659574449, 5497.615166938276, 5550.27846379968, 5564.638298510584, 5234.633575649668, 5375.16684913839, 5410.756515956713, 5435.945640543544, 5467.316585426822, 5068.518490743373, 5075.700794483468, 5085.135526960499, 5092.287079808903, 5099.6175286852895, 3726.3045314381347, 3790.8673196437994, 3799.6010418905616, 3821.2166505866785, 3825.808709564455, 4891.413030436371, 5478.753456094406, 5506.201600767786, 5510.448955104457, 5512.145617429305, 5208.453112423141, 5218.739063046908, 5247.291615631993, 5260.947390526046, 5294.761735721825, 5195.896082078413, 5258.132408152765, 5287.788488460418, 5304.294809647031, 5330.920036199538, 4886.364772579542, 5160.535551800356, 5166.689998600096, 5197.518707168439, 5209.062368773657, 5237.450067742832, 5253.001929633358, 5255.871372094308, 5265.394479634738, 5296.788128474972, 5101.744912754421, 5158.587313014875, 5168.612354073534, 5178.145605974972, 5201.401838788588], "value": 3913.2686912654726, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.1059936593525, 634.3181080338636, 691.3708525242031, 718.4826924614279, 728.5410191579305, 11807.586734464296, 11962.700932476682, 12268.447919843606, 12381.319027453497, 12416.627501174968, 12725.490980360797, 13027.478900843955, 13033.674158146028, 13064.085514014023, 13070.215787052783, 617.3517806303386, 763.9541627502367, 774.0633833061987, 795.0340336491162, 801.3068695578341, 791.2325044706625, 791.651673263765, 793.9761807145795, 797.6450479536609, 798.2177466083242, 834.6953362022879, 834.8330333933208, 837.5184269045293, 838.8238469921324, 841.032812265893, 813.2111851504031, 816.2042009041197, 822.0956947357888, 823.2919689067397, 827.3505298340834, 605.8061420345491, 606.1544145916466, 606.4481321997006, 607.7295603456464, 609.0194786393902, 13165.0, 13308.600741977756, 13315.201087934658, 13335.666608334772, 13429.462821487226, 13685.521006764715, 13733.939749803378, 13851.51519696816, 14057.929710351485, 14301.92849035748, 9492.525373731354, 9552.61789528418, 9652.324337296392, 9663.13031827139, 9769.755756106084, 3232.6444091149956, 3237.6114866216203, 3291.374638818617, 3301.6698330167033, 3354.3794398036443, 53275.73362133203, 55457.0, 55486.0, 68552.6572367135, 68943.0, 9840.458774767456, 10256.487175641189, 10445.11216546587, 10641.893581064245, 10695.572177112828, 18843.0, 19239.90380048119, 19244.326448574513, 19259.807401926082, 19261.325853595055, 6541.901871471931, 6568.312131108561, 6645.06969024337, 6801.795946121624, 6865.141857267841, 3486.38988177068, 3495.667911548399, 3557.8932632021083, 3594.2452085061905, 3599.38810402227, 2843.4170994945985, 2891.0, 2917.3144311086876, 2938.133250691051, 2942.440936222111, 513.7508308470389, 542.5659472422126, 543.6384804105226, 547.731611510365, 548.6872482684911, 508.7863097499059, 559.2645670942698, 562.7833284185618, 597.9431953964366, 618.7957973868613, 8109.797255068671, 8169.877451838108, 8340.499570025819, 8368.707095251759, 8381.161883811692, 556.0824639345113, 589.0208898102372, 601.3955974245943, 602.457787990803, 615.6767696959042, 3623.9456408153897, 3935.311320518955, 3988.760674359548, 4037.0916543777416, 4044.838206471767, 59852.0, 60453.0932036011, 75516.0, 111554.0, 111741.0, 94413.52793236128, 95974.0, 97739.51130244303, 98153.0, 98213.50893245632, 86151.56924215339, 86406.56796715976, 86488.56755716307, 87404.12595874087, 87749.56125219334, 7526.564787106945, 7552.28253315956, 7622.8094297643, 7679.692812287446, 7760.88358674609, 48497.75751121222, 48563.75718121387, 48701.26948095852, 50135.49864501308, 50441.495585045144, 72165.0, 73456.63271683607, 74256.25743742494, 76577.61711191408, 77096.0, 9606.51967401641, 9696.127348538665, 9728.9027109728, 9849.162821160282, 10058.29591928558, 11492.195546311677, 11502.194846360675, 11576.768464630828, 12234.082443816571, 12328.876711232773, 10950.452477376259, 10977.0, 11109.833352499558, 11190.944045280046, 11298.60454884075, 11036.668899933014, 11198.832017519906, 11231.71920701989, 11336.206465547333, 11899.702507437383, 9582.281328900499, 9591.520423978913, 9625.133737963617, 10743.570257189625, 10873.782524349626, 8699.391042626956, 8799.648014079621, 8824.426412283181, 8864.645414183618, 9198.724038278862, 9321.0, 9330.766730831512, 9355.158035776813, 9366.625334986524, 9420.057994200524], "value": 6501.956305950289, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 117.0, 110.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 151.0, 172.0, 123.0, 155.0, 152.0, 126.0, 181.0, 129.0], "value": 147.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 166.0, 169.0, 163.0, 162.0, 165.0, 164.0, 166.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 152.0, 79.0, 76.0, 77.0, 76.0, 165.0, 79.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 140.0, 87.0, 85.0, 86.0, 147.0, 84.0, 85.0, 135.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 119.0, 119.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 63.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 86.0, 88.0, 81.0, 82.0, 80.0, 89.0, 85.0, 80.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 138.0, 135.0, 144.0, 131.0, 133.0, 135.0, 138.0, 181.0, 135.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 173.0, 166.0, 174.0, 170.0, 173.0, 170.0, 166.0, 169.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 69.0, 73.0, 70.0, 68.0, 67.0, 70.0, 68.0, 68.0], "value": 69.5, "unit": "score"}]}]} 09:04:51 INFO - Return code: 0 09:04:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:04:51 ERROR - # TBPL SUCCESS # 09:04:51 INFO - Running post-action listener: _resource_record_post_action 09:04:51 INFO - ##### 09:04:51 INFO - ##### Finished run-tests step (success) 09:04:51 INFO - ##### 09:04:51 INFO - Running post-run listener: _resource_record_post_run 09:04:51 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 553689088; Read time: 0; Write time: 811032 09:04:51 INFO - TinderboxPrint: CPU usage
13.4% 09:04:51 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:04:51 INFO - TinderboxPrint: I/O write bytes / time
553,689,088 / 811,032 09:04:51 INFO - TinderboxPrint: CPU idle
8,273.2 (86.6%) 09:04:51 INFO - TinderboxPrint: CPU user
1,221.2 (12.8%) 09:04:51 INFO - TinderboxPrint: Swap in / out
0 / 0 09:04:51 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 261287936; Read time: 0; Write time: 353408 09:04:51 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288460800; Read time: 0; Write time: 457036 09:04:52 INFO - Running post-run listener: _upload_blobber_files 09:04:52 INFO - Blob upload gear active. 09:04:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:04:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:04:52 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:04:52 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:04:52 INFO - (blobuploader) - INFO - Open directory for files ... 09:04:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:04:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:04:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:53 INFO - (blobuploader) - INFO - Done attempting. 09:04:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:04:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:04:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:57 INFO - (blobuploader) - INFO - Done attempting. 09:04:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:04:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:04:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:58 INFO - (blobuploader) - INFO - Done attempting. 09:04:58 INFO - (blobuploader) - INFO - Iteration through files over. 09:04:58 INFO - Return code: 0 09:04:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:04:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:04:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d7bb56f992fd21329cef6532f6e29a4e9057da7a313b53e81b97dcb67b3a7b5a21987895567d1c4f6cd1ce1bf78e01000ee1150ebfc680878131161c9f381e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f63ff13c0cce2365c4a153991e07e465eaf19d5d3f37dfbfefafe5b398682b23167de1d565e4cdc9cc000f9d1ddb349a5f35f695c4f1a482d8deb36c58aa0d65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c911ea15b9ab380cc4bb1cbc2b7cdffa63b8343294a1317db5fe658ea3121007a06f4c2fcb7f41a6f75db5cc794577017ae52e6c2782909ed9d463f186639ffd"} 09:04:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:04:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:04:58 INFO - Contents: 09:04:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d7bb56f992fd21329cef6532f6e29a4e9057da7a313b53e81b97dcb67b3a7b5a21987895567d1c4f6cd1ce1bf78e01000ee1150ebfc680878131161c9f381e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f63ff13c0cce2365c4a153991e07e465eaf19d5d3f37dfbfefafe5b398682b23167de1d565e4cdc9cc000f9d1ddb349a5f35f695c4f1a482d8deb36c58aa0d65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c911ea15b9ab380cc4bb1cbc2b7cdffa63b8343294a1317db5fe658ea3121007a06f4c2fcb7f41a6f75db5cc794577017ae52e6c2782909ed9d463f186639ffd"} 09:04:58 INFO - Running post-run listener: copy_logs_to_upload_dir 09:04:58 INFO - Copying logs to upload dir... 09:04:58 INFO - mkdir: /builds/slave/test/build/upload/logs 09:04:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.147024 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-11 09:04:58.077518) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 09:04:58.080762) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761 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-Non-PGO/sha512/0d7bb56f992fd21329cef6532f6e29a4e9057da7a313b53e81b97dcb67b3a7b5a21987895567d1c4f6cd1ce1bf78e01000ee1150ebfc680878131161c9f381e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f63ff13c0cce2365c4a153991e07e465eaf19d5d3f37dfbfefafe5b398682b23167de1d565e4cdc9cc000f9d1ddb349a5f35f695c4f1a482d8deb36c58aa0d65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c911ea15b9ab380cc4bb1cbc2b7cdffa63b8343294a1317db5fe658ea3121007a06f4c2fcb7f41a6f75db5cc794577017ae52e6c2782909ed9d463f186639ffd"} build_url:https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/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-Non-PGO/sha512/0d7bb56f992fd21329cef6532f6e29a4e9057da7a313b53e81b97dcb67b3a7b5a21987895567d1c4f6cd1ce1bf78e01000ee1150ebfc680878131161c9f381e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f63ff13c0cce2365c4a153991e07e465eaf19d5d3f37dfbfefafe5b398682b23167de1d565e4cdc9cc000f9d1ddb349a5f35f695c4f1a482d8deb36c58aa0d65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c911ea15b9ab380cc4bb1cbc2b7cdffa63b8343294a1317db5fe658ea3121007a06f4c2fcb7f41a6f75db5cc794577017ae52e6c2782909ed9d463f186639ffd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 09:04:58.109804) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 09:04:58.110532) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468251679.856632-1499999761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 09:04:58.193426) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 09:04:58.193805) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 09:04:58.194126) ========= ========= Total master_lag: 0.17 =========