builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-042 starttime: 1468360920.77 results: success (0) buildid: 20160712142126 builduid: ef2131f292014f9ebc4be8ea160a4fe3 revision: 9fb3a5f8b892765c7b877aa8541228fd0b5a1928 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 15:02:00.766420) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 15:02:00.766946) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 15:02:00.767245) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 15:02:00.825766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 15:02:00.826031) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 15:02:00-- 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% 46.0M=0s 2016-07-12 15:02:01 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158260 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 15:02:01.002531) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 15:02:01.002862) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020699 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 15:02:01.052830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 15:02:01.053494) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9fb3a5f8b892765c7b877aa8541228fd0b5a1928 --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 9fb3a5f8b892765c7b877aa8541228fd0b5a1928 --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=74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 15:02:01,180 truncating revision to first 12 chars 2016-07-12 15:02:01,180 Setting DEBUG logging. 2016-07-12 15:02:01,180 attempt 1/10 2016-07-12 15:02:01,180 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9fb3a5f8b892?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 15:02:01,918 unpacking tar archive at: fx-team-9fb3a5f8b892/testing/mozharness/ program finished with exit code 0 elapsedTime=1.086753 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 15:02:02.154145) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 15:02:02.154529) ========= script_repo_revision: 9fb3a5f8b892765c7b877aa8541228fd0b5a1928 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 15:02:02.155090) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 15:02:02.155370) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 15:02:02.165544) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-12 15:02:02.166195) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:02:02 INFO - MultiFileLogger online at 20160712 15:02:02 in /builds/slave/test 15:02:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:02:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:02:02 INFO - {'append_to_log': False, 15:02:02 INFO - 'base_work_dir': '/builds/slave/test', 15:02:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:02:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:02:02 INFO - 'branch': 'Fx-Team-Non-PGO', 15:02:02 INFO - 'buildbot_json_path': 'buildprops.json', 15:02:02 INFO - 'config_files': ('talos/linux_config.py',), 15:02:02 INFO - 'default_actions': ('clobber', 15:02:02 INFO - 'read-buildbot-config', 15:02:02 INFO - 'download-and-extract', 15:02:02 INFO - 'populate-webroot', 15:02:02 INFO - 'create-virtualenv', 15:02:02 INFO - 'install', 15:02:02 INFO - 'run-tests'), 15:02:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:02:02 INFO - 'download_minidump_stackwalk': True, 15:02:02 INFO - 'download_symbols': 'ondemand', 15:02:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:02:02 INFO - 'tooltool.py': '/tools/tooltool.py', 15:02:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:02:02 INFO - '/tools/misc-python/virtualenv.py')}, 15:02:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:02:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:02:02 INFO - 'installer_path': 'installer.exe', 15:02:02 INFO - 'log_level': 'info', 15:02:02 INFO - 'log_name': 'talos', 15:02:02 INFO - 'log_to_console': True, 15:02:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:02:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:02:02 INFO - 'opt_config_files': (), 15:02:02 INFO - 'pip_index': False, 15:02:02 INFO - 'sps_profile': False, 15:02:02 INFO - 'sps_profile_interval': 0, 15:02:02 INFO - 'suite': 'dromaeojs-e10s', 15:02:02 INFO - 'system_bits': '32', 15:02:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:02:02 INFO - 'title': 'talos-linux64-ix-042', 15:02:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:02:02 INFO - 'use_talos_json': True, 15:02:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:02:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:02:02 INFO - 'work_dir': 'build'} 15:02:02 INFO - ##### 15:02:02 INFO - ##### Running clobber step. 15:02:02 INFO - ##### 15:02:02 INFO - Running pre-action listener: _resource_record_pre_action 15:02:02 INFO - Running main action method: clobber 15:02:02 INFO - rmtree: /builds/slave/test/build 15:02:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:02:03 INFO - Running post-action listener: _resource_record_post_action 15:02:03 INFO - ##### 15:02:03 INFO - ##### Finished clobber step (success) 15:02:03 INFO - ##### 15:02:03 INFO - ##### 15:02:03 INFO - ##### Running read-buildbot-config step. 15:02:03 INFO - ##### 15:02:03 INFO - Running pre-action listener: _resource_record_pre_action 15:02:03 INFO - Running main action method: read_buildbot_config 15:02:03 INFO - Using buildbot properties: 15:02:03 INFO - { 15:02:03 INFO - "project": "", 15:02:03 INFO - "product": "firefox", 15:02:03 INFO - "script_repo_revision": "production", 15:02:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:02:03 INFO - "repository": "", 15:02:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:02:03 INFO - "buildid": "20160712142126", 15:02:03 INFO - "pgo_build": "False", 15:02:03 INFO - "basedir": "/builds/slave/test", 15:02:03 INFO - "buildnumber": 1452, 15:02:03 INFO - "slavename": "talos-linux64-ix-042", 15:02:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:02:03 INFO - "platform": "ubuntu64_hw", 15:02:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:02:03 INFO - "branch": "fx-team", 15:02:03 INFO - "repo_path": "integration/fx-team", 15:02:03 INFO - "revision": "9fb3a5f8b892765c7b877aa8541228fd0b5a1928", 15:02:03 INFO - "stage_platform": "linux64", 15:02:03 INFO - "builduid": "ef2131f292014f9ebc4be8ea160a4fe3", 15:02:03 INFO - "slavebuilddir": "test" 15:02:03 INFO - } 15:02:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:02:03 INFO - Running post-action listener: _resource_record_post_action 15:02:03 INFO - ##### 15:02:03 INFO - ##### Finished read-buildbot-config step (success) 15:02:03 INFO - ##### 15:02:03 INFO - ##### 15:02:03 INFO - ##### Running download-and-extract step. 15:02:03 INFO - ##### 15:02:03 INFO - Running pre-action listener: _resource_record_pre_action 15:02:03 INFO - Running main action method: download_and_extract 15:02:03 INFO - mkdir: /builds/slave/test/build/tests 15:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:03 INFO - https://queue.taskcluster.net/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:02:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:02:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:02:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/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 15:02:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/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 15:02:13 INFO - Downloaded 1361 bytes. 15:02:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:02:13 INFO - Using the following test package requirements: 15:02:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:02:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:02:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:02:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:13 INFO - u'jsshell-linux-x86_64.zip'], 15:02:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:02:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:02:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:02:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:02:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:02:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:02:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:02:13 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')]} 15:02:13 INFO - https://queue.taskcluster.net/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:02:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:02:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:02:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/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 15:02:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/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 15:02:22 INFO - Downloaded 22750521 bytes. 15:02:22 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'] 15:02:22 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 15:02:23 INFO - Return code: 0 15:02:23 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 15:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:23 INFO - https://queue.taskcluster.net/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:02:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:02:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:02:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/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 15:02:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/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 15:02:25 INFO - Downloaded 22750521 bytes. 15:02:25 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'] 15:02:25 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 15:02:26 INFO - Return code: 0 15:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:26 INFO - https://queue.taskcluster.net/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:02:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:02:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:02:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/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 15:02:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/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 15:02:27 INFO - Downloaded 14403317 bytes. 15:02:27 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'] 15:02:27 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 15:02:27 INFO - Return code: 0 15:02:27 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')]} 15:02:27 INFO - https://queue.taskcluster.net/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:02:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:02:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:02:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/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 15:02:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICxnFLgER4ChM_-iieoMRw/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 15:02:29 INFO - Downloaded 56665710 bytes. 15:02:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:02:29 INFO - mkdir: /builds/slave/test/properties 15:02:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:02:29 INFO - Writing to file /builds/slave/test/properties/build_url 15:02:29 INFO - Contents: 15:02:29 INFO - build_url:https://queue.taskcluster.net/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:02:30 INFO - Running post-action listener: _resource_record_post_action 15:02:30 INFO - Running post-action listener: set_extra_try_arguments 15:02:30 INFO - ##### 15:02:30 INFO - ##### Finished download-and-extract step (success) 15:02:30 INFO - ##### 15:02:30 INFO - ##### 15:02:30 INFO - ##### Running populate-webroot step. 15:02:30 INFO - ##### 15:02:30 INFO - Running pre-action listener: _resource_record_pre_action 15:02:30 INFO - Running main action method: populate_webroot 15:02:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:02:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:02:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:02:30 INFO - '--tppagecycles', 15:02:30 INFO - '7'], 15:02:30 INFO - 'tests': ['tsvgm']}}, 15:02:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:02:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:02:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:02:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:02:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:02:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:02:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:30 INFO - 'talos_options': ['--disable-e10s'], 15:02:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:02:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:02:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:30 INFO - 'talos_options': ['--disable-e10s'], 15:02:30 INFO - 'tests': ['damp', 'tps']}, 15:02:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:30 INFO - 'tests': ['damp', 'tps']}, 15:02:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:02:30 INFO - 'tests': ['dromaeo_dom']}, 15:02:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:02:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:02:30 INFO - 'tests': ['basic_compositor_video']}, 15:02:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:02:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:02:30 INFO - 'tests': ['a11yr', 15:02:30 INFO - 'ts_paint', 15:02:30 INFO - 'tpaint', 15:02:30 INFO - 'sessionrestore', 15:02:30 INFO - 'sessionrestore_no_auto_restore', 15:02:30 INFO - 'tabpaint']}, 15:02:30 INFO - 'other-e10s': {'tests': ['a11yr', 15:02:30 INFO - 'ts_paint', 15:02:30 INFO - 'tpaint', 15:02:30 INFO - 'sessionrestore', 15:02:30 INFO - 'sessionrestore_no_auto_restore', 15:02:30 INFO - 'tabpaint']}, 15:02:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:02:30 INFO - 'ts_paint', 15:02:30 INFO - 'tpaint', 15:02:30 INFO - 'sessionrestore', 15:02:30 INFO - 'sessionrestore_no_auto_restore', 15:02:30 INFO - 'tabpaint']}, 15:02:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:02:30 INFO - 'ts_paint', 15:02:30 INFO - 'tpaint', 15:02:30 INFO - 'sessionrestore', 15:02:30 INFO - 'sessionrestore_no_auto_restore', 15:02:30 INFO - 'tabpaint']}, 15:02:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:02:30 INFO - 'tests': ['a11yr', 15:02:30 INFO - 'ts_paint', 15:02:30 INFO - 'tpaint', 15:02:30 INFO - 'sessionrestore', 15:02:30 INFO - 'sessionrestore_no_auto_restore', 15:02:30 INFO - 'tabpaint']}, 15:02:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:02:30 INFO - 'tests': ['a11yr', 15:02:30 INFO - 'ts_paint', 15:02:30 INFO - 'tpaint', 15:02:30 INFO - 'sessionrestore', 15:02:30 INFO - 'sessionrestore_no_auto_restore', 15:02:30 INFO - 'tabpaint']}, 15:02:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:02:30 INFO - 'tests': ['tsvgx', 15:02:30 INFO - 'tsvgr_opacity', 15:02:30 INFO - 'tart', 15:02:30 INFO - 'tscrollx', 15:02:30 INFO - 'cart']}, 15:02:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:02:30 INFO - 'tsvgr_opacity', 15:02:30 INFO - 'tart', 15:02:30 INFO - 'tscrollx', 15:02:30 INFO - 'cart']}, 15:02:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:30 INFO - 'talos_options': ['--disable-e10s'], 15:02:30 INFO - 'tests': ['tp5o']}, 15:02:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:30 INFO - 'tests': ['tp5o']}, 15:02:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:30 INFO - 'talos_options': ['--disable-e10s', 15:02:30 INFO - '--xperf_path', 15:02:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:02:30 INFO - 'tests': ['tp5n']}, 15:02:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:30 INFO - 'talos_options': ['--xperf_path', 15:02:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:02:30 INFO - 'tests': ['tp5n']}}, 15:02:30 INFO - 'talos.zip': {'path': '', 15:02:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:02:30 INFO - Running post-action listener: _resource_record_post_action 15:02:30 INFO - ##### 15:02:30 INFO - ##### Finished populate-webroot step (success) 15:02:30 INFO - ##### 15:02:30 INFO - ##### 15:02:30 INFO - ##### Running create-virtualenv step. 15:02:30 INFO - ##### 15:02:30 INFO - Running pre-action listener: _resource_record_pre_action 15:02:30 INFO - Running main action method: create_virtualenv 15:02:30 INFO - Creating virtualenv /builds/slave/test/build/venv 15:02:30 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 15:02:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:02:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:02:30 INFO - Using real prefix '/usr' 15:02:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:02:31 INFO - Installing distribute.............................................................................................................................................................................................done. 15:02:33 INFO - Installing pip.................done. 15:02:33 INFO - Return code: 0 15:02:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:02:33 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')]} 15:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:33 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')]} 15:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:33 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 0x261a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2849400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8570>, '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 0x28d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d9900>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', '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 15:02:33 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 15:02:33 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 15:02:33 INFO - Using env: {'DISPLAY': ':0', 15:02:33 INFO - 'HOME': '/home/cltbld', 15:02:33 INFO - 'LANG': 'en_US.UTF-8', 15:02:33 INFO - 'LANGUAGE': 'en_US:en', 15:02:33 INFO - 'LOGNAME': 'cltbld', 15:02:33 INFO - 'MAIL': '/var/mail/cltbld', 15:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:33 INFO - 'MOZ_NO_REMOTE': '1', 15:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:33 INFO - 'NO_EM_RESTART': '1', 15:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:33 INFO - 'PWD': '/builds/slave/test', 15:02:33 INFO - 'SHELL': '/bin/bash', 15:02:33 INFO - 'SHLVL': '1', 15:02:33 INFO - 'TERM': 'linux', 15:02:33 INFO - 'TMOUT': '86400', 15:02:33 INFO - 'USER': 'cltbld', 15:02:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', 15:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:33 INFO - '_': '/tools/buildbot/bin/python'} 15:02:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:33 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 15:02:33 INFO - Cleaning up... 15:02:33 INFO - Return code: 0 15:02:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:02:33 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')]} 15:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:33 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')]} 15:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:33 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 0x261a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2849400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8570>, '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 0x28d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d9900>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', '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 15:02:33 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 15:02:33 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 15:02:33 INFO - Using env: {'DISPLAY': ':0', 15:02:33 INFO - 'HOME': '/home/cltbld', 15:02:33 INFO - 'LANG': 'en_US.UTF-8', 15:02:33 INFO - 'LANGUAGE': 'en_US:en', 15:02:33 INFO - 'LOGNAME': 'cltbld', 15:02:33 INFO - 'MAIL': '/var/mail/cltbld', 15:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:33 INFO - 'MOZ_NO_REMOTE': '1', 15:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:33 INFO - 'NO_EM_RESTART': '1', 15:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:33 INFO - 'PWD': '/builds/slave/test', 15:02:33 INFO - 'SHELL': '/bin/bash', 15:02:33 INFO - 'SHLVL': '1', 15:02:33 INFO - 'TERM': 'linux', 15:02:33 INFO - 'TMOUT': '86400', 15:02:33 INFO - 'USER': 'cltbld', 15:02:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', 15:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:33 INFO - '_': '/tools/buildbot/bin/python'} 15:02:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:33 INFO - Downloading/unpacking psutil>=3.1.1 15:02:33 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 15:02:33 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 15:02:33 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 15:02:33 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 15:02:33 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 15:02:33 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 15:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:02:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:02:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:02:35 INFO - Installing collected packages: psutil 15:02:35 INFO - Running setup.py install for psutil 15:02:35 INFO - building 'psutil._psutil_linux' extension 15:02:35 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 15:02:35 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 15:02:35 INFO - building 'psutil._psutil_posix' extension 15:02:35 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 15:02:35 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 15:02:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:02:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:02:35 INFO - Successfully installed psutil 15:02:35 INFO - Cleaning up... 15:02:36 INFO - Return code: 0 15:02:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:02:36 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')]} 15:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:36 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')]} 15:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:36 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 0x261a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2849400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8570>, '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 0x28d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d9900>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', '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 15:02:36 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 15:02:36 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 15:02:36 INFO - Using env: {'DISPLAY': ':0', 15:02:36 INFO - 'HOME': '/home/cltbld', 15:02:36 INFO - 'LANG': 'en_US.UTF-8', 15:02:36 INFO - 'LANGUAGE': 'en_US:en', 15:02:36 INFO - 'LOGNAME': 'cltbld', 15:02:36 INFO - 'MAIL': '/var/mail/cltbld', 15:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:36 INFO - 'MOZ_NO_REMOTE': '1', 15:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:36 INFO - 'NO_EM_RESTART': '1', 15:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:36 INFO - 'PWD': '/builds/slave/test', 15:02:36 INFO - 'SHELL': '/bin/bash', 15:02:36 INFO - 'SHLVL': '1', 15:02:36 INFO - 'TERM': 'linux', 15:02:36 INFO - 'TMOUT': '86400', 15:02:36 INFO - 'USER': 'cltbld', 15:02:36 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', 15:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:36 INFO - '_': '/tools/buildbot/bin/python'} 15:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:02: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 15:02: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 15:02: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 15:02: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 15:02: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 15:02: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 15:02:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:02:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:02:38 INFO - Installing collected packages: mozsystemmonitor 15:02:38 INFO - Running setup.py install for mozsystemmonitor 15:02:38 INFO - Successfully installed mozsystemmonitor 15:02:38 INFO - Cleaning up... 15:02:38 INFO - Return code: 0 15:02:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:38 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 0x261a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2849400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8570>, '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 0x28d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d9900>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', '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 15:02:38 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 15:02:38 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 15:02:38 INFO - Using env: {'DISPLAY': ':0', 15:02:38 INFO - 'HOME': '/home/cltbld', 15:02:38 INFO - 'LANG': 'en_US.UTF-8', 15:02:38 INFO - 'LANGUAGE': 'en_US:en', 15:02:38 INFO - 'LOGNAME': 'cltbld', 15:02:38 INFO - 'MAIL': '/var/mail/cltbld', 15:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:38 INFO - 'MOZ_NO_REMOTE': '1', 15:02:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:38 INFO - 'NO_EM_RESTART': '1', 15:02:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:38 INFO - 'PWD': '/builds/slave/test', 15:02:38 INFO - 'SHELL': '/bin/bash', 15:02:38 INFO - 'SHLVL': '1', 15:02:38 INFO - 'TERM': 'linux', 15:02:38 INFO - 'TMOUT': '86400', 15:02:38 INFO - 'USER': 'cltbld', 15:02:38 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', 15:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:38 INFO - '_': '/tools/buildbot/bin/python'} 15:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:38 INFO - Downloading/unpacking jsonschema==2.5.1 15:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:02:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:40 INFO - Downloading functools32-3.2.3-2.tar.gz 15:02:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:02:40 INFO - warning: no files found matching '*.txt' 15:02:40 INFO - no previously-included directories found matching 'build' 15:02:40 INFO - no previously-included directories found matching 'dist' 15:02:40 INFO - no previously-included directories found matching '.git*' 15:02:40 INFO - Installing collected packages: jsonschema, functools32 15:02:40 INFO - Running setup.py install for functools32 15:02:40 INFO - warning: no files found matching '*.txt' 15:02:40 INFO - no previously-included directories found matching 'build' 15:02:40 INFO - no previously-included directories found matching 'dist' 15:02:40 INFO - no previously-included directories found matching '.git*' 15:02:40 INFO - Successfully installed jsonschema functools32 15:02:40 INFO - Cleaning up... 15:02:40 INFO - Return code: 0 15:02:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:02: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')]} 15:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02: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')]} 15:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x261a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2849400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8570>, '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 0x28d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d9900>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', '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 15:02:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:02:40 INFO - Using env: {'DISPLAY': ':0', 15:02:40 INFO - 'HOME': '/home/cltbld', 15:02:40 INFO - 'LANG': 'en_US.UTF-8', 15:02:40 INFO - 'LANGUAGE': 'en_US:en', 15:02:40 INFO - 'LOGNAME': 'cltbld', 15:02:40 INFO - 'MAIL': '/var/mail/cltbld', 15:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:40 INFO - 'MOZ_NO_REMOTE': '1', 15:02:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:40 INFO - 'NO_EM_RESTART': '1', 15:02:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:40 INFO - 'PWD': '/builds/slave/test', 15:02:40 INFO - 'SHELL': '/bin/bash', 15:02:40 INFO - 'SHLVL': '1', 15:02:40 INFO - 'TERM': 'linux', 15:02:40 INFO - 'TMOUT': '86400', 15:02:40 INFO - 'USER': 'cltbld', 15:02:40 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', 15:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:40 INFO - '_': '/tools/buildbot/bin/python'} 15:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:41 INFO - Downloading/unpacking blobuploader==1.2.4 15:02:41 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 15:02:41 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 15:02:41 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 15:02:41 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 15:02:41 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 15:02:41 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 15:02:43 INFO - Downloading blobuploader-1.2.4.tar.gz 15:02:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:02:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:02:43 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 15:02:43 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 15:02:43 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 15:02:43 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 15:02:43 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 15:02:43 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 15:02:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:02:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:02:43 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 15:02:43 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 15:02:43 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 15:02:43 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 15:02:43 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 15:02:43 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 15:02:43 INFO - Downloading docopt-0.6.1.tar.gz 15:02:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:02:43 INFO - Installing collected packages: blobuploader, requests, docopt 15:02:43 INFO - Running setup.py install for blobuploader 15:02:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:02:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:02:43 INFO - Running setup.py install for requests 15:02:44 INFO - Running setup.py install for docopt 15:02:44 INFO - Successfully installed blobuploader requests docopt 15:02:44 INFO - Cleaning up... 15:02:44 INFO - Return code: 0 15:02:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02: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')]} 15:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02: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')]} 15:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:44 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 0x261a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2849400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8570>, '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 0x28d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d9900>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', '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 15:02:44 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 15:02:44 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 15:02:44 INFO - Using env: {'DISPLAY': ':0', 15:02:44 INFO - 'HOME': '/home/cltbld', 15:02:44 INFO - 'LANG': 'en_US.UTF-8', 15:02:44 INFO - 'LANGUAGE': 'en_US:en', 15:02:44 INFO - 'LOGNAME': 'cltbld', 15:02:44 INFO - 'MAIL': '/var/mail/cltbld', 15:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:44 INFO - 'MOZ_NO_REMOTE': '1', 15:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:44 INFO - 'NO_EM_RESTART': '1', 15:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:44 INFO - 'PWD': '/builds/slave/test', 15:02:44 INFO - 'SHELL': '/bin/bash', 15:02:44 INFO - 'SHLVL': '1', 15:02:44 INFO - 'TERM': 'linux', 15:02:44 INFO - 'TMOUT': '86400', 15:02:44 INFO - 'USER': 'cltbld', 15:02:44 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', 15:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:44 INFO - '_': '/tools/buildbot/bin/python'} 15:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:02:44 INFO - Running setup.py (path:/tmp/pip-QF2CMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:02:44 INFO - Running setup.py (path:/tmp/pip-D0iJzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:02:44 INFO - Running setup.py (path:/tmp/pip-Hp_MhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:02:44 INFO - Running setup.py (path:/tmp/pip-7NwCEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:02:44 INFO - Running setup.py (path:/tmp/pip-mz0bH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:02:45 INFO - Running setup.py (path:/tmp/pip-E4eLUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:02:45 INFO - Running setup.py (path:/tmp/pip-u2V8Ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:02:45 INFO - Running setup.py (path:/tmp/pip-7hACUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:02:45 INFO - Running setup.py (path:/tmp/pip-1aQ6sN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:02:45 INFO - Running setup.py (path:/tmp/pip-NqpuVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:02:45 INFO - Running setup.py (path:/tmp/pip-Bwe51t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:02:45 INFO - Running setup.py (path:/tmp/pip-1MISNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:02:45 INFO - Running setup.py (path:/tmp/pip-_nK7bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:02:45 INFO - Running setup.py (path:/tmp/pip-PirFAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:45 INFO - Running setup.py (path:/tmp/pip-h06Pfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:02:45 INFO - Running setup.py (path:/tmp/pip-gq_H17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:02:45 INFO - Running setup.py (path:/tmp/pip-qgyJ7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:02:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:02:45 INFO - Running setup.py install for manifestparser 15:02:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:02:45 INFO - Running setup.py install for mozcrash 15:02:46 INFO - Running setup.py install for mozdebug 15:02:46 INFO - Running setup.py install for mozdevice 15:02:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:02:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:02:46 INFO - Running setup.py install for mozfile 15:02:46 INFO - Running setup.py install for mozhttpd 15:02:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:02:46 INFO - Running setup.py install for mozinfo 15:02:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:02:46 INFO - Running setup.py install for mozInstall 15:02:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:02:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:02:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:02:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:02:46 INFO - Running setup.py install for mozleak 15:02:46 INFO - Running setup.py install for mozlog 15:02:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:02:46 INFO - Running setup.py install for moznetwork 15:02:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:02:47 INFO - Running setup.py install for mozprocess 15:02:47 INFO - Running setup.py install for mozprofile 15:02:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:02:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:02:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:02:47 INFO - Running setup.py install for mozrunner 15:02:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:02:47 INFO - Running setup.py install for mozscreenshot 15:02:47 INFO - Running setup.py install for moztest 15:02:47 INFO - Running setup.py install for mozversion 15:02:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:02:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:02:47 INFO - Cleaning up... 15:02:47 INFO - Return code: 0 15:02:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02: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')]} 15:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02: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')]} 15:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:47 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 0x261a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2849400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8570>, '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 0x28d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d9900>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', '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 15:02:47 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 15:02:47 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 15:02:47 INFO - Using env: {'DISPLAY': ':0', 15:02:47 INFO - 'HOME': '/home/cltbld', 15:02:47 INFO - 'LANG': 'en_US.UTF-8', 15:02:47 INFO - 'LANGUAGE': 'en_US:en', 15:02:47 INFO - 'LOGNAME': 'cltbld', 15:02:47 INFO - 'MAIL': '/var/mail/cltbld', 15:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:47 INFO - 'MOZ_NO_REMOTE': '1', 15:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:47 INFO - 'NO_EM_RESTART': '1', 15:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:47 INFO - 'PWD': '/builds/slave/test', 15:02:47 INFO - 'SHELL': '/bin/bash', 15:02:47 INFO - 'SHLVL': '1', 15:02:47 INFO - 'TERM': 'linux', 15:02:47 INFO - 'TMOUT': '86400', 15:02:47 INFO - 'USER': 'cltbld', 15:02:47 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', 15:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:47 INFO - '_': '/tools/buildbot/bin/python'} 15:02:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:02:47 INFO - Running setup.py (path:/tmp/pip-5_bDLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:02:47 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)) 15:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:02:47 INFO - Running setup.py (path:/tmp/pip-Cc4bXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:02:48 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)) 15:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:02:48 INFO - Running setup.py (path:/tmp/pip-YNrsLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:02:48 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)) 15:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:02:48 INFO - Running setup.py (path:/tmp/pip-BPaTeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:02:48 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)) 15:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:02:48 INFO - Running setup.py (path:/tmp/pip-_1iH8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:02:48 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)) 15:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:02:48 INFO - Running setup.py (path:/tmp/pip-ZgloxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:02:48 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)) 15:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:02:48 INFO - Running setup.py (path:/tmp/pip-LPkOX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:02:48 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)) 15:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:02:48 INFO - Running setup.py (path:/tmp/pip-TXoQMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:02:48 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)) 15:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:02:48 INFO - Running setup.py (path:/tmp/pip-slcZs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:02:48 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)) 15:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:02:48 INFO - Running setup.py (path:/tmp/pip-c1Or8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:02:48 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)) 15:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:02:48 INFO - Running setup.py (path:/tmp/pip-0iTleR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:02:48 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)) 15:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:02:48 INFO - Running setup.py (path:/tmp/pip-cS9gAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:02:48 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)) 15:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:02:48 INFO - Running setup.py (path:/tmp/pip-eL4Jc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:02:48 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)) 15:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:02:48 INFO - Running setup.py (path:/tmp/pip-aaGXtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:02:48 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)) 15:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:48 INFO - Running setup.py (path:/tmp/pip-wbCDRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:48 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)) 15:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:02:48 INFO - Running setup.py (path:/tmp/pip-9ESCYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:02:49 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)) 15:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:02:49 INFO - Running setup.py (path:/tmp/pip-o4wBVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:02:49 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)) 15:02:49 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)) 15:02:49 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)) 15:02:49 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)) 15:02:49 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)) 15:02:49 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)) 15:02:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:51 INFO - Downloading blessings-1.6.tar.gz 15:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:02:51 INFO - Installing collected packages: blessings 15:02:51 INFO - Running setup.py install for blessings 15:02:51 INFO - Successfully installed blessings 15:02:51 INFO - Cleaning up... 15:02:51 INFO - Return code: 0 15:02:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:02:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:02:51 INFO - Reading from file tmpfile_stdout 15:02:51 INFO - Current package versions: 15:02:51 INFO - argparse == 1.2.1 15:02:51 INFO - blessings == 1.6 15:02:51 INFO - blobuploader == 1.2.4 15:02:51 INFO - docopt == 0.6.1 15:02:51 INFO - functools32 == 3.2.3-2 15:02:51 INFO - jsonschema == 2.5.1 15:02:51 INFO - manifestparser == 1.1 15:02:51 INFO - mozInstall == 1.12 15:02:51 INFO - mozcrash == 0.17 15:02:51 INFO - mozdebug == 0.1 15:02:51 INFO - mozdevice == 0.48 15:02:51 INFO - mozfile == 1.2 15:02:51 INFO - mozhttpd == 0.7 15:02:51 INFO - mozinfo == 0.9 15:02:51 INFO - mozleak == 0.1 15:02:51 INFO - mozlog == 3.2 15:02:51 INFO - moznetwork == 0.27 15:02:51 INFO - mozprocess == 0.23 15:02:51 INFO - mozprofile == 0.28 15:02:51 INFO - mozrunner == 6.12 15:02:51 INFO - mozscreenshot == 0.1 15:02:51 INFO - mozsystemmonitor == 0.3 15:02:51 INFO - moztest == 0.7 15:02:51 INFO - mozversion == 1.4 15:02:51 INFO - psutil == 3.1.1 15:02:51 INFO - requests == 1.2.3 15:02:51 INFO - wsgiref == 0.1.2 15:02:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:51 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 0x261a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2849400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8570>, '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 0x28d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d9900>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', '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 15:02:51 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 15:02:51 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 15:02:51 INFO - Using env: {'DISPLAY': ':0', 15:02:51 INFO - 'HOME': '/home/cltbld', 15:02:51 INFO - 'LANG': 'en_US.UTF-8', 15:02:51 INFO - 'LANGUAGE': 'en_US:en', 15:02:51 INFO - 'LOGNAME': 'cltbld', 15:02:51 INFO - 'MAIL': '/var/mail/cltbld', 15:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:51 INFO - 'MOZ_NO_REMOTE': '1', 15:02:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:51 INFO - 'NO_EM_RESTART': '1', 15:02:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:51 INFO - 'PWD': '/builds/slave/test', 15:02:51 INFO - 'SHELL': '/bin/bash', 15:02:51 INFO - 'SHLVL': '1', 15:02:51 INFO - 'TERM': 'linux', 15:02:51 INFO - 'TMOUT': '86400', 15:02:51 INFO - 'USER': 'cltbld', 15:02:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', 15:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:51 INFO - '_': '/tools/buildbot/bin/python'} 15:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:51 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)) 15:02:51 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)) 15:02:51 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)) 15:02:51 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)) 15:02:51 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)) 15:02:51 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)) 15:02:51 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)) 15:02:51 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)) 15:02:51 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)) 15:02:51 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)) 15:02:51 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)) 15:02:51 INFO - Cleaning up... 15:02:51 INFO - Return code: 0 15:02:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:51 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 0x261a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2849400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8570>, '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 0x28d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d9900>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', '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 15:02:51 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 15:02:51 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 15:02:51 INFO - Using env: {'DISPLAY': ':0', 15:02:51 INFO - 'HOME': '/home/cltbld', 15:02:51 INFO - 'LANG': 'en_US.UTF-8', 15:02:51 INFO - 'LANGUAGE': 'en_US:en', 15:02:51 INFO - 'LOGNAME': 'cltbld', 15:02:51 INFO - 'MAIL': '/var/mail/cltbld', 15:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:51 INFO - 'MOZ_NO_REMOTE': '1', 15:02:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:51 INFO - 'NO_EM_RESTART': '1', 15:02:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:51 INFO - 'PWD': '/builds/slave/test', 15:02:51 INFO - 'SHELL': '/bin/bash', 15:02:51 INFO - 'SHLVL': '1', 15:02:51 INFO - 'TERM': 'linux', 15:02:51 INFO - 'TMOUT': '86400', 15:02:51 INFO - 'USER': 'cltbld', 15:02:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', 15:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:51 INFO - '_': '/tools/buildbot/bin/python'} 15:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:02:51 INFO - Cleaning up... 15:02:51 INFO - Return code: 0 15:02:51 INFO - Running post-action listener: _resource_record_post_action 15:02:51 INFO - Running post-action listener: _start_resource_monitoring 15:02:51 INFO - Starting resource monitoring. 15:02:51 INFO - ##### 15:02:51 INFO - ##### Finished create-virtualenv step (success) 15:02:51 INFO - ##### 15:02:51 INFO - ##### 15:02:51 INFO - ##### Running install step. 15:02:51 INFO - ##### 15:02:51 INFO - Running pre-action listener: _resource_record_pre_action 15:02:51 INFO - Running main action method: install 15:02:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:02:52 INFO - Reading from file tmpfile_stdout 15:02:52 INFO - Detecting whether we're running mozinstall >=1.0... 15:02:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:02:52 INFO - Reading from file tmpfile_stdout 15:02:52 INFO - Output received: 15:02:52 INFO - Usage: mozinstall [options] installer 15:02:52 INFO - Options: 15:02:52 INFO - -h, --help show this help message and exit 15:02:52 INFO - -d DEST, --destination=DEST 15:02:52 INFO - Directory to install application into. [default: 15:02:52 INFO - "/builds/slave/test"] 15:02:52 INFO - --app=APP Application being installed. [default: firefox] 15:02:52 INFO - mkdir: /builds/slave/test/build/application 15:02:52 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'] 15:02:52 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 15:03:08 INFO - Reading from file tmpfile_stdout 15:03:08 INFO - Output received: 15:03:08 INFO - /builds/slave/test/build/application/firefox/firefox 15:03:08 INFO - Running post-action listener: _resource_record_post_action 15:03:08 INFO - ##### 15:03:08 INFO - ##### Finished install step (success) 15:03:08 INFO - ##### 15:03:08 INFO - ##### 15:03:08 INFO - ##### Running run-tests step. 15:03:08 INFO - ##### 15:03:08 INFO - Running pre-action listener: _resource_record_pre_action 15:03:08 INFO - Running main action method: run_tests 15:03:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:03:08 INFO - Python 2.7.3 15:03:08 INFO - Return code: 0 15:03:08 INFO - grabbing minidump binary from tooltool 15:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:08 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 0x28d8570>, '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 0x28d9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d9900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:03:08 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 15:03:08 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 15:03:08 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 15:03:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:03:09 INFO - Return code: 0 15:03:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:03:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:03:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:03:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:03:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:03:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 15:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 15:03:09 INFO - Using env: {'DISPLAY': ':0', 15:03:09 INFO - 'HOME': '/home/cltbld', 15:03:09 INFO - 'LANG': 'en_US.UTF-8', 15:03:09 INFO - 'LANGUAGE': 'en_US:en', 15:03:09 INFO - 'LOGNAME': 'cltbld', 15:03:09 INFO - 'MAIL': '/var/mail/cltbld', 15:03:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:03:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:09 INFO - 'MOZ_NO_REMOTE': '1', 15:03:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:09 INFO - 'NO_EM_RESTART': '1', 15:03:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:09 INFO - 'PWD': '/builds/slave/test', 15:03:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:03:09 INFO - 'SHELL': '/bin/bash', 15:03:09 INFO - 'SHLVL': '1', 15:03:09 INFO - 'TERM': 'linux', 15:03:09 INFO - 'TMOUT': '86400', 15:03:09 INFO - 'USER': 'cltbld', 15:03:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997', 15:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:09 INFO - '_': '/tools/buildbot/bin/python'} 15:03:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 15:03:09 INFO - mozversion application_buildid: 20160712142126 15:03:09 INFO - mozversion application_changeset: 9fb3a5f8b892765c7b877aa8541228fd0b5a1928 15:03:09 INFO - mozversion application_display_name: Nightly 15:03:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:03:09 INFO - mozversion application_name: Firefox 15:03:09 INFO - mozversion application_remotingname: firefox 15:03:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:03:09 INFO - mozversion application_vendor: Mozilla 15:03:09 INFO - mozversion application_version: 50.0a1 15:03:09 INFO - mozversion platform_buildid: 20160712142126 15:03:09 INFO - mozversion platform_changeset: 9fb3a5f8b892765c7b877aa8541228fd0b5a1928 15:03:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:03:09 INFO - mozversion platform_version: 50.0a1 15:03:09 INFO - using testdate: 1468360989 15:03:09 INFO - actual date: 1468360989 15:03:09 INFO - starting webserver on 'localhost:59651' 15:03:09 INFO - SUITE-START | Running 2 tests 15:03:09 INFO - TEST-START | dromaeo_css 15:03:09 INFO - operating with platform_type : linux_ 15:03:09 INFO - Initialising browser for dromaeo_css test... 15:03:09 INFO - TEST-INFO | started process 25240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3p1LHW/profile http://localhost:59651/getInfo.html) 15:03:14 INFO - PROCESS | 25240 | __metrics Screen width/height:1600/1200 15:03:14 INFO - PROCESS | 25240 | colorDepth:24 15:03:14 INFO - PROCESS | 25240 | Browser inner width/height: 1024/697 15:03:14 INFO - PROCESS | 25240 | __metrics 15:03:14 ERROR - PROCESS | 25240 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 15:03:15 INFO - TEST-INFO | 25240: exit 0 15:03:15 INFO - Browser initialized. 15:03:15 INFO - Running cycle 1/1 for dromaeo_css test... 15:03:15 INFO - TEST-INFO | started process 25360 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3p1LHW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:03:27 INFO - PROCESS | 25360 | RSS: Main: 169017344 15:03:27 INFO - PROCESS | 25360 | 15:04:17 INFO - PROCESS | 25360 | 1468361057055 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] 15:06:29 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:59651/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59651/tests/dromaeo/cssquery-ext.html) 15:06:30 INFO - PROCESS | 25360 | RSS: Main: 171368448 15:06:30 INFO - PROCESS | 25360 | 15:09:33 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:59651/tests/dromaeo/cssquery-ext.html (next: http://localhost:59651/tests/dromaeo/cssquery-jquery.html) 15:09:33 INFO - PROCESS | 25360 | RSS: Main: 168792064 15:09:33 INFO - PROCESS | 25360 | 15:12:35 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:59651/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59651/tests/dromaeo/cssquery-mootools.html) 15:12:36 INFO - PROCESS | 25360 | RSS: Main: 171892736 15:12:36 INFO - PROCESS | 25360 | 15:15:38 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:59651/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59651/tests/dromaeo/cssquery-prototype.html) 15:15:39 INFO - PROCESS | 25360 | RSS: Main: 167645184 15:15:39 INFO - PROCESS | 25360 | 15:18:41 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:59651/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59651/tests/dromaeo/cssquery-yui.html) 15:18:42 INFO - PROCESS | 25360 | RSS: Main: 169189376 15:18:42 INFO - PROCESS | 25360 | 15:21:45 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:59651/tests/dromaeo/cssquery-yui.html (next: http://localhost:59651/tests/dromaeo/cssquery-dojo.html) 15:21:45 INFO - PROCESS | 25360 | RSS: Main: 170164224 15:21:45 INFO - PROCESS | 25360 | 15:21:45 INFO - PROCESS | 25360 | __start_tp_report 15:21:45 INFO - PROCESS | 25360 | _x_x_mozilla_page_load 15:21:45 INFO - PROCESS | 25360 | _x_x_mozilla_page_load_details 15:21:45 INFO - PROCESS | 25360 | |i|pagename|runs| 15:21:45 INFO - PROCESS | 25360 | |0;dojo.html;2675.398035442026;2687.3550347916494;2698.0556805118204;2716.497447972124;2727.6317697110885;4836.588889944354;4887.6823006504555;4925.8029678812845;4938.234573641087;4945.480724523918;4655.813767449306;4809.783559739812;4811.2302031674935;4819.662623616348;4838.177509823329;4380.71525350852;4433.379326894237;4526.094781043805;4551.886202844922;4564.1328147652;155.72578706072014;4295.098029413827;4406.69153159279;4424.026714122888;4430.623397011242;4458.531854155316;4459.286514157751;4473.127740090684;4484.5291244419195;4530.660200484944;4452.532484089189;4499.932501012488;4502.549745025504;4509.751963641998;4535.387722657465;4276;4408.691391602589;4445.955540444619;4469.798859051318;4478.977605111986;4823.276508523714;4839.104765618372;4887.095887260833;4887.608991280725;4935.80256789728;5015.598752099823;5172.172452407597;5215.921761173586;5226.503482169188;5291.153415453509;5096.872578185575;5108.233764935252;5150.922736158961;5163.251328557338;5188.974055129738;4827.227643577046;4837.080954618611;4843.07981483517;4843.782029808667;4895.4370247422;5187.247849061865;5221.973890130601;5290.550303224269;5310.123829568155;5316.627836051517;5065.062963351792;5071.518205770446;5081.034603425337;5083.8983220335385;5086.847394578169;5236.162214045735;5237;5243.239730239094;5243.68537887728;5308.283381743492;5067.391912970394;5122.948770512247;5150.793968241228;5179.922301165486;5203.115470370046;5111.258867464197;5122.795088196505;5132.589392848563;5136.614753893398;5142.948570514322;4350.1734670412525;4361.694681372273;4372.540883207281;4376.409184760017;4409.669274804339;3718.6839118674675;3739.569949455793;3765.359888818907;3811.7522361047;3842.1739326045035;4463.308187230984;4477.686561940698;4488.573585509372;4534.0251845852645;4584.358189853423;5263.131583288715;5269.947300527022;5270.077736396115;5273.2617433559335;5279.445658205833;4405.889852753707;4453.064856380196;4456.955430445719;4505.346724724896;4509.030558429953;4611.792469338888;4638.698484598491;4638.907221855611;4640.86077417678;4696.530346965276;4696.74167920754;4879.121758083579;4888.560029597354;4907.33750943618;4939.234418665113;5188.325517682677;5249.921251181312;5257.63196576236;5302.681839089667;5332.840014799563;4905.730184839868;4932.161532539549;4940.456549779593;4969.751512424436;4988.825391111293;5003.2745251938995;5186.4554221807675;5198.246254293182;5204.453532379197;5216.295800066942;5137.409197942285;5159.613029022763;5232.843014709565;5238.319018527567;5240.737963101754;5016.724080175625;5016.799328026838;5032.144535428913;5059.696418214919;5074.543291103819;4921.064997650435;5014.42334131565;5019.573336266459;5019.623528235324;5026.421961474477;5005.249212618136;5017;5023.824166154167;5035.446100928968;5065.164247899055;5010.574101201439;5049.343585333883;5053.924191137209;5057.165567681292;5094.9490505095955;4936.432310284364;4942.44922942188;4942.654014218971;5015.3480047593575;5018.347614810052 15:21:45 INFO - PROCESS | 25360 | |1;ext.html;556.4963707844399;564.0523919814711;569.1349149293075;577.4629594477137;602.2171177469289;37111.44332835006;40204.99999999996;40212;40330.395044074365;40391.59608403915;40331.19337613246;40749.388759168636;40796.18407631846;40839.38740918889;40915;7650.655720492591;7781.766547003599;7835.098963619172;7854.214578542157;7872.921270787305;7796.142424333319;7886.369090472748;7901;7904;7915.8416831663335;7897.210278972086;7922.207779222089;7933.325667318285;7941.32498737608;7960.840783184332;7829;7842.568658723768;7854.607269636495;7884.960575197088;7899.763007109796;7785.104712957969;7843.137254901956;7847.803804904866;7868.449208555404;7884.526928384315;37996.81001594974;38338.42492362617;38497.615023849685;38605;38635.806820966;2483.3295010347106;2844.815087019337;2889.783266255018;2926.443975644642;2971.554266859967;26172.345691357677;27327.863360683266;27908.86045569759;28271.15186544407;28325.725342359645;3221.3396253767924;3271.8527666254836;3311.817850018248;3379.8310084495924;3381.03640462467;280521;280592;281196;281374;281448.59275703697;31898.20254493656;32738.672613273564;52854.471455285726;53646.46353536493;53732.82072561627;34360.82819585886;34385;34476.65523344785;34565.82717086399;34566;12621.558245461365;12640.178388404907;12700;12719.427625756864;12806.295653739135;10403.94798026005;10455.424951627581;10498.475076246157;10506;10545.578176872992;7880.921190788134;7922.801929951682;7998.240167184108;8031.076426211061;8040.075391329955;3108.3006323577015;3132.9530057049164;3141.6230052393857;3150.3384289299047;3207.6631953644533;892.4422236102436;894.8299823033602;993.64228877604;1004.0662184168793;1033.0599154769275;28042.158735237976;28752.856235719108;28760.424791504054;28843.278918026797;30865.537016944763;952.2239374909427;969.5249327829454;973.0609961387295;1032.7108409645311;1045.4929359260752;14416.495422660157;14799.70400591982;14875.404983800743;15006.399744010336;15180.392784288726;440839.7748067499;442881;443503;448884;449212;48317.5168248313;48771.512284877404;48852;48860.75569622129;48913.755431223326;1194.9614106469999;1205.8492688413949;1211.6062279759115;1220.7924652809045;1247.7192631657986;27141.05006324769;27960.72039279581;27997.860010699816;28117.43765124727;28495;43186.35220471758;43810.56189438065;43996.780016099714;44043.11913761771;44081.77959110184;381974;382077;385073;385584.8649081064;386111.8332900035;24564.263072107864;24579.877100615096;24929.50140997206;24957;25086.62370064487;41199.382009269284;41270;41855.58144418517;42044.36933446062;42176.36735448909;35456.82271588626;36050.819745901106;36263;36343.27313453769;36590.81704591567;35615.465768014015;36023.27953440969;36139.81930090333;36554.63445365619;36730.8163459181;34826.303473930886;35361.29277414489;35670.28659426745;35976.280474390886;35994.8200258997;30983;32225.51661725123;32787.83606081954;32968.34063318768;32974.50538241976;25039.749602503744;25205.87397063003;25490.41041438964;25555.616665749658;25681.871590641927 15:21:45 INFO - PROCESS | 25360 | |2;jquery.html;363.3532312483779;364.5206553382302;365.6434975898499;374.16934405619514;385.1718804570174;15418.152001639904;16801.327946882124;16960.151992400377;17423.91288043558;17493.387731429404;16203.189840507986;16680.916595417035;17275.395361162362;17278.136093195353;17382.391616293433;5002.9499705002845;5111.335526381566;5166.250893620423;5172.27588137661;5184.092783762845;3704.68510176634;5062.6962382257;5619.5785316101255;5932.050871860503;5935.554833387491;5911.674857882815;5924.6149000314845;5975.193348897887;5983.1025346197985;6008.609440386361;5889.734961926702;5933.643981361132;5951.345352011275;5977.521798256151;5986.730597123118;4560.863174104782;5058.266551350071;5140.665856719302;5230.875361797193;5232.189010703309;12338.691532711664;12855.164414313133;12866.614001579968;12899.09706320558;13198.67003324915;1923.8749481283671;1930.8165724256314;1994.411648563677;2355.316958082154;2442.6458163566363;8589.613467393981;8678.956605216996;8787.209151176425;8884.955575222082;8902.065283145306;1615.095546493967;1658.2206363009486;1687.308203636503;1687.6118492746737;1729.8356656117649;66989.66505167492;72765.6361718188;72867.63566182135;73169;73658.26341736567;9748.171405430476;10013.549390277454;10037.498125093716;10088.293819432569;10316.948415257875;13633.522826701017;13710.794338084937;13791.586252412444;13804;13844.10013349129;7017.47368947331;7081.716731330792;7132.465065120033;7148.46386521013;7189.92810071903;6747.224069232003;6772.8984065239065;6832.0776695146515;6884.208316043719;6912.101426814482;4250.936235956463;4312.633426158812;4415.735055896656;4432.84485043022;4495.707778994355;1672.573493759108;1735.1844633022458;1811.8641101917408;1863.4223390748912;1873.878197917131;757.4962649837906;872.9607167677469;902.3908861518448;907.6414816147585;916.4638686368415;16463.259153338127;16904.492865214062;17106.743398849027;17205.311787528357;17341.65316693659;866.250693150433;889.1997202517656;899.8425275576878;916.4821875640242;917.2570218123342;9547.665831695856;9689.467079310565;9794;9794.461304628314;10020.398776073458;302773;305795.35511612386;369376;373173;375104;84769;87705;87943;89152;90169;910.2854259406334;940.3088729783603;941.712777602824;959.9232061435068;961.3654987708079;15744.763828542353;16246.3501459945;16430.507084787474;16565.266730989253;16615.252313645673;38761.80619096886;40167.799161005176;40830.18339633131;41305.380419293135;41469.79265103655;55843.441565583824;56126.1581076276;59246.40753592409;59556;59714.10428843484;7651.923480765121;7762.534247945141;7927.801804954922;7942.960285198537;8071.596420179085;8963.282937365126;11584.13119016094;11997.76004479888;12006.939965300118;12427.067969902475;4797.664163508521;6930.584164950119;10633.787324253626;10668.359898406121;10740.087092597218;10069;10107.241956853119;10368.222383321432;10526.210534210119;10560.894391055992;10119.139873110573;10265.281430299807;10312.690619281433;10610.628627997983;10695.87693292193;7903.170167132368;7905.249001344863;7935.563544005136;7941.285284324438;8051.275385215359;8746.91253087461;9748.415095094317;10041.799164016533;10389.272750907365;10536.10443112344 15:21:45 INFO - PROCESS | 25360 | |3;mootools.html;1364.1542243808838;1417.8015077889095;1472.9631759206018;1673.1383337581156;1688.3415467967486;6452.741890324393;7053.329933656307;7312.378447831928;7619.161892191862;7620.1236857761305;7411;7430.851382972337;7490.812729681761;7491.101067871849;7508.2867127622785;2183.858049226803;2218.567379361017;2221.8444708870384;2229.487217939875;2234.944126396837;2154.4183070571016;2158.6438237690763;2218.301235110943;2224.944376390587;2232.8102111320477;2120.279105104264;2149.967750483744;2156.996996396675;2172.2071443922932;2219.178903805594;2161.9783802162015;2173.1090252996273;2175.793299636524;2179.106566307822;2181.4328274648706;2127.5319429725437;2141.764405915348;2154.5583155453096;2163.459135216196;2169.4142581502906;7465.552066875951;7498.925010749932;7499.100107987077;7551.886721699179;7565.621718914087;4486.75322857246;4591.83928562502;4607.44710634726;4607.953920460786;4615.492295847454;2786.4845003674386;2860.5423132298733;2875.5830404591425;2892.3203047283873;2915.28575499002;894.646614587241;900.9099090091004;904.7014485219928;935.8876934767803;935.9017303183135;9964.850527242097;9990.050945160197;9995;9997.950010249975;10004.449755263386;4003.3394489908837;4113.650339721157;4209.684273679425;4233.809478573472;4235.97882010588;8514.361422893184;8525.95737021311;8590.87113693295;8596.011458682207;8621;4454.77726113693;4463.04044630406;4472.0608672179205;4486.327050942385;4514.367988481616;3534.3461459630053;4004.3593025116425;4021.3364794809113;4052.2908491013955;4168.041350489404;3356.311956049004;3463.619001909788;3498.2478767065204;3515.261795023023;3521.2605352876185;1173.4602083041725;1179.9056075513938;1189.0309397840733;1193.9940300298442;1209.2200530657854;754.5171090502083;799.4204201953653;823.2261674026396;828.4739190613883;861.5950503263456;5061.240813877874;5249.107651699221;5297.655652382583;5307.150855863043;5358.115910874662;865.1910463716446;885.5793498088485;890.7238755985666;934.1312579301315;954.4607296877242;3472.340255351475;3614.548181477315;3634.5093412388987;3661.6521430464063;3689.4650275709873;8953.462792232487;9157.130072643089;9201.447913125234;9208.723738287863;9301.255899528021;9143.862842057375;9158.129977652112;9178.816423671622;9214.585343659552;9231.630734770668;6956.79129626112;7087.78736637912;7096.822579435556;7099.680514376865;7117.608531530712;5084.440711521655;5161.974190129025;5251.973740131275;5283.339582552181;5296.390915044665;8276.586170691562;8387.916120838714;8521.659133634834;8522;8550.187732165434;8187.754367368989;8420.284275836622;8580.356473264404;8718.476891386537;8751.781205469913;5533.889322213453;5899.616524925866;6115.357887421935;6140.140380346845;6230.43926046658;7298.2701729826595;7307.159676637255;7322.963385183253;7360.595167265637;7364.484486085923;6305.4009869062365;6439.261399422036;6469.805905822833;6526.151600291932;6547.410733034049;6591.868162636816;6595.604263744191;6660.56706314088;6678.632675202911;6682.365175308338;6170.259568851587;6254.437100660963;6255.155554000152;6256.3420693515345;6256.968715156395;4292.291771857734;4315.956840431555;4339.153864996296;4374.890627734332;4396.538363471917;4399.516053234206;4423.336499525097;4498.8425405110665;4515.774211289357;4665.5101214372 15:21:45 INFO - PROCESS | 25360 | |4;prototype.html;283.2197296448285;289.62927452860345;291.9868605912734;297.4734719546403;300.65725073416303;5123.333966584343;5142.974285128574;5168.741562921858;5175.628458458512;5176.559992400641;5045.77294021769;5049;5092.694438333693;5093.465186155456;5108.310378098965;3763.4731137640683;3894.5131858517684;3956.940645890314;3981;3981.6814654827544;3951.3677811550156;3973;3983.6215559521943;3997.1605962747713;3997.8200980955926;3956.9208615827665;3960.6237407446247;3964.425158352037;3967.940480892789;3974.841006359742;3692.7045836333295;3903.8243279052513;3905.1799122184375;3991.241664083829;3996.840126394941;3347.062822409729;3360.5295258663805;3360.6975372216616;3365.697087262158;3370.3933292007428;4896.53104068778;4906.632002599819;4910.263460480921;4927.926081108786;4941.950580494221;4285.985586774211;4433.534478879704;4446.911061778746;4456.420665313521;4460.30865215892;5182.144946083891;5186.7925282988635;5205.895882082337;5223.242629818655;5233.764480598382;3655;3670.6512881276235;3689.1883785567134;3694.501242332278;3704.3887758519813;5438.945610543923;5491.341039075336;5504.559635229172;5606;5613.831585052455;3615.4215325547784;3719.776813391205;3728.3848165052464;3764.2095160016156;3770.6417890300377;3792.27946690128;3812.1041555234497;3817.675497582681;3820.9044773880873;3827.10063135163;4394.780260986938;4407.559244075567;4411.029573493826;4412.24991751403;4415.315626077963;5107.923381149286;5283.199904050859;5290.418054014055;5293.285406470154;5340;1321.7885138378006;1327.183781974079;1331.9943442700699;1336.525533435636;1338.2171429713533;844.936629752771;848.1391387741447;860.9268212201907;864.831357885219;942.3450701762347;4396.780160991938;4514.480834703985;4553.408056952575;4562.384078149474;4568.611668008257;5296;5314.654547454403;5329.840104796862;5387.946120538744;5417.783288668488;4513.480949690827;4602.217623004098;4633.189191891405;4639.327297541838;4645.140648979949;2836.53197222456;2842.8294302341924;2844.9715502844706;2870;2872.195785180153;4987.850364489072;5029.698218106925;5034.521720436553;5045.2432135180015;5061.569766569809;5208.713520756395;5422.75597598109;5429.592780541396;5472.7263636818;5506.1190209566275;4956.628252881048;4982.9252561211615;4991.4758950310425;4998.275250088789;5029.698218106852;5339.172428273624;5343.946560534345;5357.892842143213;5360.410354860885;5385.219143224289;5031.597472202142;5249.973750131225;5386.865328366822;5407.972960135174;5436.53789427903;5162.9483705162465;5198.948010519997;5201.725577233602;5222.529972302511;5236.371635403776;3746.3328818675427;3747.5502939647417;3775.9244815104094;3777.792221427848;3785.886423407302;5198.972400763781;5489.231507588861;5498.882930071871;5503.449655034465;5595.412481689364;5303.628745987744;5364.673902180673;5391.838244852661;5401.299350324837;5404.702741349263;5135.768890399866;5312.618719132976;5337.25278461008;5388.353397592314;5396.541293990055;5226.529612334908;5258.842234732964;5266.868328291824;5269.78920843162;5283.128283833278;5093.617978651542;5258.447862974333;5283.815066472809;5310.522053015247;5333.626646134733;5203.583713303003;5220.590440581098;5237.109691352555;5254.343207099113;5279.762410691605 15:21:45 INFO - PROCESS | 25360 | |5;yui.html;624.4816802054295;642.367268240783;659.5383231737784;740.4890625468427;746.9551826890389;12423;13014.4143513542;13448.798268025987;13618.727625447485;13684.3157842108;13143.6714082148;13219.272939988297;13271.535496257633;13315.400806963686;13396.531121410753;631.2330518420118;768.7040489411589;787.6849260295885;804.3042768005662;806.0730160315625;799.596203917024;801.034753122489;802.6588699802589;806.3226889412892;809.6032943857497;834.4200780457585;844.7254642241265;849.0829903704016;851.4976164063202;854.4702284583567;838.1450920061565;838.1827717974986;841.898972123343;843.8776377425239;844.273924424994;612.0696541257308;614.0543562913108;616.2820314333795;616.4113271825396;618.0389494336305;13601.047926645138;13678.521251756141;13713.794293085612;13748.725025499534;13828.723425531534;14139.222342771143;14195;14305.356258968372;14349.856501434957;14503.057301275488;10640.114650381249;10824.78350432987;10972.451377431176;11004.944975275152;11048.834267485994;3295.5880514935634;3313.2545177335146;3358.697717205463;3382.3235352929514;3426.588809342895;69228.30771692269;69336;70003.2999670007;70927.64536177338;71064;9473.194778443773;9528.666496672722;9720.125188732907;11106.222564420414;11146.386948717736;18298.725519117223;18324.083795810155;18494.722579161054;18536.721949170773;18546.81453185451;6762.898556521656;6879.724811007603;6954.165500140016;6981;7075.893861592081;3684.115812205105;3764.228333191689;3860.4595356650093;3866.052817059838;3898.688104951597;2630.145202809095;2758.9378089435713;2766.488199683065;2770.362816552164;2774.5144599694972;501.333226808344;509.52868596548046;516.6925679220858;518.3002946022839;521.4889408379809;433.23750199648845;506.44797171083695;529.1665626638061;552.9032419326602;562.8846086552329;7366.484346095722;7601.46789724725;7711.344535714415;7730.961345193238;8409.654455287126;416.8603517821503;452.94791099024036;490.6516373374872;511.9180931051014;559.8488408129782;3204.1669166017004;3364.327134573095;3472.843722032464;3488.469933725019;3570.8214589270433;56073;82267.5886620575;93623;95864.52067739617;96524.51737741407;50849.23726144111;68534;81575;81674.18325816665;81848;45385.31922021172;55955.72022139863;59817.70091149603;62144.68927655423;65001;8378.455400398954;8419.789505262417;8428.410011299151;8453.66185352579;8677.609507572048;40925.59074409218;43958;44618.55381446144;45473.77263113796;45971.540284596726;57587.4241257582;64370.67814660897;64373;65209.673951631834;65883;11051.171162163031;11174.776504470028;11261.324320540794;11376.37429941328;11733.88266117362;13417.66455838612;13529.526466573623;13595.592132236048;13888.375023124187;14307.284635768377;11258.605948791754;11464.369459679798;11539.884601154217;12104.334261615695;12218.511259549874;12305.56930507428;12465.750684986431;12468.314242716375;12710.618681439571;13062.673433164247;10840.620578279722;11156.888431115909;11288;11295.7740845181;11880.524779008743;10184.134348580157;10443.268971172249;10489.370637761758;11002.229843910849;11003.762737915898;9710.563024663767;10329.793404132026;10426.68719938403;10472.68581942543;10525.210609204187 15:21:45 INFO - PROCESS | 25360 | __end_tp_report 15:21:45 INFO - PROCESS | 25360 | __start_cc_report 15:21:45 INFO - PROCESS | 25360 | _x_x_mozilla_cycle_collect,395 15:21:45 INFO - PROCESS | 25360 | __end_cc_report 15:21:45 INFO - PROCESS | 25360 | __startTimestamp1468362105536__endTimestamp 15:21:45 INFO - PROCESS | 25360 | 15:21:45 INFO - PROCESS | 25360 | ------- Summary: start ------- 15:21:45 INFO - PROCESS | 25360 | Number of tests: 6 15:21:45 INFO - PROCESS | 25360 | 15:21:45 INFO - PROCESS | 25360 | [#0] dojo.html Cycles:165 Average:4767.30 Median:4939.23 stddev:624.33 (12.6%) stddev-sans-first:604.29 15:21:45 INFO - PROCESS | 25360 | Values: 2675.4 2687.4 2698.1 2716.5 2727.6 4836.6 4887.7 4925.8 4938.2 4945.5 4655.8 4809.8 4811.2 4819.7 4838.2 4380.7 4433.4 4526.1 4551.9 4564.1 155.7 4295.1 4406.7 4424.0 4430.6 4458.5 4459.3 4473.1 4484.5 4530.7 4452.5 4499.9 4502.5 4509.8 4535.4 4276.0 4408.7 4446.0 4469.8 4479.0 4823.3 4839.1 4887.1 4887.6 4935.8 5015.6 5172.2 5215.9 5226.5 5291.2 5096.9 5108.2 5150.9 5163.3 5189.0 4827.2 4837.1 4843.1 4843.8 4895.4 5187.2 5222.0 5290.6 5310.1 5316.6 5065.1 5071.5 5081.0 5083.9 5086.8 5236.2 5237.0 5243.2 5243.7 5308.3 5067.4 5122.9 5150.8 5179.9 5203.1 5111.3 5122.8 5132.6 5136.6 5142.9 4350.2 4361.7 4372.5 4376.4 4409.7 3718.7 3739.6 3765.4 3811.8 3842.2 4463.3 4477.7 4488.6 4534.0 4584.4 5263.1 5269.9 5270.1 5273.3 5279.4 4405.9 4453.1 4457.0 4505.3 4509.0 4611.8 4638.7 4638.9 4640.9 4696.5 4696.7 4879.1 4888.6 4907.3 4939.2 5188.3 5249.9 5257.6 5302.7 5332.8 4905.7 4932.2 4940.5 4969.8 4988.8 5003.3 5186.5 5198.2 5204.5 5216.3 5137.4 5159.6 5232.8 5238.3 5240.7 5016.7 5016.8 5032.1 5059.7 5074.5 4921.1 5014.4 5019.6 5019.6 5026.4 5005.2 5017.0 5023.8 5035.4 5065.2 5010.6 5049.3 5053.9 5057.2 5094.9 4936.4 4942.4 4942.7 5015.3 5018.3 15:21:45 INFO - PROCESS | 25360 | 15:21:45 INFO - PROCESS | 25360 | [#1] ext.html Cycles:180 Average:50451.37 Median:36201.41 stddev:99799.24 (275.7%) stddev-sans-first:100008.89 15:21:45 INFO - PROCESS | 25360 | Values: 556.5 564.1 569.1 577.5 602.2 37111.4 40205.0 40212.0 40330.4 40391.6 40331.2 40749.4 40796.2 40839.4 40915.0 7650.7 7781.8 7835.1 7854.2 7872.9 7796.1 7886.4 7901.0 7904.0 7915.8 7897.2 7922.2 7933.3 7941.3 7960.8 7829.0 7842.6 7854.6 7885.0 7899.8 7785.1 7843.1 7847.8 7868.4 7884.5 37996.8 38338.4 38497.6 38605.0 38635.8 2483.3 2844.8 2889.8 2926.4 2971.6 26172.3 27327.9 27908.9 28271.2 28325.7 3221.3 3271.9 3311.8 3379.8 3381.0 280521.0 280592.0 281196.0 281374.0 281448.6 31898.2 32738.7 52854.5 53646.5 53732.8 34360.8 34385.0 34476.7 34565.8 34566.0 12621.6 12640.2 12700.0 12719.4 12806.3 10403.9 10455.4 10498.5 10506.0 10545.6 7880.9 7922.8 7998.2 8031.1 8040.1 3108.3 3133.0 3141.6 3150.3 3207.7 892.4 894.8 993.6 1004.1 1033.1 28042.2 28752.9 28760.4 28843.3 30865.5 952.2 969.5 973.1 1032.7 1045.5 14416.5 14799.7 14875.4 15006.4 15180.4 440839.8 442881.0 443503.0 448884.0 449212.0 48317.5 48771.5 48852.0 48860.8 48913.8 1195.0 1205.8 1211.6 1220.8 1247.7 27141.1 27960.7 27997.9 28117.4 28495.0 43186.4 43810.6 43996.8 44043.1 44081.8 381974.0 382077.0 385073.0 385584.9 386111.8 24564.3 24579.9 24929.5 24957.0 25086.6 41199.4 41270.0 41855.6 42044.4 42176.4 35456.8 36050.8 36263.0 36343.3 36590.8 35615.5 36023.3 36139.8 36554.6 36730.8 34826.3 35361.3 35670.3 35976.3 35994.8 30983.0 32225.5 32787.8 32968.3 32974.5 25039.7 25205.9 25490.4 25555.6 25681.9 15:21:45 INFO - PROCESS | 25360 | 15:21:45 INFO - PROCESS | 25360 | [#2] jquery.html Cycles:180 Average:23524.58 Median:4528.29 stddev:58140.07 (1283.9%) stddev-sans-first:58277.16 15:21:45 INFO - PROCESS | 25360 | Values: 363.4 364.5 365.6 374.2 385.2 15418.2 16801.3 16960.2 17423.9 17493.4 16203.2 16680.9 17275.4 17278.1 17382.4 5002.9 5111.3 5166.3 5172.3 5184.1 3704.7 5062.7 5619.6 5932.1 5935.6 5911.7 5924.6 5975.2 5983.1 6008.6 5889.7 5933.6 5951.3 5977.5 5986.7 4560.9 5058.3 5140.7 5230.9 5232.2 12338.7 12855.2 12866.6 12899.1 13198.7 1923.9 1930.8 1994.4 2355.3 2442.6 8589.6 8679.0 8787.2 8885.0 8902.1 1615.1 1658.2 1687.3 1687.6 1729.8 66989.7 72765.6 72867.6 73169.0 73658.3 9748.2 10013.5 10037.5 10088.3 10316.9 13633.5 13710.8 13791.6 13804.0 13844.1 7017.5 7081.7 7132.5 7148.5 7189.9 6747.2 6772.9 6832.1 6884.2 6912.1 4250.9 4312.6 4415.7 4432.8 4495.7 1672.6 1735.2 1811.9 1863.4 1873.9 757.5 873.0 902.4 907.6 916.5 16463.3 16904.5 17106.7 17205.3 17341.7 866.3 889.2 899.8 916.5 917.3 9547.7 9689.5 9794.0 9794.5 10020.4 302773.0 305795.4 369376.0 373173.0 375104.0 84769.0 87705.0 87943.0 89152.0 90169.0 910.3 940.3 941.7 959.9 961.4 15744.8 16246.4 16430.5 16565.3 16615.3 38761.8 40167.8 40830.2 41305.4 41469.8 55843.4 56126.2 59246.4 59556.0 59714.1 7651.9 7762.5 7927.8 7943.0 8071.6 8963.3 11584.1 11997.8 12006.9 12427.1 4797.7 6930.6 10633.8 10668.4 10740.1 10069.0 10107.2 10368.2 10526.2 10560.9 10119.1 10265.3 10312.7 10610.6 10695.9 7903.2 7905.2 7935.6 7941.3 8051.3 8746.9 9748.4 10041.8 10389.3 10536.1 15:21:45 INFO - PROCESS | 25360 | 15:21:45 INFO - PROCESS | 25360 | [#3] mootools.html Cycles:180 Average:4958.46 Median:5446.00 stddev:2699.15 (49.6%) stddev-sans-first:2693.20 15:21:45 INFO - PROCESS | 25360 | Values: 1364.2 1417.8 1473.0 1673.1 1688.3 6452.7 7053.3 7312.4 7619.2 7620.1 7411.0 7430.9 7490.8 7491.1 7508.3 2183.9 2218.6 2221.8 2229.5 2234.9 2154.4 2158.6 2218.3 2224.9 2232.8 2120.3 2150.0 2157.0 2172.2 2219.2 2162.0 2173.1 2175.8 2179.1 2181.4 2127.5 2141.8 2154.6 2163.5 2169.4 7465.6 7498.9 7499.1 7551.9 7565.6 4486.8 4591.8 4607.4 4608.0 4615.5 2786.5 2860.5 2875.6 2892.3 2915.3 894.6 900.9 904.7 935.9 935.9 9964.9 9990.1 9995.0 9998.0 10004.4 4003.3 4113.7 4209.7 4233.8 4236.0 8514.4 8526.0 8590.9 8596.0 8621.0 4454.8 4463.0 4472.1 4486.3 4514.4 3534.3 4004.4 4021.3 4052.3 4168.0 3356.3 3463.6 3498.2 3515.3 3521.3 1173.5 1179.9 1189.0 1194.0 1209.2 754.5 799.4 823.2 828.5 861.6 5061.2 5249.1 5297.7 5307.2 5358.1 865.2 885.6 890.7 934.1 954.5 3472.3 3614.5 3634.5 3661.7 3689.5 8953.5 9157.1 9201.4 9208.7 9301.3 9143.9 9158.1 9178.8 9214.6 9231.6 6956.8 7087.8 7096.8 7099.7 7117.6 5084.4 5162.0 5252.0 5283.3 5296.4 8276.6 8387.9 8521.7 8522.0 8550.2 8187.8 8420.3 8580.4 8718.5 8751.8 5533.9 5899.6 6115.4 6140.1 6230.4 7298.3 7307.2 7323.0 7360.6 7364.5 6305.4 6439.3 6469.8 6526.2 6547.4 6591.9 6595.6 6660.6 6678.6 6682.4 6170.3 6254.4 6255.2 6256.3 6257.0 4292.3 4316.0 4339.2 4374.9 4396.5 4399.5 4423.3 4498.8 4515.8 4665.5 15:21:45 INFO - PROCESS | 25360 | 15:21:45 INFO - PROCESS | 25360 | [#4] prototype.html Cycles:180 Average:4363.92 Median:5029.70 stddev:1283.87 (25.5%) stddev-sans-first:1250.41 15:21:45 INFO - PROCESS | 25360 | Values: 283.2 289.6 292.0 297.5 300.7 5123.3 5143.0 5168.7 5175.6 5176.6 5045.8 5049.0 5092.7 5093.5 5108.3 3763.5 3894.5 3956.9 3981.0 3981.7 3951.4 3973.0 3983.6 3997.2 3997.8 3956.9 3960.6 3964.4 3967.9 3974.8 3692.7 3903.8 3905.2 3991.2 3996.8 3347.1 3360.5 3360.7 3365.7 3370.4 4896.5 4906.6 4910.3 4927.9 4942.0 4286.0 4433.5 4446.9 4456.4 4460.3 5182.1 5186.8 5205.9 5223.2 5233.8 3655.0 3670.7 3689.2 3694.5 3704.4 5438.9 5491.3 5504.6 5606.0 5613.8 3615.4 3719.8 3728.4 3764.2 3770.6 3792.3 3812.1 3817.7 3820.9 3827.1 4394.8 4407.6 4411.0 4412.2 4415.3 5107.9 5283.2 5290.4 5293.3 5340.0 1321.8 1327.2 1332.0 1336.5 1338.2 844.9 848.1 860.9 864.8 942.3 4396.8 4514.5 4553.4 4562.4 4568.6 5296.0 5314.7 5329.8 5387.9 5417.8 4513.5 4602.2 4633.2 4639.3 4645.1 2836.5 2842.8 2845.0 2870.0 2872.2 4987.9 5029.7 5034.5 5045.2 5061.6 5208.7 5422.8 5429.6 5472.7 5506.1 4956.6 4982.9 4991.5 4998.3 5029.7 5339.2 5343.9 5357.9 5360.4 5385.2 5031.6 5250.0 5386.9 5408.0 5436.5 5162.9 5198.9 5201.7 5222.5 5236.4 3746.3 3747.6 3775.9 3777.8 3785.9 5199.0 5489.2 5498.9 5503.4 5595.4 5303.6 5364.7 5391.8 5401.3 5404.7 5135.8 5312.6 5337.3 5388.4 5396.5 5226.5 5258.8 5266.9 5269.8 5283.1 5093.6 5258.4 5283.8 5310.5 5333.6 5203.6 5220.6 5237.1 5254.3 5279.8 15:21:45 INFO - PROCESS | 25360 | 15:21:45 INFO - PROCESS | 25360 | [#5] yui.html Cycles:180 Average:16984.07 Median:22535.75 stddev:23214.85 (103.0%) stddev-sans-first:23247.47 15:21:45 INFO - PROCESS | 25360 | Values: 624.5 642.4 659.5 740.5 747.0 12423.0 13014.4 13448.8 13618.7 13684.3 13143.7 13219.3 13271.5 13315.4 13396.5 631.2 768.7 787.7 804.3 806.1 799.6 801.0 802.7 806.3 809.6 834.4 844.7 849.1 851.5 854.5 838.1 838.2 841.9 843.9 844.3 612.1 614.1 616.3 616.4 618.0 13601.0 13678.5 13713.8 13748.7 13828.7 14139.2 14195.0 14305.4 14349.9 14503.1 10640.1 10824.8 10972.5 11004.9 11048.8 3295.6 3313.3 3358.7 3382.3 3426.6 69228.3 69336.0 70003.3 70927.6 71064.0 9473.2 9528.7 9720.1 11106.2 11146.4 18298.7 18324.1 18494.7 18536.7 18546.8 6762.9 6879.7 6954.2 6981.0 7075.9 3684.1 3764.2 3860.5 3866.1 3898.7 2630.1 2758.9 2766.5 2770.4 2774.5 501.3 509.5 516.7 518.3 521.5 433.2 506.4 529.2 552.9 562.9 7366.5 7601.5 7711.3 7731.0 8409.7 416.9 452.9 490.7 511.9 559.8 3204.2 3364.3 3472.8 3488.5 3570.8 56073.0 82267.6 93623.0 95864.5 96524.5 50849.2 68534.0 81575.0 81674.2 81848.0 45385.3 55955.7 59817.7 62144.7 65001.0 8378.5 8419.8 8428.4 8453.7 8677.6 40925.6 43958.0 44618.6 45473.8 45971.5 57587.4 64370.7 64373.0 65209.7 65883.0 11051.2 11174.8 11261.3 11376.4 11733.9 13417.7 13529.5 13595.6 13888.4 14307.3 11258.6 11464.4 11539.9 12104.3 12218.5 12305.6 12465.8 12468.3 12710.6 13062.7 10840.6 11156.9 11288.0 11295.8 11880.5 10184.1 10443.3 10489.4 11002.2 11003.8 9710.6 10329.8 10426.7 10472.7 10525.2 15:21:45 INFO - PROCESS | 25360 | -------- Summary: end -------- 15:21:45 INFO - PROCESS | 25360 | 15:21:46 INFO - TEST-INFO | 25360: exit 0 15:21:46 INFO - TEST-OK | dromaeo_css | took 1117156ms 15:21:46 INFO - TEST-START | kraken 15:21:46 INFO - operating with platform_type : linux_ 15:21:46 INFO - Initialising browser for kraken test... 15:21:46 INFO - TEST-INFO | started process 25597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp8_5KB/profile http://localhost:59651/getInfo.html) 15:21:51 INFO - PROCESS | 25597 | __metrics Screen width/height:1600/1200 15:21:51 INFO - PROCESS | 25597 | colorDepth:24 15:21:51 INFO - PROCESS | 25597 | Browser inner width/height: 1024/697 15:21:51 INFO - PROCESS | 25597 | __metrics 15:21:51 ERROR - PROCESS | 25597 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 15:21:52 INFO - TEST-INFO | 25597: exit 0 15:21:52 INFO - Browser initialized. 15:21:52 INFO - Running cycle 1/1 for kraken test... 15:21:52 INFO - TEST-INFO | started process 25716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp8_5KB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:22:04 INFO - PROCESS | 25716 | RSS: Main: 168886272 15:22:04 INFO - PROCESS | 25716 | 15:22:07 INFO - PROCESS | 25716 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59651/tests/kraken/driver.html?testName=audio-beat-detection) 15:22:08 INFO - PROCESS | 25716 | RSS: Main: 174432256 15:22:08 INFO - PROCESS | 25716 | 15:22:10 INFO - PROCESS | 25716 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59651/tests/kraken/driver.html?testName=audio-dft) 15:22:11 INFO - PROCESS | 25716 | RSS: Main: 174133248 15:22:11 INFO - PROCESS | 25716 | 15:22:14 INFO - PROCESS | 25716 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59651/tests/kraken/driver.html?testName=audio-fft) 15:22:15 INFO - PROCESS | 25716 | RSS: Main: 168427520 15:22:15 INFO - PROCESS | 25716 | 15:22:17 INFO - PROCESS | 25716 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59651/tests/kraken/driver.html?testName=audio-oscillator) 15:22:17 INFO - PROCESS | 25716 | RSS: Main: 169078784 15:22:17 INFO - PROCESS | 25716 | 15:22:20 INFO - PROCESS | 25716 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59651/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:22:20 INFO - PROCESS | 25716 | RSS: Main: 169414656 15:22:20 INFO - PROCESS | 25716 | 15:22:23 INFO - PROCESS | 25716 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59651/tests/kraken/driver.html?testName=imaging-darkroom) 15:22:24 INFO - PROCESS | 25716 | RSS: Main: 169828352 15:22:24 INFO - PROCESS | 25716 | 15:22:28 INFO - PROCESS | 25716 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59651/tests/kraken/driver.html?testName=imaging-desaturate) 15:22:28 INFO - PROCESS | 25716 | RSS: Main: 167927808 15:22:28 INFO - PROCESS | 25716 | 15:22:31 INFO - PROCESS | 25716 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59651/tests/kraken/driver.html?testName=json-parse-financial) 15:22:32 INFO - PROCESS | 25716 | RSS: Main: 168951808 15:22:32 INFO - PROCESS | 25716 | 15:22:34 INFO - PROCESS | 25716 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59651/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:22:34 INFO - PROCESS | 25716 | RSS: Main: 169656320 15:22:34 INFO - PROCESS | 25716 | 15:22:36 INFO - PROCESS | 25716 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59651/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:22:37 INFO - PROCESS | 25716 | RSS: Main: 169512960 15:22:37 INFO - PROCESS | 25716 | 15:22:39 INFO - PROCESS | 25716 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59651/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:22:40 INFO - PROCESS | 25716 | RSS: Main: 169947136 15:22:40 INFO - PROCESS | 25716 | 15:22:42 INFO - PROCESS | 25716 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:22:43 INFO - PROCESS | 25716 | RSS: Main: 169783296 15:22:43 INFO - PROCESS | 25716 | 15:22:46 INFO - PROCESS | 25716 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:22:47 INFO - PROCESS | 25716 | RSS: Main: 169885696 15:22:47 INFO - PROCESS | 25716 | 15:22:48 INFO - PROCESS | 25716 | Cycle 1(1): loaded http://localhost:59651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59651/tests/kraken/driver.html?testName=ai-astar) 15:22:49 INFO - PROCESS | 25716 | RSS: Main: 170663936 15:22:49 INFO - PROCESS | 25716 | 15:22:49 INFO - PROCESS | 25716 | __start_tp_report 15:22:49 INFO - PROCESS | 25716 | _x_x_mozilla_page_load 15:22:49 INFO - PROCESS | 25716 | _x_x_mozilla_page_load_details 15:22:49 INFO - PROCESS | 25716 | |i|pagename|runs| 15:22:49 INFO - PROCESS | 25716 | |0;ai-astar;106;114;111;119;114;118;116;117;115;114 15:22:49 INFO - PROCESS | 25716 | |1;audio-beat-detection;159;126;146;167;125;153;153;126;185;130 15:22:49 INFO - PROCESS | 25716 | |2;audio-dft;162;162;162;170;168;161;165;163;165;163 15:22:49 INFO - PROCESS | 25716 | |3;audio-fft;75;78;79;150;79;76;76;76;169;77 15:22:49 INFO - PROCESS | 25716 | |4;audio-oscillator;87;85;149;86;86;86;141;86;85;137 15:22:49 INFO - PROCESS | 25716 | |5;imaging-gaussian-blur;118;119;117;118;117;118;118;126;118;119 15:22:49 INFO - PROCESS | 25716 | |6;imaging-darkroom;148;149;148;149;149;149;149;148;148;147 15:22:49 INFO - PROCESS | 25716 | |7;imaging-desaturate;96;95;96;100;96;97;96;96;95;95 15:22:49 INFO - PROCESS | 25716 | |8;json-parse-financial;64;64;63;65;64;64;65;63;63;72 15:22:49 INFO - PROCESS | 25716 | |9;json-stringify-tinderbox;65;65;66;65;65;66;64;64;65;65 15:22:49 INFO - PROCESS | 25716 | |10;stanford-crypto-aes;81;80;85;83;81;80;80;86;85;80 15:22:49 INFO - PROCESS | 25716 | |11;stanford-crypto-ccm;142;135;137;133;145;143;133;142;175;137 15:22:49 INFO - PROCESS | 25716 | |12;stanford-crypto-pbkdf2;174;171;170;171;167;172;175;170;173;170 15:22:49 INFO - PROCESS | 25716 | |13;stanford-crypto-sha256-iterative;73;69;68;68;70;68;72;71;66;73 15:22:49 INFO - PROCESS | 25716 | __end_tp_report 15:22:49 INFO - PROCESS | 25716 | __start_cc_report 15:22:49 INFO - PROCESS | 25716 | _x_x_mozilla_cycle_collect,965 15:22:49 INFO - PROCESS | 25716 | __end_cc_report 15:22:49 INFO - PROCESS | 25716 | __startTimestamp1468362169113__endTimestamp 15:22:49 INFO - PROCESS | 25716 | 15:22:49 INFO - PROCESS | 25716 | ------- Summary: start ------- 15:22:49 INFO - PROCESS | 25716 | Number of tests: 14 15:22:49 INFO - PROCESS | 25716 | 15:22:49 INFO - PROCESS | 25716 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.50 stddev:3.75 (3.2%) stddev-sans-first:2.45 15:22:49 INFO - PROCESS | 25716 | Values: 106.0 114.0 111.0 119.0 114.0 118.0 116.0 117.0 115.0 114.0 15:22:49 INFO - PROCESS | 25716 | 15:22:49 INFO - PROCESS | 25716 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:153.00 stddev:20.32 (13.3%) stddev-sans-first:21.08 15:22:49 INFO - PROCESS | 25716 | Values: 159.0 126.0 146.0 167.0 125.0 153.0 153.0 126.0 185.0 130.0 15:22:49 INFO - PROCESS | 25716 | 15:22:49 INFO - PROCESS | 25716 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.92 (1.8%) stddev-sans-first:3.00 15:22:49 INFO - PROCESS | 25716 | Values: 162.0 162.0 162.0 170.0 168.0 161.0 165.0 163.0 165.0 163.0 15:22:49 INFO - PROCESS | 25716 | 15:22:49 INFO - PROCESS | 25716 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.50 stddev:35.10 (45.9%) stddev-sans-first:36.58 15:22:49 INFO - PROCESS | 25716 | Values: 75.0 78.0 79.0 150.0 79.0 76.0 76.0 76.0 169.0 77.0 15:22:49 INFO - PROCESS | 25716 | 15:22:49 INFO - PROCESS | 25716 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:86.00 stddev:27.44 (31.9%) stddev-sans-first:28.50 15:22:49 INFO - PROCESS | 25716 | Values: 87.0 85.0 149.0 86.0 86.0 86.0 141.0 86.0 85.0 137.0 15:22:49 INFO - PROCESS | 25716 | 15:22:49 INFO - PROCESS | 25716 | [#5] imaging-gaussian-blur Cycles:10 Average:118.80 Median:118.00 stddev:2.62 (2.2%) stddev-sans-first:2.76 15:22:49 INFO - PROCESS | 25716 | Values: 118.0 119.0 117.0 118.0 117.0 118.0 118.0 126.0 118.0 119.0 15:22:49 INFO - PROCESS | 25716 | 15:22:49 INFO - PROCESS | 25716 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 15:22:49 INFO - PROCESS | 25716 | Values: 148.0 149.0 148.0 149.0 149.0 149.0 149.0 148.0 148.0 147.0 15:22:49 INFO - PROCESS | 25716 | 15:22:49 INFO - PROCESS | 25716 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.48 (1.5%) stddev-sans-first:1.56 15:22:49 INFO - PROCESS | 25716 | Values: 96.0 95.0 96.0 100.0 96.0 97.0 96.0 96.0 95.0 95.0 15:22:49 INFO - PROCESS | 25716 | 15:22:49 INFO - PROCESS | 25716 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:64.00 stddev:2.67 (4.2%) stddev-sans-first:2.82 15:22:49 INFO - PROCESS | 25716 | Values: 64.0 64.0 63.0 65.0 64.0 64.0 65.0 63.0 63.0 72.0 15:22:49 INFO - PROCESS | 25716 | 15:22:49 INFO - PROCESS | 25716 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 15:22:49 INFO - PROCESS | 25716 | Values: 65.0 65.0 66.0 65.0 65.0 66.0 64.0 64.0 65.0 65.0 15:22:49 INFO - PROCESS | 25716 | 15:22:49 INFO - PROCESS | 25716 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:2.42 (3.0%) stddev-sans-first:2.54 15:22:49 INFO - PROCESS | 25716 | Values: 81.0 80.0 85.0 83.0 81.0 80.0 80.0 86.0 85.0 80.0 15:22:49 INFO - PROCESS | 25716 | 15:22:49 INFO - PROCESS | 25716 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:142.00 stddev:12.29 (8.7%) stddev-sans-first:13.04 15:22:49 INFO - PROCESS | 25716 | Values: 142.0 135.0 137.0 133.0 145.0 143.0 133.0 142.0 175.0 137.0 15:22:49 INFO - PROCESS | 25716 | 15:22:49 INFO - PROCESS | 25716 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:171.50 stddev:2.31 (1.3%) stddev-sans-first:2.24 15:22:49 INFO - PROCESS | 25716 | Values: 174.0 171.0 170.0 171.0 167.0 172.0 175.0 170.0 173.0 170.0 15:22:49 INFO - PROCESS | 25716 | 15:22:49 INFO - PROCESS | 25716 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.50 stddev:2.39 (3.4%) stddev-sans-first:2.24 15:22:49 INFO - PROCESS | 25716 | Values: 73.0 69.0 68.0 68.0 70.0 68.0 72.0 71.0 66.0 73.0 15:22:49 INFO - PROCESS | 25716 | -------- Summary: end -------- 15:22:49 INFO - PROCESS | 25716 | 15:22:50 INFO - TEST-INFO | 25716: exit 0 15:22:50 INFO - TEST-OK | kraken | took 63801ms 15:22:50 INFO - SUITE-END | took 1180s 15:22:50 INFO - Completed test suite (00:19:41) 15:22:50 INFO - javascript benchmark 15:22:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6366.9622376262505, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2675.398035442026, 2687.3550347916494, 2698.0556805118204, 2716.497447972124, 2727.6317697110885, 4836.588889944354, 4887.6823006504555, 4925.8029678812845, 4938.234573641087, 4945.480724523918, 4655.813767449306, 4809.783559739812, 4811.2302031674935, 4819.662623616348, 4838.177509823329, 4380.71525350852, 4433.379326894237, 4526.094781043805, 4551.886202844922, 4564.1328147652, 155.72578706072014, 4295.098029413827, 4406.69153159279, 4424.026714122888, 4430.623397011242, 4458.531854155316, 4459.286514157751, 4473.127740090684, 4484.5291244419195, 4530.660200484944, 4452.532484089189, 4499.932501012488, 4502.549745025504, 4509.751963641998, 4535.387722657465, 4276.0, 4408.691391602589, 4445.955540444619, 4469.798859051318, 4478.977605111986, 4823.276508523714, 4839.104765618372, 4887.095887260833, 4887.608991280725, 4935.80256789728, 5015.598752099823, 5172.172452407597, 5215.921761173586, 5226.503482169188, 5291.153415453509, 5096.872578185575, 5108.233764935252, 5150.922736158961, 5163.251328557338, 5188.974055129738, 4827.227643577046, 4837.080954618611, 4843.07981483517, 4843.782029808667, 4895.4370247422, 5187.247849061865, 5221.973890130601, 5290.550303224269, 5310.123829568155, 5316.627836051517, 5065.062963351792, 5071.518205770446, 5081.034603425337, 5083.8983220335385, 5086.847394578169, 5236.162214045735, 5237.0, 5243.239730239094, 5243.68537887728, 5308.283381743492, 5067.391912970394, 5122.948770512247, 5150.793968241228, 5179.922301165486, 5203.115470370046, 5111.258867464197, 5122.795088196505, 5132.589392848563, 5136.614753893398, 5142.948570514322, 4350.1734670412525, 4361.694681372273, 4372.540883207281, 4376.409184760017, 4409.669274804339, 3718.6839118674675, 3739.569949455793, 3765.359888818907, 3811.7522361047, 3842.1739326045035, 4463.308187230984, 4477.686561940698, 4488.573585509372, 4534.0251845852645, 4584.358189853423, 5263.131583288715, 5269.947300527022, 5270.077736396115, 5273.2617433559335, 5279.445658205833, 4405.889852753707, 4453.064856380196, 4456.955430445719, 4505.346724724896, 4509.030558429953, 4611.792469338888, 4638.698484598491, 4638.907221855611, 4640.86077417678, 4696.530346965276, 4696.74167920754, 4879.121758083579, 4888.560029597354, 4907.33750943618, 4939.234418665113, 5188.325517682677, 5249.921251181312, 5257.63196576236, 5302.681839089667, 5332.840014799563, 4905.730184839868, 4932.161532539549, 4940.456549779593, 4969.751512424436, 4988.825391111293, 5003.2745251938995, 5186.4554221807675, 5198.246254293182, 5204.453532379197, 5216.295800066942, 5137.409197942285, 5159.613029022763, 5232.843014709565, 5238.319018527567, 5240.737963101754, 5016.724080175625, 5016.799328026838, 5032.144535428913, 5059.696418214919, 5074.543291103819, 4921.064997650435, 5014.42334131565, 5019.573336266459, 5019.623528235324, 5026.421961474477, 5005.249212618136, 5017.0, 5023.824166154167, 5035.446100928968, 5065.164247899055, 5010.574101201439, 5049.343585333883, 5053.924191137209, 5057.165567681292, 5094.9490505095955, 4936.432310284364, 4942.44922942188, 4942.654014218971, 5015.3480047593575, 5018.347614810052], "value": 4729.051393875723, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.4963707844399, 564.0523919814711, 569.1349149293075, 577.4629594477137, 602.2171177469289, 37111.44332835006, 40204.99999999996, 40212.0, 40330.395044074365, 40391.59608403915, 40331.19337613246, 40749.388759168636, 40796.18407631846, 40839.38740918889, 40915.0, 7650.655720492591, 7781.766547003599, 7835.098963619172, 7854.214578542157, 7872.921270787305, 7796.142424333319, 7886.369090472748, 7901.0, 7904.0, 7915.8416831663335, 7897.210278972086, 7922.207779222089, 7933.325667318285, 7941.32498737608, 7960.840783184332, 7829.0, 7842.568658723768, 7854.607269636495, 7884.960575197088, 7899.763007109796, 7785.104712957969, 7843.137254901956, 7847.803804904866, 7868.449208555404, 7884.526928384315, 37996.81001594974, 38338.42492362617, 38497.615023849685, 38605.0, 38635.806820966, 2483.3295010347106, 2844.815087019337, 2889.783266255018, 2926.443975644642, 2971.554266859967, 26172.345691357677, 27327.863360683266, 27908.86045569759, 28271.15186544407, 28325.725342359645, 3221.3396253767924, 3271.8527666254836, 3311.817850018248, 3379.8310084495924, 3381.03640462467, 280521.0, 280592.0, 281196.0, 281374.0, 281448.59275703697, 31898.20254493656, 32738.672613273564, 52854.471455285726, 53646.46353536493, 53732.82072561627, 34360.82819585886, 34385.0, 34476.65523344785, 34565.82717086399, 34566.0, 12621.558245461365, 12640.178388404907, 12700.0, 12719.427625756864, 12806.295653739135, 10403.94798026005, 10455.424951627581, 10498.475076246157, 10506.0, 10545.578176872992, 7880.921190788134, 7922.801929951682, 7998.240167184108, 8031.076426211061, 8040.075391329955, 3108.3006323577015, 3132.9530057049164, 3141.6230052393857, 3150.3384289299047, 3207.6631953644533, 892.4422236102436, 894.8299823033602, 993.64228877604, 1004.0662184168793, 1033.0599154769275, 28042.158735237976, 28752.856235719108, 28760.424791504054, 28843.278918026797, 30865.537016944763, 952.2239374909427, 969.5249327829454, 973.0609961387295, 1032.7108409645311, 1045.4929359260752, 14416.495422660157, 14799.70400591982, 14875.404983800743, 15006.399744010336, 15180.392784288726, 440839.7748067499, 442881.0, 443503.0, 448884.0, 449212.0, 48317.5168248313, 48771.512284877404, 48852.0, 48860.75569622129, 48913.755431223326, 1194.9614106469999, 1205.8492688413949, 1211.6062279759115, 1220.7924652809045, 1247.7192631657986, 27141.05006324769, 27960.72039279581, 27997.860010699816, 28117.43765124727, 28495.0, 43186.35220471758, 43810.56189438065, 43996.780016099714, 44043.11913761771, 44081.77959110184, 381974.0, 382077.0, 385073.0, 385584.8649081064, 386111.8332900035, 24564.263072107864, 24579.877100615096, 24929.50140997206, 24957.0, 25086.62370064487, 41199.382009269284, 41270.0, 41855.58144418517, 42044.36933446062, 42176.36735448909, 35456.82271588626, 36050.819745901106, 36263.0, 36343.27313453769, 36590.81704591567, 35615.465768014015, 36023.27953440969, 36139.81930090333, 36554.63445365619, 36730.8163459181, 34826.303473930886, 35361.29277414489, 35670.28659426745, 35976.280474390886, 35994.8200258997, 30983.0, 32225.51661725123, 32787.83606081954, 32968.34063318768, 32974.50538241976, 25039.749602503744, 25205.87397063003, 25490.41041438964, 25555.616665749658, 25681.871590641927], "value": 16590.818728497725, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.3532312483779, 364.5206553382302, 365.6434975898499, 374.16934405619514, 385.1718804570174, 15418.152001639904, 16801.327946882124, 16960.151992400377, 17423.91288043558, 17493.387731429404, 16203.189840507986, 16680.916595417035, 17275.395361162362, 17278.136093195353, 17382.391616293433, 5002.9499705002845, 5111.335526381566, 5166.250893620423, 5172.27588137661, 5184.092783762845, 3704.68510176634, 5062.6962382257, 5619.5785316101255, 5932.050871860503, 5935.554833387491, 5911.674857882815, 5924.6149000314845, 5975.193348897887, 5983.1025346197985, 6008.609440386361, 5889.734961926702, 5933.643981361132, 5951.345352011275, 5977.521798256151, 5986.730597123118, 4560.863174104782, 5058.266551350071, 5140.665856719302, 5230.875361797193, 5232.189010703309, 12338.691532711664, 12855.164414313133, 12866.614001579968, 12899.09706320558, 13198.67003324915, 1923.8749481283671, 1930.8165724256314, 1994.411648563677, 2355.316958082154, 2442.6458163566363, 8589.613467393981, 8678.956605216996, 8787.209151176425, 8884.955575222082, 8902.065283145306, 1615.095546493967, 1658.2206363009486, 1687.308203636503, 1687.6118492746737, 1729.8356656117649, 66989.66505167492, 72765.6361718188, 72867.63566182135, 73169.0, 73658.26341736567, 9748.171405430476, 10013.549390277454, 10037.498125093716, 10088.293819432569, 10316.948415257875, 13633.522826701017, 13710.794338084937, 13791.586252412444, 13804.0, 13844.10013349129, 7017.47368947331, 7081.716731330792, 7132.465065120033, 7148.46386521013, 7189.92810071903, 6747.224069232003, 6772.8984065239065, 6832.0776695146515, 6884.208316043719, 6912.101426814482, 4250.936235956463, 4312.633426158812, 4415.735055896656, 4432.84485043022, 4495.707778994355, 1672.573493759108, 1735.1844633022458, 1811.8641101917408, 1863.4223390748912, 1873.878197917131, 757.4962649837906, 872.9607167677469, 902.3908861518448, 907.6414816147585, 916.4638686368415, 16463.259153338127, 16904.492865214062, 17106.743398849027, 17205.311787528357, 17341.65316693659, 866.250693150433, 889.1997202517656, 899.8425275576878, 916.4821875640242, 917.2570218123342, 9547.665831695856, 9689.467079310565, 9794.0, 9794.461304628314, 10020.398776073458, 302773.0, 305795.35511612386, 369376.0, 373173.0, 375104.0, 84769.0, 87705.0, 87943.0, 89152.0, 90169.0, 910.2854259406334, 940.3088729783603, 941.712777602824, 959.9232061435068, 961.3654987708079, 15744.763828542353, 16246.3501459945, 16430.507084787474, 16565.266730989253, 16615.252313645673, 38761.80619096886, 40167.799161005176, 40830.18339633131, 41305.380419293135, 41469.79265103655, 55843.441565583824, 56126.1581076276, 59246.40753592409, 59556.0, 59714.10428843484, 7651.923480765121, 7762.534247945141, 7927.801804954922, 7942.960285198537, 8071.596420179085, 8963.282937365126, 11584.13119016094, 11997.76004479888, 12006.939965300118, 12427.067969902475, 4797.664163508521, 6930.584164950119, 10633.787324253626, 10668.359898406121, 10740.087092597218, 10069.0, 10107.241956853119, 10368.222383321432, 10526.210534210119, 10560.894391055992, 10119.139873110573, 10265.281430299807, 10312.690619281433, 10610.628627997983, 10695.87693292193, 7903.170167132368, 7905.249001344863, 7935.563544005136, 7941.285284324438, 8051.275385215359, 8746.91253087461, 9748.415095094317, 10041.799164016533, 10389.272750907365, 10536.10443112344], "value": 8184.6219579486615, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.1542243808838, 1417.8015077889095, 1472.9631759206018, 1673.1383337581156, 1688.3415467967486, 6452.741890324393, 7053.329933656307, 7312.378447831928, 7619.161892191862, 7620.1236857761305, 7411.0, 7430.851382972337, 7490.812729681761, 7491.101067871849, 7508.2867127622785, 2183.858049226803, 2218.567379361017, 2221.8444708870384, 2229.487217939875, 2234.944126396837, 2154.4183070571016, 2158.6438237690763, 2218.301235110943, 2224.944376390587, 2232.8102111320477, 2120.279105104264, 2149.967750483744, 2156.996996396675, 2172.2071443922932, 2219.178903805594, 2161.9783802162015, 2173.1090252996273, 2175.793299636524, 2179.106566307822, 2181.4328274648706, 2127.5319429725437, 2141.764405915348, 2154.5583155453096, 2163.459135216196, 2169.4142581502906, 7465.552066875951, 7498.925010749932, 7499.100107987077, 7551.886721699179, 7565.621718914087, 4486.75322857246, 4591.83928562502, 4607.44710634726, 4607.953920460786, 4615.492295847454, 2786.4845003674386, 2860.5423132298733, 2875.5830404591425, 2892.3203047283873, 2915.28575499002, 894.646614587241, 900.9099090091004, 904.7014485219928, 935.8876934767803, 935.9017303183135, 9964.850527242097, 9990.050945160197, 9995.0, 9997.950010249975, 10004.449755263386, 4003.3394489908837, 4113.650339721157, 4209.684273679425, 4233.809478573472, 4235.97882010588, 8514.361422893184, 8525.95737021311, 8590.87113693295, 8596.011458682207, 8621.0, 4454.77726113693, 4463.04044630406, 4472.0608672179205, 4486.327050942385, 4514.367988481616, 3534.3461459630053, 4004.3593025116425, 4021.3364794809113, 4052.2908491013955, 4168.041350489404, 3356.311956049004, 3463.619001909788, 3498.2478767065204, 3515.261795023023, 3521.2605352876185, 1173.4602083041725, 1179.9056075513938, 1189.0309397840733, 1193.9940300298442, 1209.2200530657854, 754.5171090502083, 799.4204201953653, 823.2261674026396, 828.4739190613883, 861.5950503263456, 5061.240813877874, 5249.107651699221, 5297.655652382583, 5307.150855863043, 5358.115910874662, 865.1910463716446, 885.5793498088485, 890.7238755985666, 934.1312579301315, 954.4607296877242, 3472.340255351475, 3614.548181477315, 3634.5093412388987, 3661.6521430464063, 3689.4650275709873, 8953.462792232487, 9157.130072643089, 9201.447913125234, 9208.723738287863, 9301.255899528021, 9143.862842057375, 9158.129977652112, 9178.816423671622, 9214.585343659552, 9231.630734770668, 6956.79129626112, 7087.78736637912, 7096.822579435556, 7099.680514376865, 7117.608531530712, 5084.440711521655, 5161.974190129025, 5251.973740131275, 5283.339582552181, 5296.390915044665, 8276.586170691562, 8387.916120838714, 8521.659133634834, 8522.0, 8550.187732165434, 8187.754367368989, 8420.284275836622, 8580.356473264404, 8718.476891386537, 8751.781205469913, 5533.889322213453, 5899.616524925866, 6115.357887421935, 6140.140380346845, 6230.43926046658, 7298.2701729826595, 7307.159676637255, 7322.963385183253, 7360.595167265637, 7364.484486085923, 6305.4009869062365, 6439.261399422036, 6469.805905822833, 6526.151600291932, 6547.410733034049, 6591.868162636816, 6595.604263744191, 6660.56706314088, 6678.632675202911, 6682.365175308338, 6170.259568851587, 6254.437100660963, 6255.155554000152, 6256.3420693515345, 6256.968715156395, 4292.291771857734, 4315.956840431555, 4339.153864996296, 4374.890627734332, 4396.538363471917, 4399.516053234206, 4423.336499525097, 4498.8425405110665, 4515.774211289357, 4665.5101214372], "value": 4041.6722053863746, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.2197296448285, 289.62927452860345, 291.9868605912734, 297.4734719546403, 300.65725073416303, 5123.333966584343, 5142.974285128574, 5168.741562921858, 5175.628458458512, 5176.559992400641, 5045.77294021769, 5049.0, 5092.694438333693, 5093.465186155456, 5108.310378098965, 3763.4731137640683, 3894.5131858517684, 3956.940645890314, 3981.0, 3981.6814654827544, 3951.3677811550156, 3973.0, 3983.6215559521943, 3997.1605962747713, 3997.8200980955926, 3956.9208615827665, 3960.6237407446247, 3964.425158352037, 3967.940480892789, 3974.841006359742, 3692.7045836333295, 3903.8243279052513, 3905.1799122184375, 3991.241664083829, 3996.840126394941, 3347.062822409729, 3360.5295258663805, 3360.6975372216616, 3365.697087262158, 3370.3933292007428, 4896.53104068778, 4906.632002599819, 4910.263460480921, 4927.926081108786, 4941.950580494221, 4285.985586774211, 4433.534478879704, 4446.911061778746, 4456.420665313521, 4460.30865215892, 5182.144946083891, 5186.7925282988635, 5205.895882082337, 5223.242629818655, 5233.764480598382, 3655.0, 3670.6512881276235, 3689.1883785567134, 3694.501242332278, 3704.3887758519813, 5438.945610543923, 5491.341039075336, 5504.559635229172, 5606.0, 5613.831585052455, 3615.4215325547784, 3719.776813391205, 3728.3848165052464, 3764.2095160016156, 3770.6417890300377, 3792.27946690128, 3812.1041555234497, 3817.675497582681, 3820.9044773880873, 3827.10063135163, 4394.780260986938, 4407.559244075567, 4411.029573493826, 4412.24991751403, 4415.315626077963, 5107.923381149286, 5283.199904050859, 5290.418054014055, 5293.285406470154, 5340.0, 1321.7885138378006, 1327.183781974079, 1331.9943442700699, 1336.525533435636, 1338.2171429713533, 844.936629752771, 848.1391387741447, 860.9268212201907, 864.831357885219, 942.3450701762347, 4396.780160991938, 4514.480834703985, 4553.408056952575, 4562.384078149474, 4568.611668008257, 5296.0, 5314.654547454403, 5329.840104796862, 5387.946120538744, 5417.783288668488, 4513.480949690827, 4602.217623004098, 4633.189191891405, 4639.327297541838, 4645.140648979949, 2836.53197222456, 2842.8294302341924, 2844.9715502844706, 2870.0, 2872.195785180153, 4987.850364489072, 5029.698218106925, 5034.521720436553, 5045.2432135180015, 5061.569766569809, 5208.713520756395, 5422.75597598109, 5429.592780541396, 5472.7263636818, 5506.1190209566275, 4956.628252881048, 4982.9252561211615, 4991.4758950310425, 4998.275250088789, 5029.698218106852, 5339.172428273624, 5343.946560534345, 5357.892842143213, 5360.410354860885, 5385.219143224289, 5031.597472202142, 5249.973750131225, 5386.865328366822, 5407.972960135174, 5436.53789427903, 5162.9483705162465, 5198.948010519997, 5201.725577233602, 5222.529972302511, 5236.371635403776, 3746.3328818675427, 3747.5502939647417, 3775.9244815104094, 3777.792221427848, 3785.886423407302, 5198.972400763781, 5489.231507588861, 5498.882930071871, 5503.449655034465, 5595.412481689364, 5303.628745987744, 5364.673902180673, 5391.838244852661, 5401.299350324837, 5404.702741349263, 5135.768890399866, 5312.618719132976, 5337.25278461008, 5388.353397592314, 5396.541293990055, 5226.529612334908, 5258.842234732964, 5266.868328291824, 5269.78920843162, 5283.128283833278, 5093.617978651542, 5258.447862974333, 5283.815066472809, 5310.522053015247, 5333.626646134733, 5203.583713303003, 5220.590440581098, 5237.109691352555, 5254.343207099113, 5279.762410691605], "value": 3948.8975777675882, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.4816802054295, 642.367268240783, 659.5383231737784, 740.4890625468427, 746.9551826890389, 12423.0, 13014.4143513542, 13448.798268025987, 13618.727625447485, 13684.3157842108, 13143.6714082148, 13219.272939988297, 13271.535496257633, 13315.400806963686, 13396.531121410753, 631.2330518420118, 768.7040489411589, 787.6849260295885, 804.3042768005662, 806.0730160315625, 799.596203917024, 801.034753122489, 802.6588699802589, 806.3226889412892, 809.6032943857497, 834.4200780457585, 844.7254642241265, 849.0829903704016, 851.4976164063202, 854.4702284583567, 838.1450920061565, 838.1827717974986, 841.898972123343, 843.8776377425239, 844.273924424994, 612.0696541257308, 614.0543562913108, 616.2820314333795, 616.4113271825396, 618.0389494336305, 13601.047926645138, 13678.521251756141, 13713.794293085612, 13748.725025499534, 13828.723425531534, 14139.222342771143, 14195.0, 14305.356258968372, 14349.856501434957, 14503.057301275488, 10640.114650381249, 10824.78350432987, 10972.451377431176, 11004.944975275152, 11048.834267485994, 3295.5880514935634, 3313.2545177335146, 3358.697717205463, 3382.3235352929514, 3426.588809342895, 69228.30771692269, 69336.0, 70003.2999670007, 70927.64536177338, 71064.0, 9473.194778443773, 9528.666496672722, 9720.125188732907, 11106.222564420414, 11146.386948717736, 18298.725519117223, 18324.083795810155, 18494.722579161054, 18536.721949170773, 18546.81453185451, 6762.898556521656, 6879.724811007603, 6954.165500140016, 6981.0, 7075.893861592081, 3684.115812205105, 3764.228333191689, 3860.4595356650093, 3866.052817059838, 3898.688104951597, 2630.145202809095, 2758.9378089435713, 2766.488199683065, 2770.362816552164, 2774.5144599694972, 501.333226808344, 509.52868596548046, 516.6925679220858, 518.3002946022839, 521.4889408379809, 433.23750199648845, 506.44797171083695, 529.1665626638061, 552.9032419326602, 562.8846086552329, 7366.484346095722, 7601.46789724725, 7711.344535714415, 7730.961345193238, 8409.654455287126, 416.8603517821503, 452.94791099024036, 490.6516373374872, 511.9180931051014, 559.8488408129782, 3204.1669166017004, 3364.327134573095, 3472.843722032464, 3488.469933725019, 3570.8214589270433, 56073.0, 82267.5886620575, 93623.0, 95864.52067739617, 96524.51737741407, 50849.23726144111, 68534.0, 81575.0, 81674.18325816665, 81848.0, 45385.31922021172, 55955.72022139863, 59817.70091149603, 62144.68927655423, 65001.0, 8378.455400398954, 8419.789505262417, 8428.410011299151, 8453.66185352579, 8677.609507572048, 40925.59074409218, 43958.0, 44618.55381446144, 45473.77263113796, 45971.540284596726, 57587.4241257582, 64370.67814660897, 64373.0, 65209.673951631834, 65883.0, 11051.171162163031, 11174.776504470028, 11261.324320540794, 11376.37429941328, 11733.88266117362, 13417.66455838612, 13529.526466573623, 13595.592132236048, 13888.375023124187, 14307.284635768377, 11258.605948791754, 11464.369459679798, 11539.884601154217, 12104.334261615695, 12218.511259549874, 12305.56930507428, 12465.750684986431, 12468.314242716375, 12710.618681439571, 13062.673433164247, 10840.620578279722, 11156.888431115909, 11288.0, 11295.7740845181, 11880.524779008743, 10184.134348580157, 10443.268971172249, 10489.370637761758, 11002.229843910849, 11003.762737915898, 9710.563024663767, 10329.793404132026, 10426.68719938403, 10472.68581942543, 10525.210609204187], "value": 6499.35351410653, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 111.0, 119.0, 114.0, 118.0, 116.0, 117.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 126.0, 146.0, 167.0, 125.0, 153.0, 153.0, 126.0, 185.0, 130.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 170.0, 168.0, 161.0, 165.0, 163.0, 165.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 79.0, 150.0, 79.0, 76.0, 76.0, 76.0, 169.0, 77.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 149.0, 86.0, 86.0, 86.0, 141.0, 86.0, 85.0, 137.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 118.0, 117.0, 118.0, 118.0, 126.0, 118.0, 119.0], "value": 118.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 149.0, 149.0, 149.0, 149.0, 148.0, 148.0, 147.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 100.0, 96.0, 97.0, 96.0, 96.0, 95.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 65.0, 64.0, 64.0, 65.0, 63.0, 63.0, 72.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 64.0, 64.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 85.0, 83.0, 81.0, 80.0, 80.0, 86.0, 85.0, 80.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 135.0, 137.0, 133.0, 145.0, 143.0, 133.0, 142.0, 175.0, 137.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 171.0, 170.0, 171.0, 167.0, 172.0, 175.0, 170.0, 173.0, 170.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 69.0, 68.0, 68.0, 70.0, 68.0, 72.0, 71.0, 66.0, 73.0], "value": 69.8, "unit": "score"}]}]} 15:22:50 INFO - Return code: 0 15:22:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:22:50 ERROR - # TBPL SUCCESS # 15:22:50 INFO - Running post-action listener: _resource_record_post_action 15:22:50 INFO - ##### 15:22:50 INFO - ##### Finished run-tests step (success) 15:22:50 INFO - ##### 15:22:50 INFO - Running post-run listener: _resource_record_post_run 15:22:50 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12288; Write bytes: 541732864; Read time: 268; Write time: 558196 15:22:50 INFO - TinderboxPrint: CPU usage
13.3% 15:22:50 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 268 15:22:50 INFO - TinderboxPrint: I/O write bytes / time
541,732,864 / 558,196 15:22:50 INFO - TinderboxPrint: CPU idle
8,287.2 (86.7%) 15:22:50 INFO - TinderboxPrint: CPU user
1,219.5 (12.8%) 15:22:50 INFO - TinderboxPrint: Swap in / out
0 / 0 15:22:50 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253030400; Read time: 0; Write time: 294888 15:22:50 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 12288; Write bytes: 288423936; Read time: 268; Write time: 263288 15:22:51 INFO - Running post-run listener: _upload_blobber_files 15:22:51 INFO - Blob upload gear active. 15:22:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:22:51 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 15:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:22:51 INFO - (blobuploader) - INFO - Open directory for files ... 15:22:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:22:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:22:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:52 INFO - (blobuploader) - INFO - Done attempting. 15:22:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:22:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:22:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:52 INFO - (blobuploader) - INFO - Done attempting. 15:22:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:22:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:22:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:57 INFO - (blobuploader) - INFO - Done attempting. 15:22:57 INFO - (blobuploader) - INFO - Iteration through files over. 15:22:57 INFO - Return code: 0 15:22:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:22:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:22:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7eab96bcb660aab62bfffc299dde3c0d7f12c913b9518aef548afe767237cb38bc85c96b7fc9594c08bad80d2475b91689b65ec291995b4926f2204bfbcc35d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c88629155c9bb0c6e4d5e9af382c7fb1f6c8472450d6f86e5e1fcc2fd523596639106422ce0573ee8ed3f05579a181b75e5be29cf11da3d847654c49cc7f0e47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/297ebffbf3154468f65ffa761205cad7352ac2e3e91903118b9034b42ff8de6e45bcb5909d23d51cb0b5dea4969f0a0fd53cb8e19e751bc397fa78e31d098695"} 15:22:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:22:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:22:57 INFO - Contents: 15:22:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7eab96bcb660aab62bfffc299dde3c0d7f12c913b9518aef548afe767237cb38bc85c96b7fc9594c08bad80d2475b91689b65ec291995b4926f2204bfbcc35d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c88629155c9bb0c6e4d5e9af382c7fb1f6c8472450d6f86e5e1fcc2fd523596639106422ce0573ee8ed3f05579a181b75e5be29cf11da3d847654c49cc7f0e47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/297ebffbf3154468f65ffa761205cad7352ac2e3e91903118b9034b42ff8de6e45bcb5909d23d51cb0b5dea4969f0a0fd53cb8e19e751bc397fa78e31d098695"} 15:22:57 INFO - Running post-run listener: copy_logs_to_upload_dir 15:22:57 INFO - Copying logs to upload dir... 15:22:57 INFO - mkdir: /builds/slave/test/build/upload/logs 15:22:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.836418 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-12 15:22:57.010282) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 15:22:57.013959) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7eab96bcb660aab62bfffc299dde3c0d7f12c913b9518aef548afe767237cb38bc85c96b7fc9594c08bad80d2475b91689b65ec291995b4926f2204bfbcc35d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c88629155c9bb0c6e4d5e9af382c7fb1f6c8472450d6f86e5e1fcc2fd523596639106422ce0573ee8ed3f05579a181b75e5be29cf11da3d847654c49cc7f0e47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/297ebffbf3154468f65ffa761205cad7352ac2e3e91903118b9034b42ff8de6e45bcb5909d23d51cb0b5dea4969f0a0fd53cb8e19e751bc397fa78e31d098695"} build_url:https://queue.taskcluster.net/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/ICxnFLgER4ChM_-iieoMRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7eab96bcb660aab62bfffc299dde3c0d7f12c913b9518aef548afe767237cb38bc85c96b7fc9594c08bad80d2475b91689b65ec291995b4926f2204bfbcc35d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c88629155c9bb0c6e4d5e9af382c7fb1f6c8472450d6f86e5e1fcc2fd523596639106422ce0573ee8ed3f05579a181b75e5be29cf11da3d847654c49cc7f0e47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/297ebffbf3154468f65ffa761205cad7352ac2e3e91903118b9034b42ff8de6e45bcb5909d23d51cb0b5dea4969f0a0fd53cb8e19e751bc397fa78e31d098695"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 15:22:57.039164) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 15:22:57.039550) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1468360063.20517-1262745997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 15:22:57.125570) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 15:22:57.125949) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 15:22:57.126326) ========= ========= Total master_lag: 0.16 =========