builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1468455481.03 results: success (0) buildid: 20160713143006 builduid: 9e60eb45167040969243f9260c444e5b revision: 34a128489d8895e2f1ef58f43e2b4d196be6e544 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 17:18:01.027213) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 17:18:01.027757) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 17:18:01.028113) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 17:18:01.049084) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:18:01.049487) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 17:18:02-- 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% 39.9M=0s 2016-07-13 17:18:02 (39.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080420 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:18:01.143715) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:18:01.144057) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019479 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:18:01.200107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:18:01.200444) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 34a128489d8895e2f1ef58f43e2b4d196be6e544 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 34a128489d8895e2f1ef58f43e2b4d196be6e544 --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=82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 17:18:02,631 truncating revision to first 12 chars 2016-07-13 17:18:02,631 Setting DEBUG logging. 2016-07-13 17:18:02,631 attempt 1/10 2016-07-13 17:18:02,631 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/34a128489d88?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 17:18:02,990 unpacking tar archive at: fx-team-34a128489d88/testing/mozharness/ program finished with exit code 0 elapsedTime=0.705225 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:18:01.920565) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 17:18:01.920932) ========= script_repo_revision: 34a128489d8895e2f1ef58f43e2b4d196be6e544 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 17:18:01.921360) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 17:18:01.921739) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 17:18:01.933363) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-13 17:18:01.933864) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:18:03 INFO - MultiFileLogger online at 20160713 17:18:03 in /builds/slave/test 17:18:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:18:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:18:03 INFO - {'append_to_log': False, 17:18:03 INFO - 'base_work_dir': '/builds/slave/test', 17:18:03 INFO - 'blob_upload_branch': 'Fx-Team', 17:18:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:18:03 INFO - 'branch': 'Fx-Team', 17:18:03 INFO - 'buildbot_json_path': 'buildprops.json', 17:18:03 INFO - 'config_files': ('talos/linux_config.py',), 17:18:03 INFO - 'default_actions': ('clobber', 17:18:03 INFO - 'read-buildbot-config', 17:18:03 INFO - 'download-and-extract', 17:18:03 INFO - 'populate-webroot', 17:18:03 INFO - 'create-virtualenv', 17:18:03 INFO - 'install', 17:18:03 INFO - 'run-tests'), 17:18:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:18:03 INFO - 'download_minidump_stackwalk': True, 17:18:03 INFO - 'download_symbols': 'ondemand', 17:18:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:18:03 INFO - 'tooltool.py': '/tools/tooltool.py', 17:18:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:18:03 INFO - '/tools/misc-python/virtualenv.py')}, 17:18:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:18:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:18:03 INFO - 'installer_path': 'installer.exe', 17:18:03 INFO - 'log_level': 'info', 17:18:03 INFO - 'log_name': 'talos', 17:18:03 INFO - 'log_to_console': True, 17:18:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:18:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:18:03 INFO - 'opt_config_files': (), 17:18:03 INFO - 'pip_index': False, 17:18:03 INFO - 'sps_profile': False, 17:18:03 INFO - 'sps_profile_interval': 0, 17:18:03 INFO - 'suite': 'dromaeojs-e10s', 17:18:03 INFO - 'system_bits': '32', 17:18:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:18:03 INFO - 'title': 'talos-linux64-ix-066', 17:18:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:18:03 INFO - 'use_talos_json': True, 17:18:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:18:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:18:03 INFO - 'work_dir': 'build'} 17:18:03 INFO - ##### 17:18:03 INFO - ##### Running clobber step. 17:18:03 INFO - ##### 17:18:03 INFO - Running pre-action listener: _resource_record_pre_action 17:18:03 INFO - Running main action method: clobber 17:18:03 INFO - rmtree: /builds/slave/test/build 17:18:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:18:04 INFO - Running post-action listener: _resource_record_post_action 17:18:04 INFO - ##### 17:18:04 INFO - ##### Finished clobber step (success) 17:18:04 INFO - ##### 17:18:04 INFO - ##### 17:18:04 INFO - ##### Running read-buildbot-config step. 17:18:04 INFO - ##### 17:18:04 INFO - Running pre-action listener: _resource_record_pre_action 17:18:04 INFO - Running main action method: read_buildbot_config 17:18:04 INFO - Using buildbot properties: 17:18:04 INFO - { 17:18:04 INFO - "project": "", 17:18:04 INFO - "product": "firefox", 17:18:04 INFO - "script_repo_revision": "production", 17:18:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:18:04 INFO - "repository": "", 17:18:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:18:04 INFO - "buildid": "20160713143006", 17:18:04 INFO - "pgo_build": "True", 17:18:04 INFO - "basedir": "/builds/slave/test", 17:18:04 INFO - "buildnumber": 581, 17:18:04 INFO - "slavename": "talos-linux64-ix-066", 17:18:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:18:04 INFO - "platform": "ubuntu64_hw", 17:18:04 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:18:04 INFO - "branch": "fx-team", 17:18:04 INFO - "repo_path": "integration/fx-team", 17:18:04 INFO - "revision": "34a128489d8895e2f1ef58f43e2b4d196be6e544", 17:18:04 INFO - "stage_platform": "linux64-pgo", 17:18:04 INFO - "builduid": "9e60eb45167040969243f9260c444e5b", 17:18:04 INFO - "slavebuilddir": "test" 17:18:04 INFO - } 17:18:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:18:04 INFO - Running post-action listener: _resource_record_post_action 17:18:04 INFO - ##### 17:18:04 INFO - ##### Finished read-buildbot-config step (success) 17:18:04 INFO - ##### 17:18:04 INFO - ##### 17:18:04 INFO - ##### Running download-and-extract step. 17:18:04 INFO - ##### 17:18:04 INFO - Running pre-action listener: _resource_record_pre_action 17:18:04 INFO - Running main action method: download_and_extract 17:18:04 INFO - mkdir: /builds/slave/test/build/tests 17:18:04 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')]} 17:18:04 INFO - https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:18:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:18:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:18:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:18:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:18:14 INFO - Downloaded 1361 bytes. 17:18:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:18:14 INFO - Using the following test package requirements: 17:18:14 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:18:14 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:18:14 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:18:14 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:14 INFO - u'jsshell-linux-x86_64.zip'], 17:18:14 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:18:14 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:18:14 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:18:14 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:18:14 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:18:14 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:18:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:14 INFO - https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:18:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:18:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:18:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:18:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:18:18 INFO - Downloaded 24325923 bytes. 17:18:18 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'] 17:18:18 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 17:18:20 INFO - Return code: 0 17:18:20 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 17:18: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')]} 17:18:20 INFO - https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:18:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:18:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:18:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:18:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:18:21 INFO - Downloaded 24325923 bytes. 17:18:21 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'] 17:18:21 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 17:18:22 INFO - Return code: 0 17:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:22 INFO - https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:18:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:18:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:18:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:18:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:18:23 INFO - Downloaded 14403317 bytes. 17:18:23 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'] 17:18:23 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 17:18:24 INFO - Return code: 0 17:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:24 INFO - https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:18:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:18:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:18:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:18:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:18:26 INFO - Downloaded 60811699 bytes. 17:18:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:18:26 INFO - mkdir: /builds/slave/test/properties 17:18:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:18:26 INFO - Writing to file /builds/slave/test/properties/build_url 17:18:26 INFO - Contents: 17:18:26 INFO - build_url:https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:18:26 INFO - Running post-action listener: _resource_record_post_action 17:18:26 INFO - Running post-action listener: set_extra_try_arguments 17:18:26 INFO - ##### 17:18:26 INFO - ##### Finished download-and-extract step (success) 17:18:26 INFO - ##### 17:18:26 INFO - ##### 17:18:26 INFO - ##### Running populate-webroot step. 17:18:26 INFO - ##### 17:18:26 INFO - Running pre-action listener: _resource_record_pre_action 17:18:26 INFO - Running main action method: populate_webroot 17:18:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:18:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:18:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:18:26 INFO - '--tppagecycles', 17:18:26 INFO - '7'], 17:18:26 INFO - 'tests': ['tsvgm']}}, 17:18:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:18:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:18:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:18:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:18:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:26 INFO - 'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:18:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:18:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:26 INFO - 'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['damp', 'tps']}, 17:18:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:26 INFO - 'tests': ['damp', 'tps']}, 17:18:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['dromaeo_dom']}, 17:18:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:18:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['basic_compositor_video']}, 17:18:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:18:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['a11yr', 17:18:26 INFO - 'ts_paint', 17:18:26 INFO - 'tpaint', 17:18:26 INFO - 'sessionrestore', 17:18:26 INFO - 'sessionrestore_no_auto_restore', 17:18:26 INFO - 'tabpaint']}, 17:18:26 INFO - 'other-e10s': {'tests': ['a11yr', 17:18:26 INFO - 'ts_paint', 17:18:26 INFO - 'tpaint', 17:18:26 INFO - 'sessionrestore', 17:18:26 INFO - 'sessionrestore_no_auto_restore', 17:18:26 INFO - 'tabpaint']}, 17:18:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:18:26 INFO - 'ts_paint', 17:18:26 INFO - 'tpaint', 17:18:26 INFO - 'sessionrestore', 17:18:26 INFO - 'sessionrestore_no_auto_restore', 17:18:26 INFO - 'tabpaint']}, 17:18:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:18:26 INFO - 'ts_paint', 17:18:26 INFO - 'tpaint', 17:18:26 INFO - 'sessionrestore', 17:18:26 INFO - 'sessionrestore_no_auto_restore', 17:18:26 INFO - 'tabpaint']}, 17:18:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['a11yr', 17:18:26 INFO - 'ts_paint', 17:18:26 INFO - 'tpaint', 17:18:26 INFO - 'sessionrestore', 17:18:26 INFO - 'sessionrestore_no_auto_restore', 17:18:26 INFO - 'tabpaint']}, 17:18:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['a11yr', 17:18:26 INFO - 'ts_paint', 17:18:26 INFO - 'tpaint', 17:18:26 INFO - 'sessionrestore', 17:18:26 INFO - 'sessionrestore_no_auto_restore', 17:18:26 INFO - 'tabpaint']}, 17:18:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['tsvgx', 17:18:26 INFO - 'tsvgr_opacity', 17:18:26 INFO - 'tart', 17:18:26 INFO - 'tscrollx', 17:18:26 INFO - 'cart']}, 17:18:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:18:26 INFO - 'tsvgr_opacity', 17:18:26 INFO - 'tart', 17:18:26 INFO - 'tscrollx', 17:18:26 INFO - 'cart']}, 17:18:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:26 INFO - 'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['tp5o']}, 17:18:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:26 INFO - 'tests': ['tp5o']}, 17:18:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:26 INFO - 'talos_options': ['--disable-e10s', 17:18:26 INFO - '--xperf_path', 17:18:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:18:26 INFO - 'tests': ['tp5n']}, 17:18:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:26 INFO - 'talos_options': ['--xperf_path', 17:18:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:18:26 INFO - 'tests': ['tp5n']}}, 17:18:26 INFO - 'talos.zip': {'path': '', 17:18:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:18:26 INFO - Running post-action listener: _resource_record_post_action 17:18:26 INFO - ##### 17:18:26 INFO - ##### Finished populate-webroot step (success) 17:18:26 INFO - ##### 17:18:26 INFO - ##### 17:18:26 INFO - ##### Running create-virtualenv step. 17:18:26 INFO - ##### 17:18:26 INFO - Running pre-action listener: _resource_record_pre_action 17:18:26 INFO - Running main action method: create_virtualenv 17:18:26 INFO - Creating virtualenv /builds/slave/test/build/venv 17:18:26 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 17:18:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:18:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:18:26 INFO - Using real prefix '/usr' 17:18:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:18:27 INFO - Installing distribute.............................................................................................................................................................................................done. 17:18:29 INFO - Installing pip.................done. 17:18:29 INFO - Return code: 0 17:18:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:18: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')]} 17:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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')]} 17:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:29 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 0x1eb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21723b0>, '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 0x21732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', '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 17:18:29 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 17:18:29 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 17:18:29 INFO - Using env: {'DISPLAY': ':0', 17:18:29 INFO - 'HOME': '/home/cltbld', 17:18:29 INFO - 'LANG': 'en_US.UTF-8', 17:18:29 INFO - 'LANGUAGE': 'en_US:en', 17:18:29 INFO - 'LOGNAME': 'cltbld', 17:18:29 INFO - 'MAIL': '/var/mail/cltbld', 17:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:29 INFO - 'MOZ_NO_REMOTE': '1', 17:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:29 INFO - 'NO_EM_RESTART': '1', 17:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:29 INFO - 'PWD': '/builds/slave/test', 17:18:29 INFO - 'SHELL': '/bin/bash', 17:18:29 INFO - 'SHLVL': '1', 17:18:29 INFO - 'TERM': 'linux', 17:18:29 INFO - 'TMOUT': '86400', 17:18:29 INFO - 'USER': 'cltbld', 17:18:29 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', 17:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:29 INFO - '_': '/tools/buildbot/bin/python'} 17:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:29 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 17:18:29 INFO - Cleaning up... 17:18:29 INFO - Return code: 0 17:18:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:18: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')]} 17:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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')]} 17:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:29 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 0x1eb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21723b0>, '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 0x21732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', '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 17:18:29 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 17:18:29 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 17:18:29 INFO - Using env: {'DISPLAY': ':0', 17:18:29 INFO - 'HOME': '/home/cltbld', 17:18:29 INFO - 'LANG': 'en_US.UTF-8', 17:18:29 INFO - 'LANGUAGE': 'en_US:en', 17:18:29 INFO - 'LOGNAME': 'cltbld', 17:18:29 INFO - 'MAIL': '/var/mail/cltbld', 17:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:29 INFO - 'MOZ_NO_REMOTE': '1', 17:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:29 INFO - 'NO_EM_RESTART': '1', 17:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:29 INFO - 'PWD': '/builds/slave/test', 17:18:29 INFO - 'SHELL': '/bin/bash', 17:18:29 INFO - 'SHLVL': '1', 17:18:29 INFO - 'TERM': 'linux', 17:18:29 INFO - 'TMOUT': '86400', 17:18:29 INFO - 'USER': 'cltbld', 17:18:29 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', 17:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:29 INFO - '_': '/tools/buildbot/bin/python'} 17:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:29 INFO - Downloading/unpacking psutil>=3.1.1 17:18:29 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 17:18:29 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 17:18:29 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 17:18:29 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 17:18:29 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 17:18:29 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 17:18:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:18:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:18:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:18:31 INFO - Installing collected packages: psutil 17:18:31 INFO - Running setup.py install for psutil 17:18:31 INFO - building 'psutil._psutil_linux' extension 17:18:31 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 17:18:32 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 17:18:32 INFO - building 'psutil._psutil_posix' extension 17:18:32 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 17:18:32 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 17:18:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:18:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:18:32 INFO - Successfully installed psutil 17:18:32 INFO - Cleaning up... 17:18:32 INFO - Return code: 0 17:18:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:18:32 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')]} 17:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:32 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')]} 17:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:32 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 0x1eb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21723b0>, '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 0x21732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', '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 17:18:32 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 17:18:32 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 17:18:32 INFO - Using env: {'DISPLAY': ':0', 17:18:32 INFO - 'HOME': '/home/cltbld', 17:18:32 INFO - 'LANG': 'en_US.UTF-8', 17:18:32 INFO - 'LANGUAGE': 'en_US:en', 17:18:32 INFO - 'LOGNAME': 'cltbld', 17:18:32 INFO - 'MAIL': '/var/mail/cltbld', 17:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:32 INFO - 'MOZ_NO_REMOTE': '1', 17:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:32 INFO - 'NO_EM_RESTART': '1', 17:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:32 INFO - 'PWD': '/builds/slave/test', 17:18:32 INFO - 'SHELL': '/bin/bash', 17:18:32 INFO - 'SHLVL': '1', 17:18:32 INFO - 'TERM': 'linux', 17:18:32 INFO - 'TMOUT': '86400', 17:18:32 INFO - 'USER': 'cltbld', 17:18:32 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', 17:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:32 INFO - '_': '/tools/buildbot/bin/python'} 17:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:18:32 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 17:18:32 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 17:18:32 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 17:18:32 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 17:18:32 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 17:18:32 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 17:18:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:18:34 INFO - Installing collected packages: mozsystemmonitor 17:18:34 INFO - Running setup.py install for mozsystemmonitor 17:18:34 INFO - Successfully installed mozsystemmonitor 17:18:34 INFO - Cleaning up... 17:18:34 INFO - Return code: 0 17:18:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:18: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')]} 17:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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')]} 17:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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', '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 0x1eb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21723b0>, '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 0x21732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', '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 17:18: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:18: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 jsonschema==2.5.1 17:18:34 INFO - Using env: {'DISPLAY': ':0', 17:18:34 INFO - 'HOME': '/home/cltbld', 17:18:34 INFO - 'LANG': 'en_US.UTF-8', 17:18:34 INFO - 'LANGUAGE': 'en_US:en', 17:18:34 INFO - 'LOGNAME': 'cltbld', 17:18:34 INFO - 'MAIL': '/var/mail/cltbld', 17:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:34 INFO - 'MOZ_NO_REMOTE': '1', 17:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:34 INFO - 'NO_EM_RESTART': '1', 17:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:34 INFO - 'PWD': '/builds/slave/test', 17:18:34 INFO - 'SHELL': '/bin/bash', 17:18:34 INFO - 'SHLVL': '1', 17:18:34 INFO - 'TERM': 'linux', 17:18:34 INFO - 'TMOUT': '86400', 17:18:34 INFO - 'USER': 'cltbld', 17:18:34 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', 17:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:34 INFO - '_': '/tools/buildbot/bin/python'} 17:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:34 INFO - Downloading/unpacking jsonschema==2.5.1 17:18:34 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 17:18:34 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 17:18:34 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 17:18:34 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 17:18:34 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 17:18:34 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 17:18:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:18:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:18:36 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 17:18:36 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 17:18:36 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 17:18:36 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 17:18:36 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 17:18:36 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 17:18:36 INFO - Downloading functools32-3.2.3-2.tar.gz 17:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:18:37 INFO - warning: no files found matching '*.txt' 17:18:37 INFO - no previously-included directories found matching 'build' 17:18:37 INFO - no previously-included directories found matching 'dist' 17:18:37 INFO - no previously-included directories found matching '.git*' 17:18:37 INFO - Installing collected packages: jsonschema, functools32 17:18:37 INFO - Running setup.py install for functools32 17:18:37 INFO - warning: no files found matching '*.txt' 17:18:37 INFO - no previously-included directories found matching 'build' 17:18:37 INFO - no previously-included directories found matching 'dist' 17:18:37 INFO - no previously-included directories found matching '.git*' 17:18:37 INFO - Successfully installed jsonschema functools32 17:18:37 INFO - Cleaning up... 17:18:37 INFO - Return code: 0 17:18:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:18: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')]} 17:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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')]} 17:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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', '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 0x1eb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21723b0>, '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 0x21732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', '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 17:18: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:18: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 blobuploader==1.2.4 17:18:37 INFO - Using env: {'DISPLAY': ':0', 17:18:37 INFO - 'HOME': '/home/cltbld', 17:18:37 INFO - 'LANG': 'en_US.UTF-8', 17:18:37 INFO - 'LANGUAGE': 'en_US:en', 17:18:37 INFO - 'LOGNAME': 'cltbld', 17:18:37 INFO - 'MAIL': '/var/mail/cltbld', 17:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:37 INFO - 'MOZ_NO_REMOTE': '1', 17:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:37 INFO - 'NO_EM_RESTART': '1', 17:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:37 INFO - 'PWD': '/builds/slave/test', 17:18:37 INFO - 'SHELL': '/bin/bash', 17:18:37 INFO - 'SHLVL': '1', 17:18:37 INFO - 'TERM': 'linux', 17:18:37 INFO - 'TMOUT': '86400', 17:18:37 INFO - 'USER': 'cltbld', 17:18:37 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', 17:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:37 INFO - '_': '/tools/buildbot/bin/python'} 17:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:37 INFO - Downloading/unpacking blobuploader==1.2.4 17:18:37 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 17:18:37 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 17:18:37 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 17:18:37 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 17:18:37 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 17:18:37 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 17:18:39 INFO - Downloading blobuploader-1.2.4.tar.gz 17:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:18:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:18:39 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 17:18:39 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 17:18:39 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 17:18:39 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 17:18:39 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 17:18:39 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 17:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:18:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:18:39 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 17:18:39 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 17:18:39 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 17:18:39 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 17:18:39 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 17:18:39 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 17:18:40 INFO - Downloading docopt-0.6.1.tar.gz 17:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:18:40 INFO - Installing collected packages: blobuploader, requests, docopt 17:18:40 INFO - Running setup.py install for blobuploader 17:18:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:18:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:18:40 INFO - Running setup.py install for requests 17:18:40 INFO - Running setup.py install for docopt 17:18:40 INFO - Successfully installed blobuploader requests docopt 17:18:40 INFO - Cleaning up... 17:18:40 INFO - Return code: 0 17:18:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18: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')]} 17:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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')]} 17:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:40 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 0x1eb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21723b0>, '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 0x21732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', '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 17:18:40 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 17:18:40 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 17:18:40 INFO - Using env: {'DISPLAY': ':0', 17:18:40 INFO - 'HOME': '/home/cltbld', 17:18:40 INFO - 'LANG': 'en_US.UTF-8', 17:18:40 INFO - 'LANGUAGE': 'en_US:en', 17:18:40 INFO - 'LOGNAME': 'cltbld', 17:18:40 INFO - 'MAIL': '/var/mail/cltbld', 17:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:40 INFO - 'MOZ_NO_REMOTE': '1', 17:18:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:40 INFO - 'NO_EM_RESTART': '1', 17:18:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:40 INFO - 'PWD': '/builds/slave/test', 17:18:40 INFO - 'SHELL': '/bin/bash', 17:18:40 INFO - 'SHLVL': '1', 17:18:40 INFO - 'TERM': 'linux', 17:18:40 INFO - 'TMOUT': '86400', 17:18:40 INFO - 'USER': 'cltbld', 17:18:40 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', 17:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:40 INFO - '_': '/tools/buildbot/bin/python'} 17:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:18:41 INFO - Running setup.py (path:/tmp/pip-i_aUKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:18:41 INFO - Running setup.py (path:/tmp/pip-PBtwPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:18:41 INFO - Running setup.py (path:/tmp/pip-c2tZgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:18:41 INFO - Running setup.py (path:/tmp/pip-Ur86e3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:18:41 INFO - Running setup.py (path:/tmp/pip-Yi0pNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:18:41 INFO - Running setup.py (path:/tmp/pip-X1c2lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:18:41 INFO - Running setup.py (path:/tmp/pip-zki3lG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:18:41 INFO - Running setup.py (path:/tmp/pip-0Ju8xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:18:41 INFO - Running setup.py (path:/tmp/pip-mNYGRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:18:41 INFO - Running setup.py (path:/tmp/pip-BLHDbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:18:41 INFO - Running setup.py (path:/tmp/pip-XtNVaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:18:41 INFO - Running setup.py (path:/tmp/pip-76IuWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:18:41 INFO - Running setup.py (path:/tmp/pip-uYRwS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:18:41 INFO - Running setup.py (path:/tmp/pip-O6O0n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:42 INFO - Running setup.py (path:/tmp/pip-Gxughj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:18:42 INFO - Running setup.py (path:/tmp/pip-lPexwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:18:42 INFO - Running setup.py (path:/tmp/pip-y9TjQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:18:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:18:42 INFO - Running setup.py install for manifestparser 17:18:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:18:42 INFO - Running setup.py install for mozcrash 17:18:42 INFO - Running setup.py install for mozdebug 17:18:42 INFO - Running setup.py install for mozdevice 17:18:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:18:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:18:42 INFO - Running setup.py install for mozfile 17:18:42 INFO - Running setup.py install for mozhttpd 17:18:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:18:42 INFO - Running setup.py install for mozinfo 17:18:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:18:43 INFO - Running setup.py install for mozInstall 17:18:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:18:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:18:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:18:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:18:43 INFO - Running setup.py install for mozleak 17:18:43 INFO - Running setup.py install for mozlog 17:18:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:18:43 INFO - Running setup.py install for moznetwork 17:18:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:18:43 INFO - Running setup.py install for mozprocess 17:18:43 INFO - Running setup.py install for mozprofile 17:18:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:18:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:18:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:18:43 INFO - Running setup.py install for mozrunner 17:18:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:18:43 INFO - Running setup.py install for mozscreenshot 17:18:43 INFO - Running setup.py install for moztest 17:18:43 INFO - Running setup.py install for mozversion 17:18:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:18:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:18:44 INFO - Cleaning up... 17:18:44 INFO - Return code: 0 17:18:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:44 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 0x1eb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21723b0>, '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 0x21732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', '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 17:18:44 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 17:18:44 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 17:18:44 INFO - Using env: {'DISPLAY': ':0', 17:18:44 INFO - 'HOME': '/home/cltbld', 17:18:44 INFO - 'LANG': 'en_US.UTF-8', 17:18:44 INFO - 'LANGUAGE': 'en_US:en', 17:18:44 INFO - 'LOGNAME': 'cltbld', 17:18:44 INFO - 'MAIL': '/var/mail/cltbld', 17:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:44 INFO - 'MOZ_NO_REMOTE': '1', 17:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:44 INFO - 'NO_EM_RESTART': '1', 17:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:44 INFO - 'PWD': '/builds/slave/test', 17:18:44 INFO - 'SHELL': '/bin/bash', 17:18:44 INFO - 'SHLVL': '1', 17:18:44 INFO - 'TERM': 'linux', 17:18:44 INFO - 'TMOUT': '86400', 17:18:44 INFO - 'USER': 'cltbld', 17:18:44 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', 17:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:44 INFO - '_': '/tools/buildbot/bin/python'} 17:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:18:44 INFO - Running setup.py (path:/tmp/pip-rtD4F1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:18:44 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)) 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:18:44 INFO - Running setup.py (path:/tmp/pip-NNisoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:18:44 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)) 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:18:44 INFO - Running setup.py (path:/tmp/pip-S1wLag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:18:44 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)) 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:18:44 INFO - Running setup.py (path:/tmp/pip-ZSjdHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:18:44 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)) 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:18:44 INFO - Running setup.py (path:/tmp/pip-T2VQF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:18:44 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)) 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:18:44 INFO - Running setup.py (path:/tmp/pip-KpulZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:18:44 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)) 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:18:44 INFO - Running setup.py (path:/tmp/pip-yy0M_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:18:44 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)) 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:18:44 INFO - Running setup.py (path:/tmp/pip-Zx2ogR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:18:44 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)) 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:18:44 INFO - Running setup.py (path:/tmp/pip-BCSS1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:18:44 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)) 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:18:44 INFO - Running setup.py (path:/tmp/pip-91Ck22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:18:45 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)) 17:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:18:45 INFO - Running setup.py (path:/tmp/pip-AasWkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:18:45 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)) 17:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:18:45 INFO - Running setup.py (path:/tmp/pip-Lw5s7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:18:45 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)) 17:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:18:45 INFO - Running setup.py (path:/tmp/pip-68LOxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:18:45 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)) 17:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:18:45 INFO - Running setup.py (path:/tmp/pip-Cif6wR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:18:45 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)) 17:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:45 INFO - Running setup.py (path:/tmp/pip-v9piQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:45 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)) 17:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:18:45 INFO - Running setup.py (path:/tmp/pip-yaRoUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:18:45 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)) 17:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:18:45 INFO - Running setup.py (path:/tmp/pip-Wr4RYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:18:45 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)) 17:18:45 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)) 17:18:45 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)) 17:18:45 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)) 17:18:45 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)) 17:18:45 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)) 17:18:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:18: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 17:18: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 17:18: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 17:18: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 17:18: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 17:18: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 17:18:47 INFO - Downloading blessings-1.6.tar.gz 17:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:18:47 INFO - Installing collected packages: blessings 17:18:47 INFO - Running setup.py install for blessings 17:18:47 INFO - Successfully installed blessings 17:18:47 INFO - Cleaning up... 17:18:47 INFO - Return code: 0 17:18:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:18:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:47 INFO - Reading from file tmpfile_stdout 17:18:47 INFO - Current package versions: 17:18:47 INFO - argparse == 1.2.1 17:18:47 INFO - blessings == 1.6 17:18:47 INFO - blobuploader == 1.2.4 17:18:47 INFO - docopt == 0.6.1 17:18:47 INFO - functools32 == 3.2.3-2 17:18:47 INFO - jsonschema == 2.5.1 17:18:47 INFO - manifestparser == 1.1 17:18:47 INFO - mozInstall == 1.12 17:18:47 INFO - mozcrash == 0.17 17:18:47 INFO - mozdebug == 0.1 17:18:47 INFO - mozdevice == 0.48 17:18:47 INFO - mozfile == 1.2 17:18:47 INFO - mozhttpd == 0.7 17:18:47 INFO - mozinfo == 0.9 17:18:47 INFO - mozleak == 0.1 17:18:47 INFO - mozlog == 3.2 17:18:47 INFO - moznetwork == 0.27 17:18:47 INFO - mozprocess == 0.23 17:18:47 INFO - mozprofile == 0.28 17:18:47 INFO - mozrunner == 6.12 17:18:47 INFO - mozscreenshot == 0.1 17:18:47 INFO - mozsystemmonitor == 0.3 17:18:47 INFO - moztest == 0.7 17:18:47 INFO - mozversion == 1.4 17:18:47 INFO - psutil == 3.1.1 17:18:47 INFO - requests == 1.2.3 17:18:47 INFO - wsgiref == 0.1.2 17:18:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:47 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 0x1eb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21723b0>, '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 0x21732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', '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 17:18:47 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 17:18:47 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 17:18:47 INFO - Using env: {'DISPLAY': ':0', 17:18:47 INFO - 'HOME': '/home/cltbld', 17:18:47 INFO - 'LANG': 'en_US.UTF-8', 17:18:47 INFO - 'LANGUAGE': 'en_US:en', 17:18:47 INFO - 'LOGNAME': 'cltbld', 17:18:47 INFO - 'MAIL': '/var/mail/cltbld', 17:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:47 INFO - 'MOZ_NO_REMOTE': '1', 17:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:47 INFO - 'NO_EM_RESTART': '1', 17:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:47 INFO - 'PWD': '/builds/slave/test', 17:18:47 INFO - 'SHELL': '/bin/bash', 17:18:47 INFO - 'SHLVL': '1', 17:18:47 INFO - 'TERM': 'linux', 17:18:47 INFO - 'TMOUT': '86400', 17:18:47 INFO - 'USER': 'cltbld', 17:18:47 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', 17:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:47 INFO - '_': '/tools/buildbot/bin/python'} 17:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:48 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)) 17:18:48 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)) 17:18:48 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)) 17:18:48 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)) 17:18:48 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)) 17:18:48 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)) 17:18:48 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)) 17:18:48 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)) 17:18:48 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)) 17:18:48 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)) 17:18:48 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)) 17:18:48 INFO - Cleaning up... 17:18:48 INFO - Return code: 0 17:18:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:18:48 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')]} 17:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:48 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')]} 17:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:48 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 0x1eb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21723b0>, '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 0x21732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', '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 17:18:48 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 17:18:48 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 17:18:48 INFO - Using env: {'DISPLAY': ':0', 17:18:48 INFO - 'HOME': '/home/cltbld', 17:18:48 INFO - 'LANG': 'en_US.UTF-8', 17:18:48 INFO - 'LANGUAGE': 'en_US:en', 17:18:48 INFO - 'LOGNAME': 'cltbld', 17:18:48 INFO - 'MAIL': '/var/mail/cltbld', 17:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:48 INFO - 'MOZ_NO_REMOTE': '1', 17:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:48 INFO - 'NO_EM_RESTART': '1', 17:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:48 INFO - 'PWD': '/builds/slave/test', 17:18:48 INFO - 'SHELL': '/bin/bash', 17:18:48 INFO - 'SHLVL': '1', 17:18:48 INFO - 'TERM': 'linux', 17:18:48 INFO - 'TMOUT': '86400', 17:18:48 INFO - 'USER': 'cltbld', 17:18:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', 17:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:48 INFO - '_': '/tools/buildbot/bin/python'} 17:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:18:48 INFO - Cleaning up... 17:18:48 INFO - Return code: 0 17:18:48 INFO - Running post-action listener: _resource_record_post_action 17:18:48 INFO - Running post-action listener: _start_resource_monitoring 17:18:48 INFO - Starting resource monitoring. 17:18:48 INFO - ##### 17:18:48 INFO - ##### Finished create-virtualenv step (success) 17:18:48 INFO - ##### 17:18:48 INFO - ##### 17:18:48 INFO - ##### Running install step. 17:18:48 INFO - ##### 17:18:48 INFO - Running pre-action listener: _resource_record_pre_action 17:18:48 INFO - Running main action method: install 17:18:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:48 INFO - Reading from file tmpfile_stdout 17:18:48 INFO - Detecting whether we're running mozinstall >=1.0... 17:18:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:18:48 INFO - Reading from file tmpfile_stdout 17:18:48 INFO - Output received: 17:18:48 INFO - Usage: mozinstall [options] installer 17:18:48 INFO - Options: 17:18:48 INFO - -h, --help show this help message and exit 17:18:48 INFO - -d DEST, --destination=DEST 17:18:48 INFO - Directory to install application into. [default: 17:18:48 INFO - "/builds/slave/test"] 17:18:48 INFO - --app=APP Application being installed. [default: firefox] 17:18:48 INFO - mkdir: /builds/slave/test/build/application 17:18:48 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'] 17:18:48 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 17:19:05 INFO - Reading from file tmpfile_stdout 17:19:05 INFO - Output received: 17:19:05 INFO - /builds/slave/test/build/application/firefox/firefox 17:19:05 INFO - Running post-action listener: _resource_record_post_action 17:19:05 INFO - ##### 17:19:05 INFO - ##### Finished install step (success) 17:19:05 INFO - ##### 17:19:05 INFO - ##### 17:19:05 INFO - ##### Running run-tests step. 17:19:05 INFO - ##### 17:19:05 INFO - Running pre-action listener: _resource_record_pre_action 17:19:05 INFO - Running main action method: run_tests 17:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:19:05 INFO - Python 2.7.3 17:19:05 INFO - Return code: 0 17:19:05 INFO - grabbing minidump binary from tooltool 17:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:05 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 0x21723b0>, '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 0x21732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2173740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:19:05 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 17:19:05 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 17:19:05 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 17:19:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:19:06 INFO - Return code: 0 17:19:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:19:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:19:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:19:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:19:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:19:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 17:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 17:19:06 INFO - Using env: {'DISPLAY': ':0', 17:19:06 INFO - 'HOME': '/home/cltbld', 17:19:06 INFO - 'LANG': 'en_US.UTF-8', 17:19:06 INFO - 'LANGUAGE': 'en_US:en', 17:19:06 INFO - 'LOGNAME': 'cltbld', 17:19:06 INFO - 'MAIL': '/var/mail/cltbld', 17:19:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:19:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:06 INFO - 'MOZ_NO_REMOTE': '1', 17:19:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:06 INFO - 'NO_EM_RESTART': '1', 17:19:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:06 INFO - 'PWD': '/builds/slave/test', 17:19:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:19:06 INFO - 'SHELL': '/bin/bash', 17:19:06 INFO - 'SHLVL': '1', 17:19:06 INFO - 'TERM': 'linux', 17:19:06 INFO - 'TMOUT': '86400', 17:19:06 INFO - 'USER': 'cltbld', 17:19:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443', 17:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:06 INFO - '_': '/tools/buildbot/bin/python'} 17:19:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 17:19:06 INFO - mozversion application_buildid: 20160713143006 17:19:06 INFO - mozversion application_changeset: 34a128489d8895e2f1ef58f43e2b4d196be6e544 17:19:06 INFO - mozversion application_display_name: Nightly 17:19:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:19:06 INFO - mozversion application_name: Firefox 17:19:06 INFO - mozversion application_remotingname: firefox 17:19:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:19:06 INFO - mozversion application_vendor: Mozilla 17:19:06 INFO - mozversion application_version: 50.0a1 17:19:06 INFO - mozversion platform_buildid: 20160713143006 17:19:06 INFO - mozversion platform_changeset: 34a128489d8895e2f1ef58f43e2b4d196be6e544 17:19:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:19:06 INFO - mozversion platform_version: 50.0a1 17:19:06 INFO - using testdate: 1468455546 17:19:06 INFO - actual date: 1468455546 17:19:06 INFO - starting webserver on 'localhost:57561' 17:19:06 INFO - SUITE-START | Running 2 tests 17:19:06 INFO - TEST-START | dromaeo_css 17:19:06 INFO - operating with platform_type : linux_ 17:19:06 INFO - Initialising browser for dromaeo_css test... 17:19:06 INFO - TEST-INFO | started process 4263 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTH4miD/profile http://localhost:57561/getInfo.html) 17:19:11 INFO - PROCESS | 4263 | __metrics Screen width/height:1600/1200 17:19:11 INFO - PROCESS | 4263 | colorDepth:24 17:19:11 INFO - PROCESS | 4263 | Browser inner width/height: 1024/697 17:19:11 INFO - PROCESS | 4263 | __metrics 17:19:11 ERROR - PROCESS | 4263 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 17:19:12 INFO - TEST-INFO | 4263: exit 0 17:19:12 INFO - Browser initialized. 17:19:12 INFO - Running cycle 1/1 for dromaeo_css test... 17:19:12 INFO - TEST-INFO | started process 4386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTH4miD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:24 INFO - PROCESS | 4386 | RSS: Main: 167424000 17:19:24 INFO - PROCESS | 4386 | 17:20:14 INFO - PROCESS | 4386 | 1468455614063 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] 17:22:21 INFO - PROCESS | 4386 | Cycle 1(1): loaded http://localhost:57561/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57561/tests/dromaeo/cssquery-ext.html) 17:22:22 INFO - PROCESS | 4386 | RSS: Main: 171503616 17:22:22 INFO - PROCESS | 4386 | 17:25:24 INFO - PROCESS | 4386 | Cycle 1(1): loaded http://localhost:57561/tests/dromaeo/cssquery-ext.html (next: http://localhost:57561/tests/dromaeo/cssquery-jquery.html) 17:25:25 INFO - PROCESS | 4386 | RSS: Main: 168562688 17:25:25 INFO - PROCESS | 4386 | 17:28:27 INFO - PROCESS | 4386 | Cycle 1(1): loaded http://localhost:57561/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57561/tests/dromaeo/cssquery-mootools.html) 17:28:27 INFO - PROCESS | 4386 | RSS: Main: 172249088 17:28:27 INFO - PROCESS | 4386 | 17:31:29 INFO - PROCESS | 4386 | Cycle 1(1): loaded http://localhost:57561/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57561/tests/dromaeo/cssquery-prototype.html) 17:31:30 INFO - PROCESS | 4386 | RSS: Main: 167124992 17:31:30 INFO - PROCESS | 4386 | 17:34:32 INFO - PROCESS | 4386 | Cycle 1(1): loaded http://localhost:57561/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57561/tests/dromaeo/cssquery-yui.html) 17:34:33 INFO - PROCESS | 4386 | RSS: Main: 169013248 17:34:33 INFO - PROCESS | 4386 | 17:37:36 INFO - PROCESS | 4386 | Cycle 1(1): loaded http://localhost:57561/tests/dromaeo/cssquery-yui.html (next: http://localhost:57561/tests/dromaeo/cssquery-dojo.html) 17:37:36 INFO - PROCESS | 4386 | RSS: Main: 170401792 17:37:36 INFO - PROCESS | 4386 | 17:37:36 INFO - PROCESS | 4386 | __start_tp_report 17:37:36 INFO - PROCESS | 4386 | _x_x_mozilla_page_load 17:37:36 INFO - PROCESS | 4386 | _x_x_mozilla_page_load_details 17:37:36 INFO - PROCESS | 4386 | |i|pagename|runs| 17:37:36 INFO - PROCESS | 4386 | |0;dojo.html;3030.2727345437092;3060.173753086668;3068.754499640029;3078.846057697115;3100.1009707184917;5325.946740532599;5339.305890234274;5370.543503802177;5422.321126984442;5470.288862447876;5378.650387724795;5379.488948549882;5414.43148469411;5426;5475.09660905951;4852.636052296074;4874.97562512187;4934.629902757308;5015.2226404907115;5028.245763135541;658.2066589904107;4784.904301913977;4794.640401969848;4899.265110233458;4950.084234416627;4820.39745031871;4825.565699087081;4836.854894353175;4850.636202284825;4879.438864530589;4845.854624361275;4856.684315519516;4865.245886887538;4870.123377791996;4900.460949295574;4800.399950006249;4801.7118972861745;4806.711597304173;4863.148948933957;4873.147199240118;5347.278117454132;5348.893022139574;5353.919691204596;5354.43778403266;5447.6731396115965;5698.800541981011;5726.0838265877255;5738.254026976467;5751.309842818847;5752.28096487939;5658.858528536778;5710.828675139753;5723.57073219506;5731.312242530923;5769.538436925036;5300.628955973083;5304.787808487656;5309.946900530984;5318.069337865858;5344.877575709067;5765.94234057654;5777.480026797609;5872.17789509469;5887.587868849225;5895.14520394549;5583.357913839879;5588.804391846266;5612.719364031782;5613.803516876889;5638.774449022075;5745.913811292834;5763.077907534775;5771.7114144293455;5775.768969241183;5789;5712.11462223356;5717.371089180187;5775.826725198251;5778.971105144531;5809.128630705343;5782.797602083907;5786.189933409326;5793.652380857162;5801.984652685763;5808.448197421239;4424.623906967944;4435.955640443619;4439.622632076245;4444.511103778582;4473.239549276631;3883.417487376916;3906.746061505993;3934.390169523728;3951.881443556698;3959.4456776051375;5419.918701219485;5427.185922111715;5444.537214336826;5463.508284254436;5487.6158668892795;5686.289213848269;5730.426957304237;5740.598158128974;5755.85610359736;5765.827025189251;5372.677639341652;5475.233467314579;5502.367227768777;5537.833864984057;5549.19536667181;4840.564349208517;4846.079244943449;4849;4852.8786780330065;4867.63492738039;5765.509931655773;6038.154658347835;6042.909356359658;6044.274687037584;6047.78832740852;5768.250127483317;5780.913286300793;5795.246617939641;5819.912701309399;5850.882982340415;5956.315023772322;5963.165156877953;5968.641881487125;5972.044472884318;6024.728887199999;5552.056150454513;5654.830355089354;5716.685582292847;5728.656280623176;5751.798687045934;5795.420457954171;5831.241938547962;5837.503812176013;5860.882782344414;5910.70446477683;5707.714614269353;5709.115087161496;5735.770569177186;5737;5738.397468265772;5479.835604931858;5566.693831839288;5599.188117722826;5702.116171993348;5706.400827913176;5502.284702988586;5515.558755299647;5555.055640541037;5557.138643510262;5606.439356064361;5634.492895639412;5635.690037048002;5643.294588176478;5659.066254068197;5669.744861481161;5348.652337598043;5545.085060964896;5547.084731019337;5556.444355564411;5622.297212848394 17:37:36 INFO - PROCESS | 4386 | |1;ext.html;552.8966768304452;584.3484514766035;601.9187409699692;612.816155153454;650.3041745332496;39001.414978775305;42572.36141457881;42621;42735;43047.35428968568;43481;43820.34269485952;43954.56045439545;43968.56031439685;44174.779126104324;8687.739367818975;8786.121387861227;8805.25155361795;8809.691660791874;8827.382083254175;8830.381873268874;8837.602307896128;8865.157810008071;8881.689140880071;8952.776180595505;8931;8937.195652391283;8967.641294348217;8971.910280897206;8977.910220897773;8939.73180804577;8939.865902011476;8958.731238062901;8966.372353935227;8981.416207946462;8719.346049046348;8800.16398442147;8804.119588041209;8825.161609647137;8865.157810008039;33299;40582.59417405818;40891;40977.38533921994;41122;3321.9169520761934;3352.6312105668358;3465.9480107798404;3466.687998080185;3489.6335884731993;31721.682783172335;31737.523937140963;32134.35731285361;32616.836915815267;33159.33681326384;4420.9336859947125;4447.755373454459;4448;4554.567316104964;4610.239310513761;371759;380116;380599;380992;381456;35269.29461410809;61245;62332.68833655803;62706.372936270964;62774.37225627777;34740.826295868865;36298.637013630054;36363.63636363656;36397.45403818945;36436.45345319822;14498.710025799635;14551.92724036373;14561.927190364193;14626.414943402146;14834.851651483346;12206.877931220752;12321.44553495077;12340.753184936431;12357.196782209128;12640.55758048464;8285.295749861209;8383.203595658402;8404.747857564284;8442.282405995436;8466.365022623328;3275.328557645677;3285.704286614216;3307.107081088093;3323.5513205717402;3330;966.246327864267;1020.6835880876952;1062.0388548363744;1089.7493576477455;1126.3804907301117;31726.2068448286;31728;32296.70813167447;32744.67255327464;33623.49564756531;1043.4939054558533;1056.8203405421098;1102.1238115698038;1134.5915470430803;1182.603827717707;16265;16795.41216057432;16896.493105206864;16988.57528561771;17061.7440738389;584683;585182;591023;592219;593570;56784.43215567874;56968.430315696314;57202;57238.42761572414;57270;1337.164272329794;1384.2179168769815;1387.5213051497217;1395.386030146732;1395.7696979998186;29714.851425743596;31635.683643163273;31865;32077.198070048435;32540.186495337806;50991.74504127455;51740.56724043921;51856.48143518517;51864.222036668725;51936;475188;480832;482183;482864;485311;27664.861675691493;27826.44347113006;27938.58092128579;27988;28011.879524818778;46534.76732616315;46945.29582056204;47908;48110.5188948106;48527;40732;40888.59111408848;41089;41906.58093419149;41908.37137443002;37864.62135378721;40582.39126413165;41422;41656.3751543721;41737.79131104325;36267.45598816073;39474.210515790095;40168;41401;43135.70592882093;34980;35979;36975.26049479049;36975.8151209253;37016;27249.455010899273;27694.584581231702;28024.85987570049;28090.157295281173;28286.15141545757 17:37:36 INFO - PROCESS | 4386 | |2;jquery.html;378.557088206798;379.78352339166685;383.69496250480864;396.57368329046284;398.2453251089186;18104.637907241864;20537;20716.27493037744;20720.067596958135;20745.585088298227;18848.434546963577;19065.714014289762;19885.204591816346;19961.800381996174;20079.498012549695;5606.691631960231;5656.604037717361;5763.049096899028;5776.566757493184;5777.711114444282;5606.6636001839815;5634.32388113427;5742.511886489653;5793.319937218202;5797.304323481167;5202.271681964528;5480.725963701799;5488.039593071217;5742.971285143569;5754.625949313281;5498;5605.215269862222;5632.831015069554;5793.391693872125;6320.968395158041;5588.888222235532;5686.744096515667;5703.144528320785;5716.314042314907;5724.856878578027;13198.076134670577;20229.393118206477;22917.541649166924;23744.525109497885;23781.7621823783;2215.656573231152;2304.8271379646426;2306.5848147333472;2684.81206315558;2979.2849716068204;9324.627014919395;9392.342536022481;9491.098345657152;9789.90210097897;9939.204863610894;1905.9237630494763;1961.5880665060354;1967.7198822934918;1977.683570628707;1987.4037788663343;86398;88684.55657721734;90628;91038.54480727554;91909;10261.02520260574;10419.687409377731;10520.473976301155;11343.319400835977;11678.766424671629;14680.41278348854;14706.926465367818;14791.038582492103;14861.479848205478;14924.92537537327;7574.977378053893;7644.770656880302;7827.608619568999;7914.841703165905;7950.801229969297;7368.263173682696;7441.739539116105;7485.663145158372;7610.695572177051;7672.65473053714;4328.372386004012;4419.138268037702;4437.445319335083;4486.327050942385;4529.569690879427;1833.1147491933848;1890.8203720646516;1892.7823300320365;1897.7627796525435;1905.6365514866272;969.2972594868804;988.8417853143462;1038.309524166436;1068.4497483795851;1110.0730889707024;19418.223271069;19452.22191112368;19732.605347893248;19768.11043503046;19790;954.7040417470606;1002.7894142230067;1010.166612544639;1083.8374243863325;1085.934843909368;10273.640422585173;10809.468466589118;10847.132229421628;10878.694556653252;12014;563044.8477576105;564562;570675;571516;571915;71396.64301678458;73081;74505.25494745091;101883.4905825481;104926;1022.9795404092025;1028.6913925822223;1033.9327943683636;1039.953202105907;1046.7487802927394;17567.297308107532;17721.291148354438;18292.45122646323;18456.81543184551;18541.258349665863;38964;45534.772326138154;46109.30836037395;46584.76707616576;46976.29535557038;61801;63220.36779632145;63436.68281658747;63724;64177;7303.379212766974;7928.722494712888;8097.635606397608;8192.713255036046;8637.956810215908;13459.259740714355;13984.580462586138;14027.50903718365;14093.647658808612;14160.858391415954;11899.940500297444;12124.818127728267;12155.574554890536;12271.386430678609;12310.569130080405;11918.582849600223;12060.155789094679;12116.333601651993;12315.876841231473;12430.627081187578;11844.881551184379;12212.57255996036;12306.384680765746;12405.565805196775;12463.688407789516;7525.774226773206;7546.358559522502;7560.9621951889885;7633.6564854580565;8003.19968003195;11315.886841131813;11510.079193664655;11859.762804744028;11915.582954596548;11971.940140299243 17:37:36 INFO - PROCESS | 4386 | |3;mootools.html;1474.3512854344087;1495.0282316494277;1592.3948899418226;1741.2512619573586;1751.4745576327098;7715.537067775937;8171.795705107375;8368.748937531876;8897.199252067305;8923.910760892397;8195.262426381625;8325.708600198994;8348.666053357874;8415.66337346507;8442.873356899636;2163.7944395282425;2197.154095673169;2202.933911982643;2206.1396055538353;2210.1490925993526;2096.6645336746124;2118.3750793515874;2224.3660556741333;2231.9107235710553;2235.675827005083;2166.945826354338;2174.1738139506965;2180.2805074325515;2198.681191227271;2199.747029091659;2120.533482633818;2153.2894144932134;2153.8276937844935;2154.8491605587537;2159.6112699714045;2122.1511395441794;2145.8819764912923;2146.9785302146934;2152.2036846366786;2154.6229409853213;8374.958125209396;8508.106648801848;8511.148885111501;8515.148485151436;8535.231829135408;5078.822241221539;5216.530512253916;5217.921731174036;5220.556252718524;5229.320188375486;3253.8535765890592;3285.392202442532;3291.5720956275773;3332;3361.6470270621476;998.241336584194;1042.0725554256717;1054.72577129946;1068.978620427595;1070.5610699613198;12195.817062744067;12215.633530994084;12238.694032649166;12240.265584064895;12243.816342754866;4318.676099292566;4350.390945267665;4513.638908887281;4518.525554816762;4532.7280363178315;10234.6417875374;10310.43292618913;10383.376997380181;10391.272610917164;10391.636292729869;5190.506901844395;5203.453637368098;5215.374155101412;5244.003639308519;5263.868403289872;4164.958350416457;4773.71357718538;4780.713157210578;4783.258594917794;4813.4945830687275;3747.475353450519;3846.1922996171115;3896.980515097406;3916.1580260244186;3926.1166237596885;1229.7724920889664;1250.5185503581006;1251.6808213905397;1257.283348491351;1271.4087949103712;974.2985050763439;976.7851072763981;987.2299606306948;987.9407235565889;1020.9229263127323;5899.321578018497;5940.198073260141;6087.538990642302;6184.103305020747;6360.681965901686;971.5919313888184;971.7764914069803;983.955721992512;998.6155330197926;1023.8310678737924;3434.5191673165778;4067.6949228807366;4079.714419990572;4097.89755256115;4184.66522678185;10153.289269751047;10434.16526677864;10799.946000269949;10930.617428390127;11010.174236932262;10546.367217966947;10724.08845248147;10865.130789536975;10923.508442120125;10944.39805810672;7902.091259505116;8055.194480551898;8110.229528194812;8175.223353781381;8231.682930731055;5934.6142500737315;6050.606710563799;6152.815415537541;6198.72105755233;6234.37656234391;9896.15882649954;9968.953259907896;10159.136473399843;10194.847077293995;10243.641472548425;9555;9940.403575785476;9955.153811925778;10148.695539133838;10239.48802559884;6906.792796216121;7450.552966822008;7651.808704782425;7771;7885.723999659985;8522.70170544028;8566.82866342682;8578.313734901318;8580.313574914117;8597.871031934652;7498.325150736242;7716.884246736191;7765.339946104418;7802.219778022152;7802.570858602831;7455.440841936768;7598.886016709865;7628.580428076287;7659.731909383368;7837.608119593883;6612.570182938093;6652.800415987528;6658.600483970978;6671.566348187353;6674.966625166843;4695.5304469552775;4845.612351011981;4901.270274185428;4925.950740492693;5032.119379108714;4909.852704418873;4920.089783390084;4973.850784476472;5062.190049592047;5063.13926632466 17:37:36 INFO - PROCESS | 4386 | |4;prototype.html;319.3150691766162;319.6643524299485;321.1345424082099;326.59502217250616;332.199399447332;5735.741891614877;5750.453706897843;5757.395473475288;5773.249477567921;5823.126531020349;5608.158776183574;5627.971860140704;5633.436656334365;5646.802361917334;5649.4633009864;4020.6381425671684;4285.742855428669;4417.5361587033385;4436.645068394529;4439.64482841372;4242.448481697375;4246.40550322955;4256.148770245948;4282.008865877367;4310.762908040057;4238.131183107471;4265.936010959838;4286.978565107186;4293.377460268259;4312.568743125694;4139.586041395852;4280.743155410685;4327;4338.655016944757;4352.173087113439;3773.509443772292;3777.697784177259;3782.56500502443;3796.1268908151005;3798.90502737431;5520.944790552083;5538.6399884007815;5547.44525547446;5557.638753481011;5586.301712285965;4849.175640141149;4921.384826896638;4943.530364615356;4952.306677065214;5008.923081537487;5859.648421094748;5865.149553314745;5868.442497962729;5882.176495290662;5884.116782776451;4062.3500239961463;4088.3867419886956;4105.2405305018365;4127.823570282455;4128.584777904929;5899.3718862899;6057.242844644419;6145.293291271471;6148.247749391447;6163.630182189083;4221.662267018631;4229.703920725519;4234.809433575497;4235.449391579075;4244.724092934011;4262.744235345827;4283.914321713548;4292.227399068198;4324.113556720865;4328.28583283761;4815.542523460265;4933.975330123327;4972.7513624318635;4989.850304490871;5002.674826136289;5858;5863.501602363762;5894;5927.288725352899;5938.921377517834;1474.8820094392422;1486.6357742353193;1490.6720521485256;1491.403438624537;1494.1632685695827;931.7577429868284;946.711253067821;985.788055568042;990.1830989433746;1002.0880998291519;5621.943780562224;5667.688277144796;5689.719813042032;5703.62926409782;5728.369879313273;5986.670733109634;5994.310654274727;5999.1901093351835;6014.669193194416;6085.57400981927;5501.4223506532035;5626.409227031185;5745.1669507921115;5749.88500229993;5785.82642520725;3210.727088197529;3236.8705251790134;3241.4165450218716;3281.310924705791;3288.835558222127;6055.545834062463;6220.62676239418;6226.813195604049;6242.813865365566;6288.9056664150075;6173.351798061229;6197.287311959092;6222.191115155001;6227.813165605039;6238.937610623926;6204.255489341308;6234.532410069263;6262.405071518289;6275.6862156891975;6295.5907865988565;5828.184054232495;6032.336442991355;6081.209442772411;6090.294717479113;6097.817065488042;6011.609245399035;6048.455638992512;6071.392860713893;6084.239470066242;6086.60437071589;6022.36765139654;6230.7507699691505;6246.750129994749;6261.718222680081;6312.3056463788025;4097.405876148002;4137.54487006423;4145.2124096421585;4146.564610715952;4149.439825623502;6066.545009124422;6096.055111457731;6142;6143.600665956698;6144.723487443165;5733.799317024051;5915.674637894957;5919.437653422918;5929.555283353679;5944.346121926498;5945;5961.52307815365;5967.985442474703;5970.611910225822;5970.805838832164;5620.3536593290655;5824.3593204748295;5843.444872737083;5854.443827836349;5908.434264919713;5984.31180414258;6040.278520621602;6044.365341639241;6053.303870054824;6058.818235452944;5858.94141058584;5897.882042359043;5902.203202567598;5934.991051521338;5943.435373639497 17:37:36 INFO - PROCESS | 4386 | |5;yui.html;770.5569297653849;796.9083555391129;808.5068108453846;837.3468694418356;847.3771777743353;14436.783448248285;15497.69004619907;15518.84481155188;15520.301586428595;15524.689506209883;13918.51285205018;14009.579712608613;14020.43918243269;14026.088304260242;14026.789598156036;641.4323323858396;743.6727839750492;764.9885251721229;766.9156392796788;770.8766597344426;785.132428666324;788.9723859664913;789.2738680414004;789.4118881433341;790.5770412829138;826.0582935453588;827.3877330775243;830.7881490220016;833.4249367936135;837.0165056059136;820.0487434575894;824.3652387661527;827.9047909490365;828.0932379044937;829.1169904052196;608.0605464557269;608.084832327349;608.2913405882186;608.7838817219912;608.8964875971095;13593.864061359458;13601.251931143783;13669.179849209078;13673.794893076612;13703.794443083361;13845.861541384658;14805.481808136772;14954.551363459113;15142.848571514254;15171.862110341659;12150.149489535735;12265.570705025371;12311.569095081719;12362.134650574464;12729.745405091846;3915.1386694927355;3967.404889266604;4030.3954406838916;4044.635982761536;4113.362428823537;70404.2959570408;71446.64276678635;71569;71763.64118179376;75249.62375188089;10943.83584246237;10976.615818446317;11153.832692509619;11256;11581.710457238636;21784.45538861541;21813.454663633536;21855.890720546613;21889.233876814236;22049.448763781034;8005.119436861941;8156.143604921516;8184.386171037077;8321.583920803936;8403.915960840435;4843.128236917319;4941.629377796679;5014.07239660664;5033.47148549397;5068.543831055149;3585.964140358563;3676.0442285006093;3678.889633311005;3701.592824789271;3703.7407381483035;612.7365232949875;620.9161763162006;625.0405627361978;628.4972022382167;631.4317114596807;571.6941436331542;593.5874567175771;610.2890132995011;624.2384291164863;662.0268205737558;9156.8626470603;9306.302027347976;9496.382735122195;9559.583432705236;9642.614295428104;608.3156448994881;738.7008261654039;739.4897520710692;748.2497010474412;761.6268028665913;4390.407295015196;4539.182947069559;4682.555157260055;4697.929531057037;4710.411198600175;118816.40591796985;125261;125268;127980.36009820078;128835;60930.0860487093;61799.69100154471;105502.4724876386;106683.46658266814;109757;56021;57086.42913570894;72813;89226.9999999987;91823;8864.512451815212;8992.261940283808;9030;9032.774180645274;9138.908610913806;50941.490585095155;52916.73541632267;54466.727666363;54537.72731136319;54622;47661.5233847671;47705;48307;48429;50248.74875625598;12275.631731048083;12281.192271206608;12379.319137447526;12458.439370228543;12530.997520198545;13800.585982420544;13965.51120710811;14218.573442796733;14222.715545689236;15070.09579425238;13485.932570337085;13557.59327220185;13874.791878122038;14165.150090994573;14656.413743450143;12609.558665447032;12800.423980920694;12873;12986.675333116747;13096.607101786962;13713.451461941411;13803.447862085404;13853.099548529313;13958.58124256274;14018.579442616738;10674.73313167177;10871.184661150604;10886.40124793144;11063.280886742335;11108.166887483632;11557.422128893353;11977.461014254553;12085.413449670126;12154;12183.269003859798 17:37:36 INFO - PROCESS | 4386 | __end_tp_report 17:37:36 INFO - PROCESS | 4386 | __start_cc_report 17:37:36 INFO - PROCESS | 4386 | _x_x_mozilla_cycle_collect,369 17:37:36 INFO - PROCESS | 4386 | __end_cc_report 17:37:36 INFO - PROCESS | 4386 | __startTimestamp1468456656410__endTimestamp 17:37:36 INFO - PROCESS | 4386 | 17:37:36 INFO - PROCESS | 4386 | ------- Summary: start ------- 17:37:36 INFO - PROCESS | 4386 | Number of tests: 6 17:37:36 INFO - PROCESS | 4386 | 17:37:36 INFO - PROCESS | 4386 | [#0] dojo.html Cycles:165 Average:5318.77 Median:5556.44 stddev:717.99 (12.9%) stddev-sans-first:697.39 17:37:36 INFO - PROCESS | 4386 | Values: 3030.3 3060.2 3068.8 3078.8 3100.1 5325.9 5339.3 5370.5 5422.3 5470.3 5378.7 5379.5 5414.4 5426.0 5475.1 4852.6 4875.0 4934.6 5015.2 5028.2 658.2 4784.9 4794.6 4899.3 4950.1 4820.4 4825.6 4836.9 4850.6 4879.4 4845.9 4856.7 4865.2 4870.1 4900.5 4800.4 4801.7 4806.7 4863.1 4873.1 5347.3 5348.9 5353.9 5354.4 5447.7 5698.8 5726.1 5738.3 5751.3 5752.3 5658.9 5710.8 5723.6 5731.3 5769.5 5300.6 5304.8 5309.9 5318.1 5344.9 5765.9 5777.5 5872.2 5887.6 5895.1 5583.4 5588.8 5612.7 5613.8 5638.8 5745.9 5763.1 5771.7 5775.8 5789.0 5712.1 5717.4 5775.8 5779.0 5809.1 5782.8 5786.2 5793.7 5802.0 5808.4 4424.6 4436.0 4439.6 4444.5 4473.2 3883.4 3906.7 3934.4 3951.9 3959.4 5419.9 5427.2 5444.5 5463.5 5487.6 5686.3 5730.4 5740.6 5755.9 5765.8 5372.7 5475.2 5502.4 5537.8 5549.2 4840.6 4846.1 4849.0 4852.9 4867.6 5765.5 6038.2 6042.9 6044.3 6047.8 5768.3 5780.9 5795.2 5819.9 5850.9 5956.3 5963.2 5968.6 5972.0 6024.7 5552.1 5654.8 5716.7 5728.7 5751.8 5795.4 5831.2 5837.5 5860.9 5910.7 5707.7 5709.1 5735.8 5737.0 5738.4 5479.8 5566.7 5599.2 5702.1 5706.4 5502.3 5515.6 5555.1 5557.1 5606.4 5634.5 5635.7 5643.3 5659.1 5669.7 5348.7 5545.1 5547.1 5556.4 5622.3 17:37:36 INFO - PROCESS | 4386 | 17:37:36 INFO - PROCESS | 4386 | [#1] ext.html Cycles:180 Average:62402.84 Median:40934.19 stddev:130814.45 (319.6%) stddev-sans-first:131099.00 17:37:36 INFO - PROCESS | 4386 | Values: 552.9 584.3 601.9 612.8 650.3 39001.4 42572.4 42621.0 42735.0 43047.4 43481.0 43820.3 43954.6 43968.6 44174.8 8687.7 8786.1 8805.3 8809.7 8827.4 8830.4 8837.6 8865.2 8881.7 8952.8 8931.0 8937.2 8967.6 8971.9 8977.9 8939.7 8939.9 8958.7 8966.4 8981.4 8719.3 8800.2 8804.1 8825.2 8865.2 33299.0 40582.6 40891.0 40977.4 41122.0 3321.9 3352.6 3465.9 3466.7 3489.6 31721.7 31737.5 32134.4 32616.8 33159.3 4420.9 4447.8 4448.0 4554.6 4610.2 371759.0 380116.0 380599.0 380992.0 381456.0 35269.3 61245.0 62332.7 62706.4 62774.4 34740.8 36298.6 36363.6 36397.5 36436.5 14498.7 14551.9 14561.9 14626.4 14834.9 12206.9 12321.4 12340.8 12357.2 12640.6 8285.3 8383.2 8404.7 8442.3 8466.4 3275.3 3285.7 3307.1 3323.6 3330.0 966.2 1020.7 1062.0 1089.7 1126.4 31726.2 31728.0 32296.7 32744.7 33623.5 1043.5 1056.8 1102.1 1134.6 1182.6 16265.0 16795.4 16896.5 16988.6 17061.7 584683.0 585182.0 591023.0 592219.0 593570.0 56784.4 56968.4 57202.0 57238.4 57270.0 1337.2 1384.2 1387.5 1395.4 1395.8 29714.9 31635.7 31865.0 32077.2 32540.2 50991.7 51740.6 51856.5 51864.2 51936.0 475188.0 480832.0 482183.0 482864.0 485311.0 27664.9 27826.4 27938.6 27988.0 28011.9 46534.8 46945.3 47908.0 48110.5 48527.0 40732.0 40888.6 41089.0 41906.6 41908.4 37864.6 40582.4 41422.0 41656.4 41737.8 36267.5 39474.2 40168.0 41401.0 43135.7 34980.0 35979.0 36975.3 36975.8 37016.0 27249.5 27694.6 28024.9 28090.2 28286.2 17:37:36 INFO - PROCESS | 4386 | 17:37:36 INFO - PROCESS | 4386 | [#2] jquery.html Cycles:180 Average:31435.56 Median:23763.14 stddev:93462.99 (393.3%) stddev-sans-first:93696.08 17:37:36 INFO - PROCESS | 4386 | Values: 378.6 379.8 383.7 396.6 398.2 18104.6 20537.0 20716.3 20720.1 20745.6 18848.4 19065.7 19885.2 19961.8 20079.5 5606.7 5656.6 5763.0 5776.6 5777.7 5606.7 5634.3 5742.5 5793.3 5797.3 5202.3 5480.7 5488.0 5743.0 5754.6 5498.0 5605.2 5632.8 5793.4 6321.0 5588.9 5686.7 5703.1 5716.3 5724.9 13198.1 20229.4 22917.5 23744.5 23781.8 2215.7 2304.8 2306.6 2684.8 2979.3 9324.6 9392.3 9491.1 9789.9 9939.2 1905.9 1961.6 1967.7 1977.7 1987.4 86398.0 88684.6 90628.0 91038.5 91909.0 10261.0 10419.7 10520.5 11343.3 11678.8 14680.4 14706.9 14791.0 14861.5 14924.9 7575.0 7644.8 7827.6 7914.8 7950.8 7368.3 7441.7 7485.7 7610.7 7672.7 4328.4 4419.1 4437.4 4486.3 4529.6 1833.1 1890.8 1892.8 1897.8 1905.6 969.3 988.8 1038.3 1068.4 1110.1 19418.2 19452.2 19732.6 19768.1 19790.0 954.7 1002.8 1010.2 1083.8 1085.9 10273.6 10809.5 10847.1 10878.7 12014.0 563044.8 564562.0 570675.0 571516.0 571915.0 71396.6 73081.0 74505.3 101883.5 104926.0 1023.0 1028.7 1033.9 1040.0 1046.7 17567.3 17721.3 18292.5 18456.8 18541.3 38964.0 45534.8 46109.3 46584.8 46976.3 61801.0 63220.4 63436.7 63724.0 64177.0 7303.4 7928.7 8097.6 8192.7 8638.0 13459.3 13984.6 14027.5 14093.6 14160.9 11899.9 12124.8 12155.6 12271.4 12310.6 11918.6 12060.2 12116.3 12315.9 12430.6 11844.9 12212.6 12306.4 12405.6 12463.7 7525.8 7546.4 7561.0 7633.7 8003.2 11315.9 11510.1 11859.8 11915.6 11971.9 17:37:36 INFO - PROCESS | 4386 | 17:37:36 INFO - PROCESS | 4386 | [#3] mootools.html Cycles:180 Average:5695.52 Median:4798.38 stddev:3270.32 (68.2%) stddev-sans-first:3264.11 17:37:36 INFO - PROCESS | 4386 | Values: 1474.4 1495.0 1592.4 1741.3 1751.5 7715.5 8171.8 8368.7 8897.2 8923.9 8195.3 8325.7 8348.7 8415.7 8442.9 2163.8 2197.2 2202.9 2206.1 2210.1 2096.7 2118.4 2224.4 2231.9 2235.7 2166.9 2174.2 2180.3 2198.7 2199.7 2120.5 2153.3 2153.8 2154.8 2159.6 2122.2 2145.9 2147.0 2152.2 2154.6 8375.0 8508.1 8511.1 8515.1 8535.2 5078.8 5216.5 5217.9 5220.6 5229.3 3253.9 3285.4 3291.6 3332.0 3361.6 998.2 1042.1 1054.7 1069.0 1070.6 12195.8 12215.6 12238.7 12240.3 12243.8 4318.7 4350.4 4513.6 4518.5 4532.7 10234.6 10310.4 10383.4 10391.3 10391.6 5190.5 5203.5 5215.4 5244.0 5263.9 4165.0 4773.7 4780.7 4783.3 4813.5 3747.5 3846.2 3897.0 3916.2 3926.1 1229.8 1250.5 1251.7 1257.3 1271.4 974.3 976.8 987.2 987.9 1020.9 5899.3 5940.2 6087.5 6184.1 6360.7 971.6 971.8 984.0 998.6 1023.8 3434.5 4067.7 4079.7 4097.9 4184.7 10153.3 10434.2 10799.9 10930.6 11010.2 10546.4 10724.1 10865.1 10923.5 10944.4 7902.1 8055.2 8110.2 8175.2 8231.7 5934.6 6050.6 6152.8 6198.7 6234.4 9896.2 9969.0 10159.1 10194.8 10243.6 9555.0 9940.4 9955.2 10148.7 10239.5 6906.8 7450.6 7651.8 7771.0 7885.7 8522.7 8566.8 8578.3 8580.3 8597.9 7498.3 7716.9 7765.3 7802.2 7802.6 7455.4 7598.9 7628.6 7659.7 7837.6 6612.6 6652.8 6658.6 6671.6 6675.0 4695.5 4845.6 4901.3 4926.0 5032.1 4909.9 4920.1 4973.9 5062.2 5063.1 17:37:36 INFO - PROCESS | 4386 | 17:37:36 INFO - PROCESS | 4386 | [#4] prototype.html Cycles:180 Average:4958.43 Median:5740.45 stddev:1488.82 (25.9%) stddev-sans-first:1451.71 17:37:36 INFO - PROCESS | 4386 | Values: 319.3 319.7 321.1 326.6 332.2 5735.7 5750.5 5757.4 5773.2 5823.1 5608.2 5628.0 5633.4 5646.8 5649.5 4020.6 4285.7 4417.5 4436.6 4439.6 4242.4 4246.4 4256.1 4282.0 4310.8 4238.1 4265.9 4287.0 4293.4 4312.6 4139.6 4280.7 4327.0 4338.7 4352.2 3773.5 3777.7 3782.6 3796.1 3798.9 5520.9 5538.6 5547.4 5557.6 5586.3 4849.2 4921.4 4943.5 4952.3 5008.9 5859.6 5865.1 5868.4 5882.2 5884.1 4062.4 4088.4 4105.2 4127.8 4128.6 5899.4 6057.2 6145.3 6148.2 6163.6 4221.7 4229.7 4234.8 4235.4 4244.7 4262.7 4283.9 4292.2 4324.1 4328.3 4815.5 4934.0 4972.8 4989.9 5002.7 5858.0 5863.5 5894.0 5927.3 5938.9 1474.9 1486.6 1490.7 1491.4 1494.2 931.8 946.7 985.8 990.2 1002.1 5621.9 5667.7 5689.7 5703.6 5728.4 5986.7 5994.3 5999.2 6014.7 6085.6 5501.4 5626.4 5745.2 5749.9 5785.8 3210.7 3236.9 3241.4 3281.3 3288.8 6055.5 6220.6 6226.8 6242.8 6288.9 6173.4 6197.3 6222.2 6227.8 6238.9 6204.3 6234.5 6262.4 6275.7 6295.6 5828.2 6032.3 6081.2 6090.3 6097.8 6011.6 6048.5 6071.4 6084.2 6086.6 6022.4 6230.8 6246.8 6261.7 6312.3 4097.4 4137.5 4145.2 4146.6 4149.4 6066.5 6096.1 6142.0 6143.6 6144.7 5733.8 5915.7 5919.4 5929.6 5944.3 5945.0 5961.5 5968.0 5970.6 5970.8 5620.4 5824.4 5843.4 5854.4 5908.4 5984.3 6040.3 6044.4 6053.3 6058.8 5858.9 5897.9 5902.2 5935.0 5943.4 17:37:36 INFO - PROCESS | 4386 | 17:37:36 INFO - PROCESS | 4386 | [#5] yui.html Cycles:180 Average:19597.23 Median:4690.24 stddev:28658.29 (611.0%) stddev-sans-first:28703.82 17:37:36 INFO - PROCESS | 4386 | Values: 770.6 796.9 808.5 837.3 847.4 14436.8 15497.7 15518.8 15520.3 15524.7 13918.5 14009.6 14020.4 14026.1 14026.8 641.4 743.7 765.0 766.9 770.9 785.1 789.0 789.3 789.4 790.6 826.1 827.4 830.8 833.4 837.0 820.0 824.4 827.9 828.1 829.1 608.1 608.1 608.3 608.8 608.9 13593.9 13601.3 13669.2 13673.8 13703.8 13845.9 14805.5 14954.6 15142.8 15171.9 12150.1 12265.6 12311.6 12362.1 12729.7 3915.1 3967.4 4030.4 4044.6 4113.4 70404.3 71446.6 71569.0 71763.6 75249.6 10943.8 10976.6 11153.8 11256.0 11581.7 21784.5 21813.5 21855.9 21889.2 22049.4 8005.1 8156.1 8184.4 8321.6 8403.9 4843.1 4941.6 5014.1 5033.5 5068.5 3586.0 3676.0 3678.9 3701.6 3703.7 612.7 620.9 625.0 628.5 631.4 571.7 593.6 610.3 624.2 662.0 9156.9 9306.3 9496.4 9559.6 9642.6 608.3 738.7 739.5 748.2 761.6 4390.4 4539.2 4682.6 4697.9 4710.4 118816.4 125261.0 125268.0 127980.4 128835.0 60930.1 61799.7 105502.5 106683.5 109757.0 56021.0 57086.4 72813.0 89227.0 91823.0 8864.5 8992.3 9030.0 9032.8 9138.9 50941.5 52916.7 54466.7 54537.7 54622.0 47661.5 47705.0 48307.0 48429.0 50248.7 12275.6 12281.2 12379.3 12458.4 12531.0 13800.6 13965.5 14218.6 14222.7 15070.1 13485.9 13557.6 13874.8 14165.2 14656.4 12609.6 12800.4 12873.0 12986.7 13096.6 13713.5 13803.4 13853.1 13958.6 14018.6 10674.7 10871.2 10886.4 11063.3 11108.2 11557.4 11977.5 12085.4 12154.0 12183.3 17:37:36 INFO - PROCESS | 4386 | -------- Summary: end -------- 17:37:36 INFO - PROCESS | 4386 | 17:37:37 INFO - TEST-INFO | 4386: exit 0 17:37:37 INFO - TEST-OK | dromaeo_css | took 1110972ms 17:37:37 INFO - TEST-START | kraken 17:37:37 INFO - operating with platform_type : linux_ 17:37:37 INFO - Initialising browser for kraken test... 17:37:37 INFO - TEST-INFO | started process 4633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGfoCYk/profile http://localhost:57561/getInfo.html) 17:37:41 INFO - PROCESS | 4633 | __metrics Screen width/height:1600/1200 17:37:41 INFO - PROCESS | 4633 | colorDepth:24 17:37:41 INFO - PROCESS | 4633 | Browser inner width/height: 1024/697 17:37:41 INFO - PROCESS | 4633 | __metrics 17:37:42 ERROR - PROCESS | 4633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 17:37:43 INFO - TEST-INFO | 4633: exit 0 17:37:43 INFO - Browser initialized. 17:37:43 INFO - Running cycle 1/1 for kraken test... 17:37:43 INFO - TEST-INFO | started process 4754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGfoCYk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:55 INFO - PROCESS | 4754 | RSS: Main: 167600128 17:37:55 INFO - PROCESS | 4754 | 17:37:57 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:57561/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57561/tests/kraken/driver.html?testName=audio-beat-detection) 17:37:58 INFO - PROCESS | 4754 | RSS: Main: 173363200 17:37:58 INFO - PROCESS | 4754 | 17:38:01 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:57561/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57561/tests/kraken/driver.html?testName=audio-dft) 17:38:01 INFO - PROCESS | 4754 | RSS: Main: 172343296 17:38:01 INFO - PROCESS | 4754 | 17:38:04 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:57561/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57561/tests/kraken/driver.html?testName=audio-fft) 17:38:05 INFO - PROCESS | 4754 | RSS: Main: 166875136 17:38:05 INFO - PROCESS | 4754 | 17:38:07 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:57561/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57561/tests/kraken/driver.html?testName=audio-oscillator) 17:38:08 INFO - PROCESS | 4754 | RSS: Main: 168124416 17:38:08 INFO - PROCESS | 4754 | 17:38:10 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:57561/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57561/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:38:10 INFO - PROCESS | 4754 | RSS: Main: 168534016 17:38:10 INFO - PROCESS | 4754 | 17:38:14 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:57561/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57561/tests/kraken/driver.html?testName=imaging-darkroom) 17:38:14 INFO - PROCESS | 4754 | RSS: Main: 168103936 17:38:14 INFO - PROCESS | 4754 | 17:38:18 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:57561/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57561/tests/kraken/driver.html?testName=imaging-desaturate) 17:38:18 INFO - PROCESS | 4754 | RSS: Main: 166060032 17:38:18 INFO - PROCESS | 4754 | 17:38:21 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:57561/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57561/tests/kraken/driver.html?testName=json-parse-financial) 17:38:22 INFO - PROCESS | 4754 | RSS: Main: 167809024 17:38:22 INFO - PROCESS | 4754 | 17:38:23 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:57561/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57561/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:38:24 INFO - PROCESS | 4754 | RSS: Main: 168284160 17:38:24 INFO - PROCESS | 4754 | 17:38:26 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:57561/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57561/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:38:26 INFO - PROCESS | 4754 | RSS: Main: 168525824 17:38:26 INFO - PROCESS | 4754 | 17:38:28 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:57561/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57561/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:38:29 INFO - PROCESS | 4754 | RSS: Main: 168869888 17:38:29 INFO - PROCESS | 4754 | 17:38:32 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:57561/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:38:32 INFO - PROCESS | 4754 | RSS: Main: 169242624 17:38:32 INFO - PROCESS | 4754 | 17:38:35 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:57561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:38:36 INFO - PROCESS | 4754 | RSS: Main: 169349120 17:38:36 INFO - PROCESS | 4754 | 17:38:37 INFO - PROCESS | 4754 | Cycle 1(1): loaded http://localhost:57561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57561/tests/kraken/driver.html?testName=ai-astar) 17:38:38 INFO - PROCESS | 4754 | RSS: Main: 169828352 17:38:38 INFO - PROCESS | 4754 | 17:38:38 INFO - PROCESS | 4754 | __start_tp_report 17:38:38 INFO - PROCESS | 4754 | _x_x_mozilla_page_load 17:38:38 INFO - PROCESS | 4754 | _x_x_mozilla_page_load_details 17:38:38 INFO - PROCESS | 4754 | |i|pagename|runs| 17:38:38 INFO - PROCESS | 4754 | |0;ai-astar;102;112;108;112;113;114;119;111;114;113 17:38:38 INFO - PROCESS | 4754 | |1;audio-beat-detection;148;121;148;173;119;161;150;125;184;120 17:38:38 INFO - PROCESS | 4754 | |2;audio-dft;163;172;162;162;161;168;171;169;161;163 17:38:38 INFO - PROCESS | 4754 | |3;audio-fft;74;75;76;167;76;75;76;77;176;79 17:38:38 INFO - PROCESS | 4754 | |4;audio-oscillator;84;85;144;84;85;84;144;84;84;139 17:38:38 INFO - PROCESS | 4754 | |5;imaging-gaussian-blur;117;117;118;117;117;117;118;117;118;119 17:38:38 INFO - PROCESS | 4754 | |6;imaging-darkroom;147;147;147;151;148;147;148;148;147;146 17:38:38 INFO - PROCESS | 4754 | |7;imaging-desaturate;95;97;96;96;95;96;96;97;95;95 17:38:38 INFO - PROCESS | 4754 | |8;json-parse-financial;53;55;54;53;53;56;54;53;53;54 17:38:38 INFO - PROCESS | 4754 | |9;json-stringify-tinderbox;62;63;63;62;62;62;63;62;62;62 17:38:38 INFO - PROCESS | 4754 | |10;stanford-crypto-aes;79;81;76;75;76;76;76;81;81;77 17:38:38 INFO - PROCESS | 4754 | |11;stanford-crypto-ccm;120;137;142;119;130;125;124;129;164;136 17:38:38 INFO - PROCESS | 4754 | |12;stanford-crypto-pbkdf2;160;160;161;160;157;162;156;156;157;156 17:38:38 INFO - PROCESS | 4754 | |13;stanford-crypto-sha256-iterative;65;65;73;65;65;63;67;63;62;67 17:38:38 INFO - PROCESS | 4754 | __end_tp_report 17:38:38 INFO - PROCESS | 4754 | __start_cc_report 17:38:38 INFO - PROCESS | 4754 | _x_x_mozilla_cycle_collect,912 17:38:38 INFO - PROCESS | 4754 | __end_cc_report 17:38:38 INFO - PROCESS | 4754 | __startTimestamp1468456718075__endTimestamp 17:38:38 INFO - PROCESS | 4754 | 17:38:38 INFO - PROCESS | 4754 | ------- Summary: start ------- 17:38:38 INFO - PROCESS | 4754 | Number of tests: 14 17:38:38 INFO - PROCESS | 4754 | 17:38:38 INFO - PROCESS | 4754 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:4.42 (3.9%) stddev-sans-first:2.93 17:38:38 INFO - PROCESS | 4754 | Values: 102.0 112.0 108.0 112.0 113.0 114.0 119.0 111.0 114.0 113.0 17:38:38 INFO - PROCESS | 4754 | 17:38:38 INFO - PROCESS | 4754 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:149.00 stddev:23.29 (15.6%) stddev-sans-first:24.67 17:38:38 INFO - PROCESS | 4754 | Values: 148.0 121.0 148.0 173.0 119.0 161.0 150.0 125.0 184.0 120.0 17:38:38 INFO - PROCESS | 4754 | 17:38:38 INFO - PROCESS | 4754 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.50 stddev:4.32 (2.6%) stddev-sans-first:4.50 17:38:38 INFO - PROCESS | 4754 | Values: 163.0 172.0 162.0 162.0 161.0 168.0 171.0 169.0 161.0 163.0 17:38:38 INFO - PROCESS | 4754 | 17:38:38 INFO - PROCESS | 4754 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.00 stddev:40.34 (53.1%) stddev-sans-first:42.06 17:38:38 INFO - PROCESS | 4754 | Values: 74.0 75.0 76.0 167.0 76.0 75.0 76.0 77.0 176.0 79.0 17:38:38 INFO - PROCESS | 4754 | 17:38:38 INFO - PROCESS | 4754 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:84.00 stddev:28.08 (33.4%) stddev-sans-first:29.04 17:38:38 INFO - PROCESS | 4754 | Values: 84.0 85.0 144.0 84.0 85.0 84.0 144.0 84.0 84.0 139.0 17:38:38 INFO - PROCESS | 4754 | 17:38:38 INFO - PROCESS | 4754 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 17:38:38 INFO - PROCESS | 4754 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 119.0 17:38:38 INFO - PROCESS | 4754 | 17:38:38 INFO - PROCESS | 4754 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.35 (0.9%) stddev-sans-first:1.41 17:38:38 INFO - PROCESS | 4754 | Values: 147.0 147.0 147.0 151.0 148.0 147.0 148.0 148.0 147.0 146.0 17:38:38 INFO - PROCESS | 4754 | 17:38:38 INFO - PROCESS | 4754 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 17:38:38 INFO - PROCESS | 4754 | Values: 95.0 97.0 96.0 96.0 95.0 96.0 96.0 97.0 95.0 95.0 17:38:38 INFO - PROCESS | 4754 | 17:38:38 INFO - PROCESS | 4754 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.03 (1.9%) stddev-sans-first:1.05 17:38:38 INFO - PROCESS | 4754 | Values: 53.0 55.0 54.0 53.0 53.0 56.0 54.0 53.0 53.0 54.0 17:38:38 INFO - PROCESS | 4754 | 17:38:38 INFO - PROCESS | 4754 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 17:38:38 INFO - PROCESS | 4754 | Values: 62.0 63.0 63.0 62.0 62.0 62.0 63.0 62.0 62.0 62.0 17:38:38 INFO - PROCESS | 4754 | 17:38:38 INFO - PROCESS | 4754 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:78.00 stddev:2.44 (3.1%) stddev-sans-first:2.55 17:38:38 INFO - PROCESS | 4754 | Values: 79.0 81.0 76.0 75.0 76.0 76.0 76.0 81.0 81.0 77.0 17:38:38 INFO - PROCESS | 4754 | 17:38:38 INFO - PROCESS | 4754 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:133.00 stddev:13.33 (10.0%) stddev-sans-first:13.34 17:38:38 INFO - PROCESS | 4754 | Values: 120.0 137.0 142.0 119.0 130.0 125.0 124.0 129.0 164.0 136.0 17:38:38 INFO - PROCESS | 4754 | 17:38:38 INFO - PROCESS | 4754 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.50 Median:160.00 stddev:2.32 (1.5%) stddev-sans-first:2.40 17:38:38 INFO - PROCESS | 4754 | Values: 160.0 160.0 161.0 160.0 157.0 162.0 156.0 156.0 157.0 156.0 17:38:38 INFO - PROCESS | 4754 | 17:38:38 INFO - PROCESS | 4754 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.00 stddev:3.10 (4.8%) stddev-sans-first:3.28 17:38:38 INFO - PROCESS | 4754 | Values: 65.0 65.0 73.0 65.0 65.0 63.0 67.0 63.0 62.0 67.0 17:38:38 INFO - PROCESS | 4754 | -------- Summary: end -------- 17:38:38 INFO - PROCESS | 4754 | 17:38:39 INFO - TEST-INFO | 4754: exit 0 17:38:39 INFO - TEST-OK | kraken | took 61888ms 17:38:39 INFO - SUITE-END | took 1172s 17:38:39 INFO - Completed test suite (00:19:33) 17:38:39 INFO - javascript benchmark 17:38:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7190.871954927959, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3030.2727345437092, 3060.173753086668, 3068.754499640029, 3078.846057697115, 3100.1009707184917, 5325.946740532599, 5339.305890234274, 5370.543503802177, 5422.321126984442, 5470.288862447876, 5378.650387724795, 5379.488948549882, 5414.43148469411, 5426.0, 5475.09660905951, 4852.636052296074, 4874.97562512187, 4934.629902757308, 5015.2226404907115, 5028.245763135541, 658.2066589904107, 4784.904301913977, 4794.640401969848, 4899.265110233458, 4950.084234416627, 4820.39745031871, 4825.565699087081, 4836.854894353175, 4850.636202284825, 4879.438864530589, 4845.854624361275, 4856.684315519516, 4865.245886887538, 4870.123377791996, 4900.460949295574, 4800.399950006249, 4801.7118972861745, 4806.711597304173, 4863.148948933957, 4873.147199240118, 5347.278117454132, 5348.893022139574, 5353.919691204596, 5354.43778403266, 5447.6731396115965, 5698.800541981011, 5726.0838265877255, 5738.254026976467, 5751.309842818847, 5752.28096487939, 5658.858528536778, 5710.828675139753, 5723.57073219506, 5731.312242530923, 5769.538436925036, 5300.628955973083, 5304.787808487656, 5309.946900530984, 5318.069337865858, 5344.877575709067, 5765.94234057654, 5777.480026797609, 5872.17789509469, 5887.587868849225, 5895.14520394549, 5583.357913839879, 5588.804391846266, 5612.719364031782, 5613.803516876889, 5638.774449022075, 5745.913811292834, 5763.077907534775, 5771.7114144293455, 5775.768969241183, 5789.0, 5712.11462223356, 5717.371089180187, 5775.826725198251, 5778.971105144531, 5809.128630705343, 5782.797602083907, 5786.189933409326, 5793.652380857162, 5801.984652685763, 5808.448197421239, 4424.623906967944, 4435.955640443619, 4439.622632076245, 4444.511103778582, 4473.239549276631, 3883.417487376916, 3906.746061505993, 3934.390169523728, 3951.881443556698, 3959.4456776051375, 5419.918701219485, 5427.185922111715, 5444.537214336826, 5463.508284254436, 5487.6158668892795, 5686.289213848269, 5730.426957304237, 5740.598158128974, 5755.85610359736, 5765.827025189251, 5372.677639341652, 5475.233467314579, 5502.367227768777, 5537.833864984057, 5549.19536667181, 4840.564349208517, 4846.079244943449, 4849.0, 4852.8786780330065, 4867.63492738039, 5765.509931655773, 6038.154658347835, 6042.909356359658, 6044.274687037584, 6047.78832740852, 5768.250127483317, 5780.913286300793, 5795.246617939641, 5819.912701309399, 5850.882982340415, 5956.315023772322, 5963.165156877953, 5968.641881487125, 5972.044472884318, 6024.728887199999, 5552.056150454513, 5654.830355089354, 5716.685582292847, 5728.656280623176, 5751.798687045934, 5795.420457954171, 5831.241938547962, 5837.503812176013, 5860.882782344414, 5910.70446477683, 5707.714614269353, 5709.115087161496, 5735.770569177186, 5737.0, 5738.397468265772, 5479.835604931858, 5566.693831839288, 5599.188117722826, 5702.116171993348, 5706.400827913176, 5502.284702988586, 5515.558755299647, 5555.055640541037, 5557.138643510262, 5606.439356064361, 5634.492895639412, 5635.690037048002, 5643.294588176478, 5659.066254068197, 5669.744861481161, 5348.652337598043, 5545.085060964896, 5547.084731019337, 5556.444355564411, 5622.297212848394], "value": 5270.956393778171, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.8966768304452, 584.3484514766035, 601.9187409699692, 612.816155153454, 650.3041745332496, 39001.414978775305, 42572.36141457881, 42621.0, 42735.0, 43047.35428968568, 43481.0, 43820.34269485952, 43954.56045439545, 43968.56031439685, 44174.779126104324, 8687.739367818975, 8786.121387861227, 8805.25155361795, 8809.691660791874, 8827.382083254175, 8830.381873268874, 8837.602307896128, 8865.157810008071, 8881.689140880071, 8952.776180595505, 8931.0, 8937.195652391283, 8967.641294348217, 8971.910280897206, 8977.910220897773, 8939.73180804577, 8939.865902011476, 8958.731238062901, 8966.372353935227, 8981.416207946462, 8719.346049046348, 8800.16398442147, 8804.119588041209, 8825.161609647137, 8865.157810008039, 33299.0, 40582.59417405818, 40891.0, 40977.38533921994, 41122.0, 3321.9169520761934, 3352.6312105668358, 3465.9480107798404, 3466.687998080185, 3489.6335884731993, 31721.682783172335, 31737.523937140963, 32134.35731285361, 32616.836915815267, 33159.33681326384, 4420.9336859947125, 4447.755373454459, 4448.0, 4554.567316104964, 4610.239310513761, 371759.0, 380116.0, 380599.0, 380992.0, 381456.0, 35269.29461410809, 61245.0, 62332.68833655803, 62706.372936270964, 62774.37225627777, 34740.826295868865, 36298.637013630054, 36363.63636363656, 36397.45403818945, 36436.45345319822, 14498.710025799635, 14551.92724036373, 14561.927190364193, 14626.414943402146, 14834.851651483346, 12206.877931220752, 12321.44553495077, 12340.753184936431, 12357.196782209128, 12640.55758048464, 8285.295749861209, 8383.203595658402, 8404.747857564284, 8442.282405995436, 8466.365022623328, 3275.328557645677, 3285.704286614216, 3307.107081088093, 3323.5513205717402, 3330.0, 966.246327864267, 1020.6835880876952, 1062.0388548363744, 1089.7493576477455, 1126.3804907301117, 31726.2068448286, 31728.0, 32296.70813167447, 32744.67255327464, 33623.49564756531, 1043.4939054558533, 1056.8203405421098, 1102.1238115698038, 1134.5915470430803, 1182.603827717707, 16265.0, 16795.41216057432, 16896.493105206864, 16988.57528561771, 17061.7440738389, 584683.0, 585182.0, 591023.0, 592219.0, 593570.0, 56784.43215567874, 56968.430315696314, 57202.0, 57238.42761572414, 57270.0, 1337.164272329794, 1384.2179168769815, 1387.5213051497217, 1395.386030146732, 1395.7696979998186, 29714.851425743596, 31635.683643163273, 31865.0, 32077.198070048435, 32540.186495337806, 50991.74504127455, 51740.56724043921, 51856.48143518517, 51864.222036668725, 51936.0, 475188.0, 480832.0, 482183.0, 482864.0, 485311.0, 27664.861675691493, 27826.44347113006, 27938.58092128579, 27988.0, 28011.879524818778, 46534.76732616315, 46945.29582056204, 47908.0, 48110.5188948106, 48527.0, 40732.0, 40888.59111408848, 41089.0, 41906.58093419149, 41908.37137443002, 37864.62135378721, 40582.39126413165, 41422.0, 41656.3751543721, 41737.79131104325, 36267.45598816073, 39474.210515790095, 40168.0, 41401.0, 43135.70592882093, 34980.0, 35979.0, 36975.26049479049, 36975.8151209253, 37016.0, 27249.455010899273, 27694.584581231702, 28024.85987570049, 28090.157295281173, 28286.15141545757], "value": 18943.813572366544, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.557088206798, 379.78352339166685, 383.69496250480864, 396.57368329046284, 398.2453251089186, 18104.637907241864, 20537.0, 20716.27493037744, 20720.067596958135, 20745.585088298227, 18848.434546963577, 19065.714014289762, 19885.204591816346, 19961.800381996174, 20079.498012549695, 5606.691631960231, 5656.604037717361, 5763.049096899028, 5776.566757493184, 5777.711114444282, 5606.6636001839815, 5634.32388113427, 5742.511886489653, 5793.319937218202, 5797.304323481167, 5202.271681964528, 5480.725963701799, 5488.039593071217, 5742.971285143569, 5754.625949313281, 5498.0, 5605.215269862222, 5632.831015069554, 5793.391693872125, 6320.968395158041, 5588.888222235532, 5686.744096515667, 5703.144528320785, 5716.314042314907, 5724.856878578027, 13198.076134670577, 20229.393118206477, 22917.541649166924, 23744.525109497885, 23781.7621823783, 2215.656573231152, 2304.8271379646426, 2306.5848147333472, 2684.81206315558, 2979.2849716068204, 9324.627014919395, 9392.342536022481, 9491.098345657152, 9789.90210097897, 9939.204863610894, 1905.9237630494763, 1961.5880665060354, 1967.7198822934918, 1977.683570628707, 1987.4037788663343, 86398.0, 88684.55657721734, 90628.0, 91038.54480727554, 91909.0, 10261.02520260574, 10419.687409377731, 10520.473976301155, 11343.319400835977, 11678.766424671629, 14680.41278348854, 14706.926465367818, 14791.038582492103, 14861.479848205478, 14924.92537537327, 7574.977378053893, 7644.770656880302, 7827.608619568999, 7914.841703165905, 7950.801229969297, 7368.263173682696, 7441.739539116105, 7485.663145158372, 7610.695572177051, 7672.65473053714, 4328.372386004012, 4419.138268037702, 4437.445319335083, 4486.327050942385, 4529.569690879427, 1833.1147491933848, 1890.8203720646516, 1892.7823300320365, 1897.7627796525435, 1905.6365514866272, 969.2972594868804, 988.8417853143462, 1038.309524166436, 1068.4497483795851, 1110.0730889707024, 19418.223271069, 19452.22191112368, 19732.605347893248, 19768.11043503046, 19790.0, 954.7040417470606, 1002.7894142230067, 1010.166612544639, 1083.8374243863325, 1085.934843909368, 10273.640422585173, 10809.468466589118, 10847.132229421628, 10878.694556653252, 12014.0, 563044.8477576105, 564562.0, 570675.0, 571516.0, 571915.0, 71396.64301678458, 73081.0, 74505.25494745091, 101883.4905825481, 104926.0, 1022.9795404092025, 1028.6913925822223, 1033.9327943683636, 1039.953202105907, 1046.7487802927394, 17567.297308107532, 17721.291148354438, 18292.45122646323, 18456.81543184551, 18541.258349665863, 38964.0, 45534.772326138154, 46109.30836037395, 46584.76707616576, 46976.29535557038, 61801.0, 63220.36779632145, 63436.68281658747, 63724.0, 64177.0, 7303.379212766974, 7928.722494712888, 8097.635606397608, 8192.713255036046, 8637.956810215908, 13459.259740714355, 13984.580462586138, 14027.50903718365, 14093.647658808612, 14160.858391415954, 11899.940500297444, 12124.818127728267, 12155.574554890536, 12271.386430678609, 12310.569130080405, 11918.582849600223, 12060.155789094679, 12116.333601651993, 12315.876841231473, 12430.627081187578, 11844.881551184379, 12212.57255996036, 12306.384680765746, 12405.565805196775, 12463.688407789516, 7525.774226773206, 7546.358559522502, 7560.9621951889885, 7633.6564854580565, 8003.19968003195, 11315.886841131813, 11510.079193664655, 11859.762804744028, 11915.582954596548, 11971.940140299243], "value": 9276.918746804164, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1474.3512854344087, 1495.0282316494277, 1592.3948899418226, 1741.2512619573586, 1751.4745576327098, 7715.537067775937, 8171.795705107375, 8368.748937531876, 8897.199252067305, 8923.910760892397, 8195.262426381625, 8325.708600198994, 8348.666053357874, 8415.66337346507, 8442.873356899636, 2163.7944395282425, 2197.154095673169, 2202.933911982643, 2206.1396055538353, 2210.1490925993526, 2096.6645336746124, 2118.3750793515874, 2224.3660556741333, 2231.9107235710553, 2235.675827005083, 2166.945826354338, 2174.1738139506965, 2180.2805074325515, 2198.681191227271, 2199.747029091659, 2120.533482633818, 2153.2894144932134, 2153.8276937844935, 2154.8491605587537, 2159.6112699714045, 2122.1511395441794, 2145.8819764912923, 2146.9785302146934, 2152.2036846366786, 2154.6229409853213, 8374.958125209396, 8508.106648801848, 8511.148885111501, 8515.148485151436, 8535.231829135408, 5078.822241221539, 5216.530512253916, 5217.921731174036, 5220.556252718524, 5229.320188375486, 3253.8535765890592, 3285.392202442532, 3291.5720956275773, 3332.0, 3361.6470270621476, 998.241336584194, 1042.0725554256717, 1054.72577129946, 1068.978620427595, 1070.5610699613198, 12195.817062744067, 12215.633530994084, 12238.694032649166, 12240.265584064895, 12243.816342754866, 4318.676099292566, 4350.390945267665, 4513.638908887281, 4518.525554816762, 4532.7280363178315, 10234.6417875374, 10310.43292618913, 10383.376997380181, 10391.272610917164, 10391.636292729869, 5190.506901844395, 5203.453637368098, 5215.374155101412, 5244.003639308519, 5263.868403289872, 4164.958350416457, 4773.71357718538, 4780.713157210578, 4783.258594917794, 4813.4945830687275, 3747.475353450519, 3846.1922996171115, 3896.980515097406, 3916.1580260244186, 3926.1166237596885, 1229.7724920889664, 1250.5185503581006, 1251.6808213905397, 1257.283348491351, 1271.4087949103712, 974.2985050763439, 976.7851072763981, 987.2299606306948, 987.9407235565889, 1020.9229263127323, 5899.321578018497, 5940.198073260141, 6087.538990642302, 6184.103305020747, 6360.681965901686, 971.5919313888184, 971.7764914069803, 983.955721992512, 998.6155330197926, 1023.8310678737924, 3434.5191673165778, 4067.6949228807366, 4079.714419990572, 4097.89755256115, 4184.66522678185, 10153.289269751047, 10434.16526677864, 10799.946000269949, 10930.617428390127, 11010.174236932262, 10546.367217966947, 10724.08845248147, 10865.130789536975, 10923.508442120125, 10944.39805810672, 7902.091259505116, 8055.194480551898, 8110.229528194812, 8175.223353781381, 8231.682930731055, 5934.6142500737315, 6050.606710563799, 6152.815415537541, 6198.72105755233, 6234.37656234391, 9896.15882649954, 9968.953259907896, 10159.136473399843, 10194.847077293995, 10243.641472548425, 9555.0, 9940.403575785476, 9955.153811925778, 10148.695539133838, 10239.48802559884, 6906.792796216121, 7450.552966822008, 7651.808704782425, 7771.0, 7885.723999659985, 8522.70170544028, 8566.82866342682, 8578.313734901318, 8580.313574914117, 8597.871031934652, 7498.325150736242, 7716.884246736191, 7765.339946104418, 7802.219778022152, 7802.570858602831, 7455.440841936768, 7598.886016709865, 7628.580428076287, 7659.731909383368, 7837.608119593883, 6612.570182938093, 6652.800415987528, 6658.600483970978, 6671.566348187353, 6674.966625166843, 4695.5304469552775, 4845.612351011981, 4901.270274185428, 4925.950740492693, 5032.119379108714, 4909.852704418873, 4920.089783390084, 4973.850784476472, 5062.190049592047, 5063.13926632466], "value": 4543.456484573591, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.3150691766162, 319.6643524299485, 321.1345424082099, 326.59502217250616, 332.199399447332, 5735.741891614877, 5750.453706897843, 5757.395473475288, 5773.249477567921, 5823.126531020349, 5608.158776183574, 5627.971860140704, 5633.436656334365, 5646.802361917334, 5649.4633009864, 4020.6381425671684, 4285.742855428669, 4417.5361587033385, 4436.645068394529, 4439.64482841372, 4242.448481697375, 4246.40550322955, 4256.148770245948, 4282.008865877367, 4310.762908040057, 4238.131183107471, 4265.936010959838, 4286.978565107186, 4293.377460268259, 4312.568743125694, 4139.586041395852, 4280.743155410685, 4327.0, 4338.655016944757, 4352.173087113439, 3773.509443772292, 3777.697784177259, 3782.56500502443, 3796.1268908151005, 3798.90502737431, 5520.944790552083, 5538.6399884007815, 5547.44525547446, 5557.638753481011, 5586.301712285965, 4849.175640141149, 4921.384826896638, 4943.530364615356, 4952.306677065214, 5008.923081537487, 5859.648421094748, 5865.149553314745, 5868.442497962729, 5882.176495290662, 5884.116782776451, 4062.3500239961463, 4088.3867419886956, 4105.2405305018365, 4127.823570282455, 4128.584777904929, 5899.3718862899, 6057.242844644419, 6145.293291271471, 6148.247749391447, 6163.630182189083, 4221.662267018631, 4229.703920725519, 4234.809433575497, 4235.449391579075, 4244.724092934011, 4262.744235345827, 4283.914321713548, 4292.227399068198, 4324.113556720865, 4328.28583283761, 4815.542523460265, 4933.975330123327, 4972.7513624318635, 4989.850304490871, 5002.674826136289, 5858.0, 5863.501602363762, 5894.0, 5927.288725352899, 5938.921377517834, 1474.8820094392422, 1486.6357742353193, 1490.6720521485256, 1491.403438624537, 1494.1632685695827, 931.7577429868284, 946.711253067821, 985.788055568042, 990.1830989433746, 1002.0880998291519, 5621.943780562224, 5667.688277144796, 5689.719813042032, 5703.62926409782, 5728.369879313273, 5986.670733109634, 5994.310654274727, 5999.1901093351835, 6014.669193194416, 6085.57400981927, 5501.4223506532035, 5626.409227031185, 5745.1669507921115, 5749.88500229993, 5785.82642520725, 3210.727088197529, 3236.8705251790134, 3241.4165450218716, 3281.310924705791, 3288.835558222127, 6055.545834062463, 6220.62676239418, 6226.813195604049, 6242.813865365566, 6288.9056664150075, 6173.351798061229, 6197.287311959092, 6222.191115155001, 6227.813165605039, 6238.937610623926, 6204.255489341308, 6234.532410069263, 6262.405071518289, 6275.6862156891975, 6295.5907865988565, 5828.184054232495, 6032.336442991355, 6081.209442772411, 6090.294717479113, 6097.817065488042, 6011.609245399035, 6048.455638992512, 6071.392860713893, 6084.239470066242, 6086.60437071589, 6022.36765139654, 6230.7507699691505, 6246.750129994749, 6261.718222680081, 6312.3056463788025, 4097.405876148002, 4137.54487006423, 4145.2124096421585, 4146.564610715952, 4149.439825623502, 6066.545009124422, 6096.055111457731, 6142.0, 6143.600665956698, 6144.723487443165, 5733.799317024051, 5915.674637894957, 5919.437653422918, 5929.555283353679, 5944.346121926498, 5945.0, 5961.52307815365, 5967.985442474703, 5970.611910225822, 5970.805838832164, 5620.3536593290655, 5824.3593204748295, 5843.444872737083, 5854.443827836349, 5908.434264919713, 5984.31180414258, 6040.278520621602, 6044.365341639241, 6053.303870054824, 6058.818235452944, 5858.94141058584, 5897.882042359043, 5902.203202567598, 5934.991051521338, 5943.435373639497], "value": 4473.240690734738, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.5569297653849, 796.9083555391129, 808.5068108453846, 837.3468694418356, 847.3771777743353, 14436.783448248285, 15497.69004619907, 15518.84481155188, 15520.301586428595, 15524.689506209883, 13918.51285205018, 14009.579712608613, 14020.43918243269, 14026.088304260242, 14026.789598156036, 641.4323323858396, 743.6727839750492, 764.9885251721229, 766.9156392796788, 770.8766597344426, 785.132428666324, 788.9723859664913, 789.2738680414004, 789.4118881433341, 790.5770412829138, 826.0582935453588, 827.3877330775243, 830.7881490220016, 833.4249367936135, 837.0165056059136, 820.0487434575894, 824.3652387661527, 827.9047909490365, 828.0932379044937, 829.1169904052196, 608.0605464557269, 608.084832327349, 608.2913405882186, 608.7838817219912, 608.8964875971095, 13593.864061359458, 13601.251931143783, 13669.179849209078, 13673.794893076612, 13703.794443083361, 13845.861541384658, 14805.481808136772, 14954.551363459113, 15142.848571514254, 15171.862110341659, 12150.149489535735, 12265.570705025371, 12311.569095081719, 12362.134650574464, 12729.745405091846, 3915.1386694927355, 3967.404889266604, 4030.3954406838916, 4044.635982761536, 4113.362428823537, 70404.2959570408, 71446.64276678635, 71569.0, 71763.64118179376, 75249.62375188089, 10943.83584246237, 10976.615818446317, 11153.832692509619, 11256.0, 11581.710457238636, 21784.45538861541, 21813.454663633536, 21855.890720546613, 21889.233876814236, 22049.448763781034, 8005.119436861941, 8156.143604921516, 8184.386171037077, 8321.583920803936, 8403.915960840435, 4843.128236917319, 4941.629377796679, 5014.07239660664, 5033.47148549397, 5068.543831055149, 3585.964140358563, 3676.0442285006093, 3678.889633311005, 3701.592824789271, 3703.7407381483035, 612.7365232949875, 620.9161763162006, 625.0405627361978, 628.4972022382167, 631.4317114596807, 571.6941436331542, 593.5874567175771, 610.2890132995011, 624.2384291164863, 662.0268205737558, 9156.8626470603, 9306.302027347976, 9496.382735122195, 9559.583432705236, 9642.614295428104, 608.3156448994881, 738.7008261654039, 739.4897520710692, 748.2497010474412, 761.6268028665913, 4390.407295015196, 4539.182947069559, 4682.555157260055, 4697.929531057037, 4710.411198600175, 118816.40591796985, 125261.0, 125268.0, 127980.36009820078, 128835.0, 60930.0860487093, 61799.69100154471, 105502.4724876386, 106683.46658266814, 109757.0, 56021.0, 57086.42913570894, 72813.0, 89226.9999999987, 91823.0, 8864.512451815212, 8992.261940283808, 9030.0, 9032.774180645274, 9138.908610913806, 50941.490585095155, 52916.73541632267, 54466.727666363, 54537.72731136319, 54622.0, 47661.5233847671, 47705.0, 48307.0, 48429.0, 50248.74875625598, 12275.631731048083, 12281.192271206608, 12379.319137447526, 12458.439370228543, 12530.997520198545, 13800.585982420544, 13965.51120710811, 14218.573442796733, 14222.715545689236, 15070.09579425238, 13485.932570337085, 13557.59327220185, 13874.791878122038, 14165.150090994573, 14656.413743450143, 12609.558665447032, 12800.423980920694, 12873.0, 12986.675333116747, 13096.607101786962, 13713.451461941411, 13803.447862085404, 13853.099548529313, 13958.58124256274, 14018.579442616738, 10674.73313167177, 10871.184661150604, 10886.40124793144, 11063.280886742335, 11108.166887483632, 11557.422128893353, 11977.461014254553, 12085.413449670126, 12154.0, 12183.269003859798], "value": 7343.08469820167, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 108.0, 112.0, 113.0, 114.0, 119.0, 111.0, 114.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 121.0, 148.0, 173.0, 119.0, 161.0, 150.0, 125.0, 184.0, 120.0], "value": 144.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 172.0, 162.0, 162.0, 161.0, 168.0, 171.0, 169.0, 161.0, 163.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 167.0, 76.0, 75.0, 76.0, 77.0, 176.0, 79.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 144.0, 84.0, 85.0, 84.0, 144.0, 84.0, 84.0, 139.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 119.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 151.0, 148.0, 147.0, 148.0, 148.0, 147.0, 146.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 97.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 53.0, 53.0, 56.0, 54.0, 53.0, 53.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 76.0, 75.0, 76.0, 76.0, 76.0, 81.0, 81.0, 77.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 137.0, 142.0, 119.0, 130.0, 125.0, 124.0, 129.0, 164.0, 136.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 157.0, 162.0, 156.0, 156.0, 157.0, 156.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 73.0, 65.0, 65.0, 63.0, 67.0, 63.0, 62.0, 67.0], "value": 65.5, "unit": "score"}]}]} 17:38:39 INFO - Return code: 0 17:38:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:38:39 ERROR - # TBPL SUCCESS # 17:38:39 INFO - Running post-action listener: _resource_record_post_action 17:38:39 INFO - ##### 17:38:39 INFO - ##### Finished run-tests step (success) 17:38:39 INFO - ##### 17:38:39 INFO - Running post-run listener: _resource_record_post_run 17:38:39 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553029632; Read time: 12; Write time: 496092 17:38:39 INFO - TinderboxPrint: CPU usage
13.3% 17:38:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:38:39 INFO - TinderboxPrint: I/O write bytes / time
553,029,632 / 496,092 17:38:39 INFO - TinderboxPrint: CPU idle
8,227.3 (86.6%) 17:38:39 INFO - TinderboxPrint: CPU user
1,212.0 (12.8%) 17:38:39 INFO - TinderboxPrint: Swap in / out
0 / 0 17:38:39 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257277952; Read time: 0; Write time: 300768 17:38:39 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 295751680; Read time: 0; Write time: 195324 17:38:40 INFO - Running post-run listener: _upload_blobber_files 17:38:40 INFO - Blob upload gear active. 17:38:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:38:40 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 17:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:38:40 INFO - (blobuploader) - INFO - Open directory for files ... 17:38:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:38:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:38:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:41 INFO - (blobuploader) - INFO - Done attempting. 17:38:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:38:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:38:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:44 INFO - (blobuploader) - INFO - Done attempting. 17:38:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:38:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:45 INFO - (blobuploader) - INFO - Done attempting. 17:38:45 INFO - (blobuploader) - INFO - Iteration through files over. 17:38:45 INFO - Return code: 0 17:38:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:38:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:38:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c93a400345f5a02c26f931e904ed2265ca1f6c631f9077d243136d31510e7d053da5da3155e46518241f4061740d61b0d1578a0e568ecd5620e0630dfcf98e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee4931b23158ebd817e84d0c5a18a13347749cffffb7bdcb09ffb6f78300819fdd1675bf998ea10e95ed22b63b67b478f27304353ae09a3f9a075ea81f07fa11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3d26afec1b6992fa3b495f29ad800daa0b65d337627b94f6bee4e59aa73f747e6faf296a81772a41428e4668da7195887d83a4e90f9bade76c95518ce11e8ec"} 17:38:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:38:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:38:45 INFO - Contents: 17:38:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c93a400345f5a02c26f931e904ed2265ca1f6c631f9077d243136d31510e7d053da5da3155e46518241f4061740d61b0d1578a0e568ecd5620e0630dfcf98e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee4931b23158ebd817e84d0c5a18a13347749cffffb7bdcb09ffb6f78300819fdd1675bf998ea10e95ed22b63b67b478f27304353ae09a3f9a075ea81f07fa11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3d26afec1b6992fa3b495f29ad800daa0b65d337627b94f6bee4e59aa73f747e6faf296a81772a41428e4668da7195887d83a4e90f9bade76c95518ce11e8ec"} 17:38:45 INFO - Running post-run listener: copy_logs_to_upload_dir 17:38:45 INFO - Copying logs to upload dir... 17:38:45 INFO - mkdir: /builds/slave/test/build/upload/logs 17:38:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.228511 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-13 17:38:44.156018) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 17:38:44.160034) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c93a400345f5a02c26f931e904ed2265ca1f6c631f9077d243136d31510e7d053da5da3155e46518241f4061740d61b0d1578a0e568ecd5620e0630dfcf98e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee4931b23158ebd817e84d0c5a18a13347749cffffb7bdcb09ffb6f78300819fdd1675bf998ea10e95ed22b63b67b478f27304353ae09a3f9a075ea81f07fa11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3d26afec1b6992fa3b495f29ad800daa0b65d337627b94f6bee4e59aa73f747e6faf296a81772a41428e4668da7195887d83a4e90f9bade76c95518ce11e8ec"} build_url:https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011569 build_url: 'https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c93a400345f5a02c26f931e904ed2265ca1f6c631f9077d243136d31510e7d053da5da3155e46518241f4061740d61b0d1578a0e568ecd5620e0630dfcf98e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee4931b23158ebd817e84d0c5a18a13347749cffffb7bdcb09ffb6f78300819fdd1675bf998ea10e95ed22b63b67b478f27304353ae09a3f9a075ea81f07fa11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3d26afec1b6992fa3b495f29ad800daa0b65d337627b94f6bee4e59aa73f747e6faf296a81772a41428e4668da7195887d83a4e90f9bade76c95518ce11e8ec"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 17:38:44.186147) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:38:44.186695) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1468453602.817521-211061443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:38:44.270329) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 17:38:44.270690) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 17:38:44.270984) ========= ========= Total master_lag: 0.15 =========