builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1468343340.66 results: success (0) buildid: 20160712094026 builduid: 41c0f26d65414ff5839e40fc4e204e25 revision: 489d075c767662a205ddf09cb609786203889911 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 10:09:00.664080) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 10:09:00.664722) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 10:09:00.665060) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 10:09:00.680400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 10:09:00.680792) ========= 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=df17445c3590ff7897617a0e00000225-1468342715.103934-535090140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 10:09: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 213M=0s 2016-07-12 10:09:00 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113842 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 10:09:00.809174) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 10:09:00.809547) ========= 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=df17445c3590ff7897617a0e00000225-1468342715.103934-535090140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023147 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 10:09:00.859917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-12 10:09:00.860322) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 489d075c767662a205ddf09cb609786203889911 --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 489d075c767662a205ddf09cb609786203889911 --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=df17445c3590ff7897617a0e00000225-1468342715.103934-535090140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 10:09:00,957 truncating revision to first 12 chars 2016-07-12 10:09:00,957 Setting DEBUG logging. 2016-07-12 10:09:00,957 attempt 1/10 2016-07-12 10:09:00,957 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/489d075c7676?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 10:09:02,350 unpacking tar archive at: fx-team-489d075c7676/testing/mozharness/ program finished with exit code 0 elapsedTime=1.749463 ========= master_lag: 0.36 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-12 10:09:02.967204) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 10:09:02.967588) ========= script_repo_revision: 489d075c767662a205ddf09cb609786203889911 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 10:09:02.968063) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 10:09:02.968368) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 10:09:03.013723) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-07-12 10:09:03.014061) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=df17445c3590ff7897617a0e00000225-1468342715.103934-535090140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:09:03 INFO - MultiFileLogger online at 20160712 10:09:03 in /builds/slave/test 10:09:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:09:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:09:03 INFO - {'append_to_log': False, 10:09:03 INFO - 'base_work_dir': '/builds/slave/test', 10:09:03 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:09:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:09:03 INFO - 'branch': 'Fx-Team-Non-PGO', 10:09:03 INFO - 'buildbot_json_path': 'buildprops.json', 10:09:03 INFO - 'config_files': ('talos/linux_config.py',), 10:09:03 INFO - 'default_actions': ('clobber', 10:09:03 INFO - 'read-buildbot-config', 10:09:03 INFO - 'download-and-extract', 10:09:03 INFO - 'populate-webroot', 10:09:03 INFO - 'create-virtualenv', 10:09:03 INFO - 'install', 10:09:03 INFO - 'run-tests'), 10:09:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:09:03 INFO - 'download_minidump_stackwalk': True, 10:09:03 INFO - 'download_symbols': 'ondemand', 10:09:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:09:03 INFO - 'tooltool.py': '/tools/tooltool.py', 10:09:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:09:03 INFO - '/tools/misc-python/virtualenv.py')}, 10:09:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:09:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:09:03 INFO - 'installer_path': 'installer.exe', 10:09:03 INFO - 'log_level': 'info', 10:09:03 INFO - 'log_name': 'talos', 10:09:03 INFO - 'log_to_console': True, 10:09:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:09:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:09:03 INFO - 'opt_config_files': (), 10:09:03 INFO - 'pip_index': False, 10:09:03 INFO - 'sps_profile': False, 10:09:03 INFO - 'sps_profile_interval': 0, 10:09:03 INFO - 'suite': 'dromaeojs', 10:09:03 INFO - 'system_bits': '32', 10:09:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:09:03 INFO - 'title': 'talos-linux64-ix-021', 10:09:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:09:03 INFO - 'use_talos_json': True, 10:09:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:09:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:09:03 INFO - 'work_dir': 'build'} 10:09:03 INFO - ##### 10:09:03 INFO - ##### Running clobber step. 10:09:03 INFO - ##### 10:09:03 INFO - Running pre-action listener: _resource_record_pre_action 10:09:03 INFO - Running main action method: clobber 10:09:03 INFO - rmtree: /builds/slave/test/build 10:09:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:09:03 INFO - Running post-action listener: _resource_record_post_action 10:09:03 INFO - ##### 10:09:03 INFO - ##### Finished clobber step (success) 10:09:03 INFO - ##### 10:09:03 INFO - ##### 10:09:03 INFO - ##### Running read-buildbot-config step. 10:09:03 INFO - ##### 10:09:03 INFO - Running pre-action listener: _resource_record_pre_action 10:09:03 INFO - Running main action method: read_buildbot_config 10:09:03 INFO - Using buildbot properties: 10:09:03 INFO - { 10:09:03 INFO - "project": "", 10:09:03 INFO - "product": "firefox", 10:09:03 INFO - "script_repo_revision": "production", 10:09:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:09:03 INFO - "repository": "", 10:09:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:09:03 INFO - "buildid": "20160712094026", 10:09:03 INFO - "pgo_build": "False", 10:09:03 INFO - "basedir": "/builds/slave/test", 10:09:03 INFO - "buildnumber": 1978, 10:09:03 INFO - "slavename": "talos-linux64-ix-021", 10:09:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:09:03 INFO - "platform": "ubuntu64_hw", 10:09:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:09:03 INFO - "branch": "fx-team", 10:09:03 INFO - "repo_path": "integration/fx-team", 10:09:03 INFO - "revision": "489d075c767662a205ddf09cb609786203889911", 10:09:03 INFO - "stage_platform": "linux64", 10:09:03 INFO - "builduid": "41c0f26d65414ff5839e40fc4e204e25", 10:09:03 INFO - "slavebuilddir": "test" 10:09:03 INFO - } 10:09:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:09:03 INFO - Running post-action listener: _resource_record_post_action 10:09:03 INFO - ##### 10:09:03 INFO - ##### Finished read-buildbot-config step (success) 10:09:03 INFO - ##### 10:09:03 INFO - ##### 10:09:03 INFO - ##### Running download-and-extract step. 10:09:03 INFO - ##### 10:09:03 INFO - Running pre-action listener: _resource_record_pre_action 10:09:03 INFO - Running main action method: download_and_extract 10:09:03 INFO - mkdir: /builds/slave/test/build/tests 10:09: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')]} 10:09:03 INFO - https://queue.taskcluster.net/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:09:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:09:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:09:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:09:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:09:06 INFO - Downloaded 1361 bytes. 10:09:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:09:06 INFO - Using the following test package requirements: 10:09:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:09:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:09:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:09:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:06 INFO - u'jsshell-linux-x86_64.zip'], 10:09:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:09:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:09:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:09:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:09:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:09:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:09:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:06 INFO - https://queue.taskcluster.net/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:09:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:09:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:09:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:09:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:09:24 INFO - Downloaded 22750521 bytes. 10:09:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:09:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:09:25 INFO - Return code: 0 10:09:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:25 INFO - https://queue.taskcluster.net/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:09:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:09:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:09:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:09:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:09:29 INFO - Downloaded 22750521 bytes. 10:09:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:09:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:09:30 INFO - Return code: 0 10:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:30 INFO - https://queue.taskcluster.net/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:09:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:09:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:09:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:09:31 INFO - Downloaded 14403317 bytes. 10:09:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:09:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:09:31 INFO - Return code: 0 10:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:31 INFO - https://queue.taskcluster.net/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:09:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:09:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:09:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:09:33 INFO - Downloaded 56668360 bytes. 10:09:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:09:33 INFO - mkdir: /builds/slave/test/properties 10:09:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:09:33 INFO - Writing to file /builds/slave/test/properties/build_url 10:09:33 INFO - Contents: 10:09:33 INFO - build_url:https://queue.taskcluster.net/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:09:33 INFO - Running post-action listener: _resource_record_post_action 10:09:33 INFO - Running post-action listener: set_extra_try_arguments 10:09:33 INFO - ##### 10:09:33 INFO - ##### Finished download-and-extract step (success) 10:09:33 INFO - ##### 10:09:33 INFO - ##### 10:09:33 INFO - ##### Running populate-webroot step. 10:09:33 INFO - ##### 10:09:33 INFO - Running pre-action listener: _resource_record_pre_action 10:09:33 INFO - Running main action method: populate_webroot 10:09:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:09:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:09:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:09:33 INFO - '--tppagecycles', 10:09:33 INFO - '7'], 10:09:33 INFO - 'tests': ['tsvgm']}}, 10:09:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:09:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:09:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:09:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:09:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:09:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:09:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:33 INFO - 'talos_options': ['--disable-e10s'], 10:09:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:33 INFO - 'talos_options': ['--disable-e10s'], 10:09:33 INFO - 'tests': ['damp', 'tps']}, 10:09:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:33 INFO - 'tests': ['damp', 'tps']}, 10:09:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:09:33 INFO - 'tests': ['dromaeo_dom']}, 10:09:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:09:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:09:33 INFO - 'tests': ['basic_compositor_video']}, 10:09:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:09:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:09:33 INFO - 'tests': ['a11yr', 10:09:33 INFO - 'ts_paint', 10:09:33 INFO - 'tpaint', 10:09:33 INFO - 'sessionrestore', 10:09:33 INFO - 'sessionrestore_no_auto_restore', 10:09:33 INFO - 'tabpaint']}, 10:09:33 INFO - 'other-e10s': {'tests': ['a11yr', 10:09:33 INFO - 'ts_paint', 10:09:33 INFO - 'tpaint', 10:09:33 INFO - 'sessionrestore', 10:09:33 INFO - 'sessionrestore_no_auto_restore', 10:09:33 INFO - 'tabpaint']}, 10:09:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:09:33 INFO - 'ts_paint', 10:09:33 INFO - 'tpaint', 10:09:33 INFO - 'sessionrestore', 10:09:33 INFO - 'sessionrestore_no_auto_restore', 10:09:33 INFO - 'tabpaint']}, 10:09:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:09:33 INFO - 'ts_paint', 10:09:33 INFO - 'tpaint', 10:09:33 INFO - 'sessionrestore', 10:09:33 INFO - 'sessionrestore_no_auto_restore', 10:09:33 INFO - 'tabpaint']}, 10:09:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:09:33 INFO - 'tests': ['a11yr', 10:09:33 INFO - 'ts_paint', 10:09:33 INFO - 'tpaint', 10:09:33 INFO - 'sessionrestore', 10:09:33 INFO - 'sessionrestore_no_auto_restore', 10:09:33 INFO - 'tabpaint']}, 10:09:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:09:33 INFO - 'tests': ['a11yr', 10:09:33 INFO - 'ts_paint', 10:09:33 INFO - 'tpaint', 10:09:33 INFO - 'sessionrestore', 10:09:33 INFO - 'sessionrestore_no_auto_restore', 10:09:33 INFO - 'tabpaint']}, 10:09:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:09:33 INFO - 'tests': ['tsvgx', 10:09:33 INFO - 'tsvgr_opacity', 10:09:33 INFO - 'tart', 10:09:33 INFO - 'tscrollx', 10:09:33 INFO - 'cart']}, 10:09:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:09:33 INFO - 'tsvgr_opacity', 10:09:33 INFO - 'tart', 10:09:33 INFO - 'tscrollx', 10:09:33 INFO - 'cart']}, 10:09:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:33 INFO - 'talos_options': ['--disable-e10s'], 10:09:33 INFO - 'tests': ['tp5o']}, 10:09:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:33 INFO - 'tests': ['tp5o']}, 10:09:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:33 INFO - 'talos_options': ['--disable-e10s', 10:09:33 INFO - '--xperf_path', 10:09:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:33 INFO - 'tests': ['tp5n']}, 10:09:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:33 INFO - 'talos_options': ['--xperf_path', 10:09:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:33 INFO - 'tests': ['tp5n']}}, 10:09:33 INFO - 'talos.zip': {'path': '', 10:09:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:09:33 INFO - Running post-action listener: _resource_record_post_action 10:09:33 INFO - ##### 10:09:33 INFO - ##### Finished populate-webroot step (success) 10:09:33 INFO - ##### 10:09:33 INFO - ##### 10:09:33 INFO - ##### Running create-virtualenv step. 10:09:33 INFO - ##### 10:09:33 INFO - Running pre-action listener: _resource_record_pre_action 10:09:33 INFO - Running main action method: create_virtualenv 10:09:33 INFO - Creating virtualenv /builds/slave/test/build/venv 10:09:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:09:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:09:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:09:34 INFO - Using real prefix '/usr' 10:09:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:09:34 INFO - Installing distribute.............................................................................................................................................................................................done. 10:09:36 INFO - Installing pip.................done. 10:09:36 INFO - Return code: 0 10:09:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e09030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c83b0>, '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 0x20c92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9740>, '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': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:09: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', 'pip>=1.5'] in /builds/slave/test/build 10:09: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 pip>=1.5 10:09:36 INFO - Using env: {'DISPLAY': ':0', 10:09:36 INFO - 'HOME': '/home/cltbld', 10:09:36 INFO - 'LANG': 'en_US.UTF-8', 10:09:36 INFO - 'LANGUAGE': 'en_US:en', 10:09:36 INFO - 'LOGNAME': 'cltbld', 10:09:36 INFO - 'MAIL': '/var/mail/cltbld', 10:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:36 INFO - 'MOZ_NO_REMOTE': '1', 10:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:36 INFO - 'NO_EM_RESTART': '1', 10:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:36 INFO - 'PWD': '/builds/slave/test', 10:09:36 INFO - 'SHELL': '/bin/bash', 10:09:36 INFO - 'SHLVL': '1', 10:09:36 INFO - 'TERM': 'linux', 10:09:36 INFO - 'TMOUT': '86400', 10:09:36 INFO - 'USER': 'cltbld', 10:09:36 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 10:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:36 INFO - '_': '/tools/buildbot/bin/python'} 10:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:09:36 INFO - Cleaning up... 10:09:36 INFO - Return code: 0 10:09:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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', '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 0x1e09030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c83b0>, '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 0x20c92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9740>, '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': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:09: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', 'psutil>=3.1.1'] in /builds/slave/test/build 10:09: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 psutil>=3.1.1 10:09:36 INFO - Using env: {'DISPLAY': ':0', 10:09:36 INFO - 'HOME': '/home/cltbld', 10:09:36 INFO - 'LANG': 'en_US.UTF-8', 10:09:36 INFO - 'LANGUAGE': 'en_US:en', 10:09:36 INFO - 'LOGNAME': 'cltbld', 10:09:36 INFO - 'MAIL': '/var/mail/cltbld', 10:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:36 INFO - 'MOZ_NO_REMOTE': '1', 10:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:36 INFO - 'NO_EM_RESTART': '1', 10:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:36 INFO - 'PWD': '/builds/slave/test', 10:09:36 INFO - 'SHELL': '/bin/bash', 10:09:36 INFO - 'SHLVL': '1', 10:09:36 INFO - 'TERM': 'linux', 10:09:36 INFO - 'TMOUT': '86400', 10:09:36 INFO - 'USER': 'cltbld', 10:09:36 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 10:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:36 INFO - '_': '/tools/buildbot/bin/python'} 10:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:37 INFO - Downloading/unpacking psutil>=3.1.1 10:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:09:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:39 INFO - Installing collected packages: psutil 10:09:39 INFO - Running setup.py install for psutil 10:09:39 INFO - building 'psutil._psutil_linux' extension 10:09:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:09:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:09:39 INFO - building 'psutil._psutil_posix' extension 10:09:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:09:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:09:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:39 INFO - Successfully installed psutil 10:09:39 INFO - Cleaning up... 10:09:39 INFO - Return code: 0 10:09:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:39 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 0x1e09030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c83b0>, '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 0x20c92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9740>, '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': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:09:39 INFO - Using env: {'DISPLAY': ':0', 10:09:39 INFO - 'HOME': '/home/cltbld', 10:09:39 INFO - 'LANG': 'en_US.UTF-8', 10:09:39 INFO - 'LANGUAGE': 'en_US:en', 10:09:39 INFO - 'LOGNAME': 'cltbld', 10:09:39 INFO - 'MAIL': '/var/mail/cltbld', 10:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:39 INFO - 'MOZ_NO_REMOTE': '1', 10:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:39 INFO - 'NO_EM_RESTART': '1', 10:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:39 INFO - 'PWD': '/builds/slave/test', 10:09:39 INFO - 'SHELL': '/bin/bash', 10:09:39 INFO - 'SHLVL': '1', 10:09:39 INFO - 'TERM': 'linux', 10:09:39 INFO - 'TMOUT': '86400', 10:09:39 INFO - 'USER': 'cltbld', 10:09:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 10:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:39 INFO - '_': '/tools/buildbot/bin/python'} 10:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:09:41 INFO - Installing collected packages: mozsystemmonitor 10:09:41 INFO - Running setup.py install for mozsystemmonitor 10:09:41 INFO - Successfully installed mozsystemmonitor 10:09:41 INFO - Cleaning up... 10:09:42 INFO - Return code: 0 10:09:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e09030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c83b0>, '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 0x20c92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9740>, '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': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:09:42 INFO - Using env: {'DISPLAY': ':0', 10:09:42 INFO - 'HOME': '/home/cltbld', 10:09:42 INFO - 'LANG': 'en_US.UTF-8', 10:09:42 INFO - 'LANGUAGE': 'en_US:en', 10:09:42 INFO - 'LOGNAME': 'cltbld', 10:09:42 INFO - 'MAIL': '/var/mail/cltbld', 10:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:42 INFO - 'MOZ_NO_REMOTE': '1', 10:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:42 INFO - 'NO_EM_RESTART': '1', 10:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:42 INFO - 'PWD': '/builds/slave/test', 10:09:42 INFO - 'SHELL': '/bin/bash', 10:09:42 INFO - 'SHLVL': '1', 10:09:42 INFO - 'TERM': 'linux', 10:09:42 INFO - 'TMOUT': '86400', 10:09:42 INFO - 'USER': 'cltbld', 10:09:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 10:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:42 INFO - '_': '/tools/buildbot/bin/python'} 10:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:42 INFO - Downloading/unpacking jsonschema==2.5.1 10:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:09:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:44 INFO - Downloading functools32-3.2.3-2.tar.gz 10:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:09:44 INFO - warning: no files found matching '*.txt' 10:09:44 INFO - no previously-included directories found matching 'build' 10:09:44 INFO - no previously-included directories found matching 'dist' 10:09:44 INFO - no previously-included directories found matching '.git*' 10:09:44 INFO - Installing collected packages: jsonschema, functools32 10:09:44 INFO - Running setup.py install for functools32 10:09:44 INFO - warning: no files found matching '*.txt' 10:09:44 INFO - no previously-included directories found matching 'build' 10:09:44 INFO - no previously-included directories found matching 'dist' 10:09:44 INFO - no previously-included directories found matching '.git*' 10:09:44 INFO - Successfully installed jsonschema functools32 10:09:44 INFO - Cleaning up... 10:09:44 INFO - Return code: 0 10:09:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:44 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 0x1e09030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c83b0>, '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 0x20c92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9740>, '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': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:09:44 INFO - Using env: {'DISPLAY': ':0', 10:09:44 INFO - 'HOME': '/home/cltbld', 10:09:44 INFO - 'LANG': 'en_US.UTF-8', 10:09:44 INFO - 'LANGUAGE': 'en_US:en', 10:09:44 INFO - 'LOGNAME': 'cltbld', 10:09:44 INFO - 'MAIL': '/var/mail/cltbld', 10:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:44 INFO - 'MOZ_NO_REMOTE': '1', 10:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:44 INFO - 'NO_EM_RESTART': '1', 10:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:44 INFO - 'PWD': '/builds/slave/test', 10:09:44 INFO - 'SHELL': '/bin/bash', 10:09:44 INFO - 'SHLVL': '1', 10:09:44 INFO - 'TERM': 'linux', 10:09:44 INFO - 'TMOUT': '86400', 10:09:44 INFO - 'USER': 'cltbld', 10:09:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 10:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:44 INFO - '_': '/tools/buildbot/bin/python'} 10:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:44 INFO - Downloading/unpacking blobuploader==1.2.4 10:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:46 INFO - Downloading blobuploader-1.2.4.tar.gz 10:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:09:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:09:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:47 INFO - Downloading docopt-0.6.1.tar.gz 10:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:09:47 INFO - Installing collected packages: blobuploader, requests, docopt 10:09:47 INFO - Running setup.py install for blobuploader 10:09:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:09:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:09:47 INFO - Running setup.py install for requests 10:09:47 INFO - Running setup.py install for docopt 10:09:48 INFO - Successfully installed blobuploader requests docopt 10:09:48 INFO - Cleaning up... 10:09:48 INFO - Return code: 0 10:09:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:48 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 0x1e09030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c83b0>, '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 0x20c92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9740>, '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': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:09:48 INFO - Using env: {'DISPLAY': ':0', 10:09:48 INFO - 'HOME': '/home/cltbld', 10:09:48 INFO - 'LANG': 'en_US.UTF-8', 10:09:48 INFO - 'LANGUAGE': 'en_US:en', 10:09:48 INFO - 'LOGNAME': 'cltbld', 10:09:48 INFO - 'MAIL': '/var/mail/cltbld', 10:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:48 INFO - 'MOZ_NO_REMOTE': '1', 10:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:48 INFO - 'NO_EM_RESTART': '1', 10:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:48 INFO - 'PWD': '/builds/slave/test', 10:09:48 INFO - 'SHELL': '/bin/bash', 10:09:48 INFO - 'SHLVL': '1', 10:09:48 INFO - 'TERM': 'linux', 10:09:48 INFO - 'TMOUT': '86400', 10:09:48 INFO - 'USER': 'cltbld', 10:09:48 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 10:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:48 INFO - '_': '/tools/buildbot/bin/python'} 10:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:48 INFO - Running setup.py (path:/tmp/pip-FHQqiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:48 INFO - Running setup.py (path:/tmp/pip-WMYzJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:48 INFO - Running setup.py (path:/tmp/pip-g0kqLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:48 INFO - Running setup.py (path:/tmp/pip-gTO_DF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:48 INFO - Running setup.py (path:/tmp/pip-vjiqiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:48 INFO - Running setup.py (path:/tmp/pip-Oh2NRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:48 INFO - Running setup.py (path:/tmp/pip-wt6Li3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:48 INFO - Running setup.py (path:/tmp/pip-VzPNBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:48 INFO - Running setup.py (path:/tmp/pip-1rma5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:48 INFO - Running setup.py (path:/tmp/pip-P_a4gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:49 INFO - Running setup.py (path:/tmp/pip-KNb9WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:49 INFO - Running setup.py (path:/tmp/pip-ZN0MUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:49 INFO - Running setup.py (path:/tmp/pip-5as4GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:49 INFO - Running setup.py (path:/tmp/pip-0WFrSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:49 INFO - Running setup.py (path:/tmp/pip-xyIU6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:49 INFO - Running setup.py (path:/tmp/pip-2apUcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:49 INFO - Running setup.py (path:/tmp/pip-K57mZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:09:49 INFO - Running setup.py install for manifestparser 10:09:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:09:49 INFO - Running setup.py install for mozcrash 10:09:49 INFO - Running setup.py install for mozdebug 10:09:49 INFO - Running setup.py install for mozdevice 10:09:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:09:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:09:49 INFO - Running setup.py install for mozfile 10:09:50 INFO - Running setup.py install for mozhttpd 10:09:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:09:50 INFO - Running setup.py install for mozinfo 10:09:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:09:50 INFO - Running setup.py install for mozInstall 10:09:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:09:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:09:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:09:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:09:50 INFO - Running setup.py install for mozleak 10:09:50 INFO - Running setup.py install for mozlog 10:09:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:09:50 INFO - Running setup.py install for moznetwork 10:09:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:09:50 INFO - Running setup.py install for mozprocess 10:09:50 INFO - Running setup.py install for mozprofile 10:09:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:09:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:09:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:09:50 INFO - Running setup.py install for mozrunner 10:09:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:09:50 INFO - Running setup.py install for mozscreenshot 10:09:51 INFO - Running setup.py install for moztest 10:09:51 INFO - Running setup.py install for mozversion 10:09:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:09:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:09:51 INFO - Cleaning up... 10:09:51 INFO - Return code: 0 10:09:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:51 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 0x1e09030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c83b0>, '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 0x20c92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9740>, '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': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:09:51 INFO - Using env: {'DISPLAY': ':0', 10:09:51 INFO - 'HOME': '/home/cltbld', 10:09:51 INFO - 'LANG': 'en_US.UTF-8', 10:09:51 INFO - 'LANGUAGE': 'en_US:en', 10:09:51 INFO - 'LOGNAME': 'cltbld', 10:09:51 INFO - 'MAIL': '/var/mail/cltbld', 10:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:51 INFO - 'MOZ_NO_REMOTE': '1', 10:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:51 INFO - 'NO_EM_RESTART': '1', 10:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:51 INFO - 'PWD': '/builds/slave/test', 10:09:51 INFO - 'SHELL': '/bin/bash', 10:09:51 INFO - 'SHLVL': '1', 10:09:51 INFO - 'TERM': 'linux', 10:09:51 INFO - 'TMOUT': '86400', 10:09:51 INFO - 'USER': 'cltbld', 10:09:51 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 10:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:51 INFO - '_': '/tools/buildbot/bin/python'} 10:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:51 INFO - Running setup.py (path:/tmp/pip-Oi_pjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:51 INFO - Running setup.py (path:/tmp/pip-KMebio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:51 INFO - Running setup.py (path:/tmp/pip-CkRHz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:51 INFO - Running setup.py (path:/tmp/pip-i6t9wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:51 INFO - Running setup.py (path:/tmp/pip-tnwUEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:51 INFO - Running setup.py (path:/tmp/pip-ctkxIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:51 INFO - Running setup.py (path:/tmp/pip-Zicn8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:52 INFO - Running setup.py (path:/tmp/pip-Qb2hNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:52 INFO - Running setup.py (path:/tmp/pip-9XUOHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:52 INFO - Running setup.py (path:/tmp/pip-17voWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:52 INFO - Running setup.py (path:/tmp/pip-nuzzXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:52 INFO - Running setup.py (path:/tmp/pip-EDWK65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:52 INFO - Running setup.py (path:/tmp/pip-F9Koii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:52 INFO - Running setup.py (path:/tmp/pip-Fn5JHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:52 INFO - Running setup.py (path:/tmp/pip-TU06uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:52 INFO - Running setup.py (path:/tmp/pip-l2_Vu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:52 INFO - Running setup.py (path:/tmp/pip-VGceeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:09:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:54 INFO - Downloading blessings-1.6.tar.gz 10:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:09:54 INFO - Installing collected packages: blessings 10:09:54 INFO - Running setup.py install for blessings 10:09:54 INFO - Successfully installed blessings 10:09:54 INFO - Cleaning up... 10:09:54 INFO - Return code: 0 10:09:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:09:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:55 INFO - Reading from file tmpfile_stdout 10:09:55 INFO - Current package versions: 10:09:55 INFO - argparse == 1.2.1 10:09:55 INFO - blessings == 1.6 10:09:55 INFO - blobuploader == 1.2.4 10:09:55 INFO - docopt == 0.6.1 10:09:55 INFO - functools32 == 3.2.3-2 10:09:55 INFO - jsonschema == 2.5.1 10:09:55 INFO - manifestparser == 1.1 10:09:55 INFO - mozInstall == 1.12 10:09:55 INFO - mozcrash == 0.17 10:09:55 INFO - mozdebug == 0.1 10:09:55 INFO - mozdevice == 0.48 10:09:55 INFO - mozfile == 1.2 10:09:55 INFO - mozhttpd == 0.7 10:09:55 INFO - mozinfo == 0.9 10:09:55 INFO - mozleak == 0.1 10:09:55 INFO - mozlog == 3.2 10:09:55 INFO - moznetwork == 0.27 10:09:55 INFO - mozprocess == 0.23 10:09:55 INFO - mozprofile == 0.28 10:09:55 INFO - mozrunner == 6.12 10:09:55 INFO - mozscreenshot == 0.1 10:09:55 INFO - mozsystemmonitor == 0.3 10:09:55 INFO - moztest == 0.7 10:09:55 INFO - mozversion == 1.4 10:09:55 INFO - psutil == 3.1.1 10:09:55 INFO - requests == 1.2.3 10:09:55 INFO - wsgiref == 0.1.2 10:09:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:55 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 0x1e09030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c83b0>, '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 0x20c92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9740>, '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': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:09:55 INFO - Using env: {'DISPLAY': ':0', 10:09:55 INFO - 'HOME': '/home/cltbld', 10:09:55 INFO - 'LANG': 'en_US.UTF-8', 10:09:55 INFO - 'LANGUAGE': 'en_US:en', 10:09:55 INFO - 'LOGNAME': 'cltbld', 10:09:55 INFO - 'MAIL': '/var/mail/cltbld', 10:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:55 INFO - 'MOZ_NO_REMOTE': '1', 10:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:55 INFO - 'NO_EM_RESTART': '1', 10:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:55 INFO - 'PWD': '/builds/slave/test', 10:09:55 INFO - 'SHELL': '/bin/bash', 10:09:55 INFO - 'SHLVL': '1', 10:09:55 INFO - 'TERM': 'linux', 10:09:55 INFO - 'TMOUT': '86400', 10:09:55 INFO - 'USER': 'cltbld', 10:09:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 10:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:55 INFO - '_': '/tools/buildbot/bin/python'} 10:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:09:55 INFO - Cleaning up... 10:09:55 INFO - Return code: 0 10:09:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:55 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 0x1e09030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c83b0>, '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 0x20c92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9740>, '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': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:09:55 INFO - Using env: {'DISPLAY': ':0', 10:09:55 INFO - 'HOME': '/home/cltbld', 10:09:55 INFO - 'LANG': 'en_US.UTF-8', 10:09:55 INFO - 'LANGUAGE': 'en_US:en', 10:09:55 INFO - 'LOGNAME': 'cltbld', 10:09:55 INFO - 'MAIL': '/var/mail/cltbld', 10:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:55 INFO - 'MOZ_NO_REMOTE': '1', 10:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:55 INFO - 'NO_EM_RESTART': '1', 10:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:55 INFO - 'PWD': '/builds/slave/test', 10:09:55 INFO - 'SHELL': '/bin/bash', 10:09:55 INFO - 'SHLVL': '1', 10:09:55 INFO - 'TERM': 'linux', 10:09:55 INFO - 'TMOUT': '86400', 10:09:55 INFO - 'USER': 'cltbld', 10:09:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 10:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:55 INFO - '_': '/tools/buildbot/bin/python'} 10:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:09:55 INFO - Cleaning up... 10:09:55 INFO - Return code: 0 10:09:55 INFO - Running post-action listener: _resource_record_post_action 10:09:55 INFO - Running post-action listener: _start_resource_monitoring 10:09:55 INFO - Starting resource monitoring. 10:09:55 INFO - ##### 10:09:55 INFO - ##### Finished create-virtualenv step (success) 10:09:55 INFO - ##### 10:09:55 INFO - ##### 10:09:55 INFO - ##### Running install step. 10:09:55 INFO - ##### 10:09:55 INFO - Running pre-action listener: _resource_record_pre_action 10:09:55 INFO - Running main action method: install 10:09:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:55 INFO - Reading from file tmpfile_stdout 10:09:55 INFO - Detecting whether we're running mozinstall >=1.0... 10:09:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:09:55 INFO - Reading from file tmpfile_stdout 10:09:55 INFO - Output received: 10:09:55 INFO - Usage: mozinstall [options] installer 10:09:55 INFO - Options: 10:09:55 INFO - -h, --help show this help message and exit 10:09:55 INFO - -d DEST, --destination=DEST 10:09:55 INFO - Directory to install application into. [default: 10:09:55 INFO - "/builds/slave/test"] 10:09:55 INFO - --app=APP Application being installed. [default: firefox] 10:09:55 INFO - mkdir: /builds/slave/test/build/application 10:09:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:10:13 INFO - Reading from file tmpfile_stdout 10:10:13 INFO - Output received: 10:10:13 INFO - /builds/slave/test/build/application/firefox/firefox 10:10:13 INFO - Running post-action listener: _resource_record_post_action 10:10:13 INFO - ##### 10:10:13 INFO - ##### Finished install step (success) 10:10:13 INFO - ##### 10:10:13 INFO - ##### 10:10:13 INFO - ##### Running run-tests step. 10:10:13 INFO - ##### 10:10:13 INFO - Running pre-action listener: _resource_record_pre_action 10:10:13 INFO - Running main action method: run_tests 10:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:10:13 INFO - Python 2.7.3 10:10:13 INFO - Return code: 0 10:10:13 INFO - grabbing minidump binary from tooltool 10:10: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')]} 10:10:13 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 0x20c83b0>, '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 0x20c92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:10:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:10:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:10:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:10:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:10:13 INFO - Return code: 0 10:10:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:10:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:10:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:10:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:10:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:10:13 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:10:13 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:10:13 INFO - Using env: {'DISPLAY': ':0', 10:10:13 INFO - 'HOME': '/home/cltbld', 10:10:13 INFO - 'LANG': 'en_US.UTF-8', 10:10:13 INFO - 'LANGUAGE': 'en_US:en', 10:10:13 INFO - 'LOGNAME': 'cltbld', 10:10:13 INFO - 'MAIL': '/var/mail/cltbld', 10:10:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:10:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:13 INFO - 'MOZ_NO_REMOTE': '1', 10:10:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:13 INFO - 'NO_EM_RESTART': '1', 10:10:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:13 INFO - 'PWD': '/builds/slave/test', 10:10:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:10:13 INFO - 'SHELL': '/bin/bash', 10:10:13 INFO - 'SHLVL': '1', 10:10:13 INFO - 'TERM': 'linux', 10:10:13 INFO - 'TMOUT': '86400', 10:10:13 INFO - 'USER': 'cltbld', 10:10:13 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468342715.103934-535090140', 10:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:13 INFO - '_': '/tools/buildbot/bin/python'} 10:10:13 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:10:13 INFO - mozversion application_buildid: 20160712094026 10:10:13 INFO - mozversion application_changeset: 489d075c767662a205ddf09cb609786203889911 10:10:13 INFO - mozversion application_display_name: Nightly 10:10:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:10:13 INFO - mozversion application_name: Firefox 10:10:13 INFO - mozversion application_remotingname: firefox 10:10:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:10:13 INFO - mozversion application_vendor: Mozilla 10:10:13 INFO - mozversion application_version: 50.0a1 10:10:13 INFO - mozversion platform_buildid: 20160712094026 10:10:13 INFO - mozversion platform_changeset: 489d075c767662a205ddf09cb609786203889911 10:10:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:10:13 INFO - mozversion platform_version: 50.0a1 10:10:13 INFO - using testdate: 1468343413 10:10:13 INFO - actual date: 1468343413 10:10:13 INFO - starting webserver on 'localhost:38162' 10:10:13 INFO - SUITE-START | Running 2 tests 10:10:13 INFO - TEST-START | dromaeo_css 10:10:13 INFO - operating with platform_type : linux_ 10:10:13 INFO - Initialising browser for dromaeo_css test... 10:10:13 INFO - TEST-INFO | started process 13401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpennQIo/profile http://localhost:38162/getInfo.html) 10:10:18 INFO - PROCESS | 13401 | __metrics Screen width/height:1600/1200 10:10:18 INFO - PROCESS | 13401 | colorDepth:24 10:10:18 INFO - PROCESS | 13401 | Browser inner width/height: 1024/697 10:10:18 INFO - PROCESS | 13401 | __metrics 10:10:19 INFO - PROCESS | 13401 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:10:19 INFO - PROCESS | 13401 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:10:20 INFO - PROCESS | 13401 | console.error: PushService: 10:10:20 INFO - PROCESS | 13401 | stateChangeProcessEnqueue: Error transitioning state 10:10:20 INFO - PROCESS | 13401 | UnknownError 10:10:21 INFO - TEST-INFO | 13401: exit 0 10:10:21 INFO - Browser initialized. 10:10:21 INFO - Running cycle 1/1 for dromaeo_css test... 10:10:21 INFO - TEST-INFO | started process 13485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpennQIo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:33 INFO - PROCESS | 13485 | RSS: Main: 159006720 10:10:33 INFO - PROCESS | 13485 | 10:11:24 INFO - PROCESS | 13485 | 1468343484288 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:13:37 INFO - PROCESS | 13485 | Cycle 1(1): loaded http://localhost:38162/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38162/tests/dromaeo/cssquery-ext.html) 10:13:38 INFO - PROCESS | 13485 | RSS: Main: 246657024 10:13:38 INFO - PROCESS | 13485 | 10:16:41 INFO - PROCESS | 13485 | Cycle 1(1): loaded http://localhost:38162/tests/dromaeo/cssquery-ext.html (next: http://localhost:38162/tests/dromaeo/cssquery-jquery.html) 10:16:42 INFO - PROCESS | 13485 | RSS: Main: 246083584 10:16:42 INFO - PROCESS | 13485 | 10:19:44 INFO - PROCESS | 13485 | Cycle 1(1): loaded http://localhost:38162/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38162/tests/dromaeo/cssquery-mootools.html) 10:19:45 INFO - PROCESS | 13485 | RSS: Main: 243523584 10:19:45 INFO - PROCESS | 13485 | 10:22:47 INFO - PROCESS | 13485 | Cycle 1(1): loaded http://localhost:38162/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38162/tests/dromaeo/cssquery-prototype.html) 10:22:47 INFO - PROCESS | 13485 | RSS: Main: 244289536 10:22:47 INFO - PROCESS | 13485 | 10:25:50 INFO - PROCESS | 13485 | Cycle 1(1): loaded http://localhost:38162/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38162/tests/dromaeo/cssquery-yui.html) 10:25:51 INFO - PROCESS | 13485 | RSS: Main: 217919488 10:25:51 INFO - PROCESS | 13485 | 10:28:54 INFO - PROCESS | 13485 | Cycle 1(1): loaded http://localhost:38162/tests/dromaeo/cssquery-yui.html (next: http://localhost:38162/tests/dromaeo/cssquery-dojo.html) 10:28:54 INFO - PROCESS | 13485 | RSS: Main: 280363008 10:28:54 INFO - PROCESS | 13485 | 10:28:54 INFO - PROCESS | 13485 | __start_tp_report 10:28:54 INFO - PROCESS | 13485 | _x_x_mozilla_page_load 10:28:54 INFO - PROCESS | 13485 | _x_x_mozilla_page_load_details 10:28:54 INFO - PROCESS | 13485 | |i|pagename|runs| 10:28:54 INFO - PROCESS | 13485 | |0;dojo.html;2647.510210611037;2650.4301575161335;2667.3465001074733;2668.90658826941;2670.8798104085313;4608.5161058088925;4702.576768090871;4718.811247550098;4766.833160839371;4843.685160464567;4751.9524804751945;4755.714657120575;4757.524247575241;4771.7614119293985;4776.426828780551;4321.978390108053;4345.391645169679;4410.889727756799;4445.88885277869;4488.685791994561;4400.691951563392;4437.290033594625;4446.288593824988;4460.130274596455;4490.057088011522;4209.284421648327;4254.1279037797485;4312.202242585132;4359.651227901761;4367.279398899178;4329.242382583036;4347.413099231595;4350.260455722503;4383.495897971742;4385.846495372647;4355.150745604608;4375.343698445226;4385.671074669381;4421.381006659039;4430.24685803411;4644.535546445362;4686.461056978457;4714.882127946795;4787.712737235777;4791.209450440673;5119.129747942859;5122.257272695476;5186.092433824066;5188.558972487343;5189.143791274435;5189.143791274435;5216.035033518811;5223.2165175223645;5224.712640804754;5227.085260079471;4656.674032817704;4672.2057250267535;4723;4726.669133160714;4726.692764970335;5189.662671926313;5200.349956255468;5207.661502002357;5218.765155568009;5222.843314700565;4749.786259618326;4995.300657907823;5001.699898006132;5002.674826136289;5004.949950500449;5030.84907452777;5112.488751124932;5115.411727651293;5151.5363617274625;5176.120059589879;5064.341635587423;5065.39215294167;5072;5078.035173317058;5125.1287281162295;5033.874153146201;5041.521055499722;5041.79832806691;5043.36957880265;5044.470330615232;4127.6904232182105;4147.52303485097;4153.252414565347;4200.138971510833;4201.621854033152;3716.3310604090984;3740.4389341598976;3752.7373083883867;3754.5494540655295;3757.868474603376;4342.848000319974;4371.519132895379;4371.868843934623;4383.276759334738;4388.5611438856495;5093.8726531837;5098.719570423662;5101.2603172539775;5107.8723031923755;5112.6421150519855;4283.400323954649;4309.892252693645;4380.277254253013;4381.956180438218;4427.734335939854;4473.306637471197;4496.348029535699;4519.570640789119;4563.612092972135;4567;4716.103940251342;4729.834455794031;4731.455882573479;4733.479317275166;4775.355327030807;4866.197077482176;4999.375078115236;5038.949610503848;5051.823186188466;5053.11570475158;4730.810767569396;4755.881102972315;4784.617230621611;4799.736014519235;4803.375561177025;4985.152524070844;4986.775595098156;4992;4998.550130488274;5021.347224860745;4951.133551628379;5049.368828896388;5054.545090941833;5061.392632884077;5110.540051395392;4861.975690121527;4886.511348865227;4905.950940490692;4912.140375434356;4916.360873086476;4882.048000639841;4890.975545122394;4893.584045356042;4893.73084480357;4938.802447902043;4764.2615394613895;4799.472058073539;4829.372181616367;4886.193778026728;4891.33966914462;4971.105201063843;5018.172001619692;5045.268436076822;5049.64652474338;5095.745212739423;4890.119778439915;4903.828366007316;4912.066707325596;4933.9506604933495;4963.776630051729 10:28:54 INFO - PROCESS | 13485 | |1;ext.html;544.9414812416152;584.9210356601859;586.3462239602844;593.1843714892024;593.9316978547467;41718;42446;42502.362464563055;42538.361924571116;46215.53784462155;42109;42628.57371426285;42677.14645707084;42679;42685.35971960423;7525.435592330569;7927.128015918259;8068.878966815502;8071.9596402017905;10218.233632477593;9788.070133337322;10170.135538479239;10193.694189174337;10201.744956376113;10262.127719143882;10565.947170264139;10611.363318200894;10616.20378471614;10618.203634727388;10622.203334749885;7649.923500764977;10195.847062294071;10425.322354046963;10449.216308776871;10487.632932847351;10295.639652612123;10376.533056012422;10379.688609341732;10383.688489345332;10386.948065259625;40152.19695606101;40379.394309085386;40412.59587404118;40435;40545.783626491255;2431.222008957134;2799.986000070007;2936.3980384021224;2945.528715405525;3042.421939831425;30576.54135187974;30929.226769330722;31011.844940775376;31339.05982820519;32024;3251.268464595471;3259.6903294187014;3309.2885029718486;3361.4957756336503;3368.7028956763384;284665;287011;287470;287826;290748.54625726945;47463.288050679264;53064.73467632637;54644.18033729497;56915.86168276694;57407.712961434925;59035;59181.704091480125;59319.11021334684;59406.40593594095;59466.70266648639;15281.46514871974;15533.145676987875;15542.378304867905;15631.687366252838;15639.68720625581;9913.355631883904;10655.89344106549;10878.945605271923;11024.118070554336;11328.09375249978;17689.911550442164;17767.46697599074;17773.377931772327;17790.733139002925;17791.73312400315;6485.870282594322;6525.869482610321;6616.569922954993;6702.128723265944;6728.400305836354;802.6147449224405;899.6851102114208;936.2930987104828;1015.4313584392763;1033.5142483032962;28552.571711424345;29093.051814292656;29258.414831703245;29379.355857972885;29396;956.6657356051213;959.4579062829479;987.6493844685177;1015.918726501878;1023.902729240721;14909.179995100374;15263.847361526465;15360.923195383952;15420;15483.767743483857;383582;384204;387173;387311;392242;51927.48072519226;51994.74002629962;52087.479125208265;52128.47871521236;52135;1061.9522121504551;1104.640991677692;1173.3253379306761;1193.2482536002262;1202.915795894279;29356.853215733783;29868.10395688133;30345.696543034286;30381.848090759406;30466.476676166545;42706;43452.130957380046;43595;43691;43720;293307;296138.5193074021;297655;298238;298293;31829.612779042127;31857.203569910936;33462;38178.61821381862;41741.37387939123;42160.67088960565;42359.576404235566;43288.35067474053;43853.12293754171;43938.12123757443;35366;37357.25285494329;37589;38519.614803852724;38536.42195367016;36887.44668829916;37473.437898431;38065;38117.04707382338;38256.426153607164;32701.509477357384;33646.32707345888;33668.83165584156;33784.1553961153;33978.49032264567;32864.342713145124;33336.666633334324;33924.32151357008;34038.65961340355;34255.65744342525;23286.534269314856;23358.76641233566;23480.508142481925;23656.52686946217;23697.881510592335 10:28:54 INFO - PROCESS | 13485 | |2;jquery.html;346.9600995885474;370.3056768558952;370.7219585311017;373.1399125016835;384.76144790230046;13025.60923172304;16149.596260093489;16616.4184253551;18461.7230741539;18528.351507697233;17488.912555437204;17936.64126717468;18070.277188912427;18099.095045247752;18390.724139137925;4772.164871147544;5126.436092029874;5173.732435553295;5179.533841954223;5182.507661772144;3756.924861502782;5052.26742122392;5829.854253643651;6143.662098584576;6155.230596175478;6080.543959203055;6089.0866370044405;6105.969470152643;6107.694615269241;6115.205023346981;5132.512411320938;5530.5299049580835;5538.0031594313;5578.86052848678;5579.13523403873;5257.342832145981;5348.679079255257;5423.5932305076885;5430.294061771944;5435.347758268994;12403.565875194325;12745.745085098246;12870.29213393263;12937.611871643865;13051.804222936664;1862.655408749372;1879.746234258385;1888.9338873139511;1905.7141428785656;1911.5890083631946;8763.298936085097;8949.821003579957;9805.264605154642;10073.798524029551;13693.931530342385;1682.1925475771575;1747.432084572519;1776.209586733904;1786.8927864328182;1800.3878681248307;71072;74067;74707;74730;75724.34964776206;8711.303095752324;8942.955285223532;9240.445573265626;9371.812563748686;10457.947710261553;12820.871791281968;13496.730065398637;13555.390007449689;13967.23180225077;14052.227127508086;7122.430205583541;7310.1593316768185;7382.224866388952;7427.740029098955;7471.215522370073;6857.074294970215;6928.688209030605;7087.610181439967;7090.680919358641;7092.361687448154;4365.4761428628135;4458.554144585581;4464.352668863062;4467.106578684276;4518.096380723869;1797.613513094691;1810.5926166612671;1826.8629852761096;1847.3718935561706;1852.2035524724497;817.7955511122219;849.3290300662532;874.8950125984795;897.8563429851192;910.7131253655077;17127.400540981256;17263;17829.46511604654;17941;18089.547761306072;832.5629044751554;842.6250318608284;860.7202659135806;868.522312727997;879.7009016934273;6779.661016949231;10092.444915529717;10156.847647285296;10171.4914254287;10193.905817174427;300687;301187;304430;383598;403815;85029.57485212658;90218.54890725635;92552.53723731473;93330;93401.5329923346;869.7043005378201;887.0552861202927;890.2032680750692;906.419891269588;907.2605826251583;16158.67682646364;16469.505914822574;16567;16744.581385465463;16878.493645190665;39523.20953580855;39568.84007415247;40085.398719019824;40468.797656012706;41739;54302.728486357315;56192.15711764245;56673.149902750665;57116.42883571277;57376;7240.52936559122;7378.852422951618;7456.366208872307;7536.095668519593;7663.578503182379;11098.889011110108;11454.198206125491;11488.195826292414;11772.823407649063;11843.940780296389;10474.057334839901;10542.8418573723;10635.787284254116;10729.517171727135;10825.67522974312;10463.738406539898;10480;10753.408562529135;10753.89246107529;10888.183386245904;10410.68767936963;10592.947035264775;10632.893671063499;10636.095931845879;10809.56761729522;6783.389494945479;7262.745803896838;7433.182349941394;7460.440466964891;7522.811929701801;9544.475053871825;9904.900950990397;10147.79704405893;10330.793384132425;10681.946590266998 10:28:54 INFO - PROCESS | 13485 | |3;mootools.html;1244.9315287659176;1359.7484465373907;1401.50947168491;1476.6086986948453;1675.4722262487317;6387.584806987548;7146.9642651786735;7409.296116868903;7429.962850185741;7623.656935437904;7367.447441441886;7394.408447324215;7405.22245164258;7413.666385012674;7471.252874712526;2163.697082408464;2183.6942828004094;2184.4102092435032;2188.0153930731153;2188.770179131192;2136.241634219853;2177.68423578581;2207.580559693653;2208.7901649343366;2211.436083798629;2156.611809874222;2169.8155656769113;2173.2067795254775;2181.160253302482;2198.7801219878043;2093.905774240163;2099.265257159997;2101.800328968753;2102.316747057205;2104.2424727098232;2083.7082808406685;2146.5599552091785;2149.215536329244;2150.451634833123;2151.247063527768;7279.745208917715;7437.405007599379;7441.776746697607;7510.474266801326;7527.5859827709455;4367.279398899178;4552.339910712961;4564.5435456454425;4567.200739870543;4569.337446070301;2742.506348857205;2802.8738706758245;2855.029290041375;2867.5411934090444;2867.641544806899;860.8708693695933;862.9913700863036;867.2801574693053;871.9564021798948;874.8993865705462;9709.465979371133;9777.217822574106;9779.364341317792;9820.950895245549;9831.90168098317;3858.82635281413;3910.1202229498704;4077.062275676611;4085.4893138357706;4091.9974606221667;7553.169151393342;7608.467407281437;7616.695332186761;7623.656935437919;7625.6568454419685;4445.333200019958;4452.376667266585;4453.1761624099645;4456.665750068758;4459.0413061192;3528.5060091587197;3949.565547789741;4063.7358571692744;4087.7751723655483;4124.896877578025;3360.462326027824;3364.3944090063533;3525.4006818840858;3552.4316109422884;3578.6063533011347;1010.030370843998;1011.6964910526813;1016.348433795083;1016.8017236638784;1020.7652239984845;670.5909395268882;708.7165133946463;787.4723934963588;792.2275781113368;828.9088200297963;5131.538161565402;5179.04187725272;5200.557952573998;5275.630705850554;5444.8366549003595;450.19415246708024;460.35090522363305;461.3978757721139;467.3480494709861;610.0483246135954;3532.788032718045;3591.3894637911617;3646.650739226503;3702.9074273143387;3733.2720119576966;8767;9038.186563209343;9081.137291957253;9103;9134.269258459308;9020.729378118667;9026.18764311202;9026.18764311215;9033.503157326279;9036.277097832157;6684.966575167093;7001.474889383317;7009.264027277164;7168.462365322517;7172.892406614009;5227.3465816772905;5434.266374039454;5509.641873278224;5567.248421463212;5619.859503512282;8435.186434916523;8619.913800862161;8631;8679.218870301704;8733.475991440533;8037.397195210499;8353.289970352587;8361.456505327134;8608.440451370641;8608.526531040852;5689.971550142222;5825.679587622722;5845.678487683048;6516.934830651633;6667.266600674019;6501.9674901625185;6543.607383557001;6873.072135261876;7107.466939979626;7107.928920710933;6456.677166141768;6655.101561289358;6675.165604299463;6750.1562304711915;6758.493113016445;6552.705128269335;6570;6578.079068930258;6641.9667901662115;6653;5900.793472228452;5911.290645122441;5958.76164953397;5962.642241465526;5970.194023806731;4280.72175308604;4355.934660980024;4390.07808360248;4445.5109937907455;4480.462344518679;4456.844010459618;4474.753888536032;4514.367988481681;4549.499555048876;4572.154151481986 10:28:54 INFO - PROCESS | 13485 | |4;prototype.html;293.39267715828237;297.16941149487184;299.8515734711318;302.6776483045555;303.3478022252156;4848.684835485691;4880.048390563837;4885.4381746099125;4923.212286034235;4991.900161996758;4872.975635121828;4878.8780280493;4883;4883.682560633556;4892.412910450751;3671.3024525340234;3736.318656604525;3765.1151979284846;3871.9806400968096;3876.7286289959716;3815.771053736785;3842.5004749382542;3846.673032792216;3850.402083135509;3856.86500972466;3674.8530058797614;3813.294540510001;3856.9421458678144;3860.478835357233;3861.4980052593123;3728.8881333559902;3828.808559572024;3838.7696738195796;3853.034952174411;3866.729328946975;3433.0902310887636;3437.089171369589;3437.4843773433936;3438.398280300937;3444.8459765978428;4736.550027747358;4764.380630518045;4779.545943135397;4786.2581299898575;4793.904121917542;4217.6204141627095;4395.274779661352;4403.889902752425;4425.845095421677;4428.535003824616;5076.466970968032;5076.54311111998;5090.752765572422;5108.693478391308;5110.795568177268;3710.7588006779474;3710.9443358349645;3753.6058713834927;3759.496201519387;3765.849366025383;5079.593632509391;5226.529612334908;5233.738313084331;5272.708186494295;5302.814401495968;3806.1245913440066;3816.3702989007056;3825.923481530354;3829;3835.1179228776978;3888.300105980894;3897.7661340319673;3910.2375036868107;3911.941320880189;3914.236723838881;4323.891902702458;4335.913281734348;4336.869893903188;4377.5403582624;4392.253316936129;4858.392700912386;5015.097282489187;5030.496950305013;5075.390953085654;5083.389993200765;1327.5950834995226;1342.664333916521;1345.5492410042746;1359.0826192320144;1360.5986234060977;878.2359347367831;881.9603117859712;895.7581453007782;896.5472436419566;903.9683611073581;4334.718243314238;4365.541618130114;4491.281394976788;4502.57225563571;4539.795709193094;5203.297554830049;5208.270842082035;5218.582513398919;5220.947790522122;5244.423113457517;4263.2752432086;4479.843205487858;4481.4174157359985;4485.6860019798305;4513.480949690762;2728.2770065932546;2751.2984189031667;2767.8062535622716;2774.320291528548;2800.635917330734;4898.338724272249;4902.240152776325;4902.48523904992;4906.2640603908985;4913.960706306914;5094.974525127351;5321.780322904664;5323.22813192085;5376.1935709643085;5380.650257733235;4949.925751113737;4955.182394904872;4960.379952505937;5006.974965125224;5023.522765337287;5324.7870085196155;5334.75993580282;5338.839834804962;5350.839474815762;5364.919526207188;4932.235503496964;5214.504622060898;5220.947790522198;5254.632175747661;5259.342582177228;5011.574016208663;5032.6980381177245;5036.320096786887;5041.949580504294;5045.293658887832;3787.3182827091387;3789.886303410902;3791.241751649736;3793.487879136281;3793.9241215176094;5116.232565115262;5210.400803907599;5235.136202526541;5244.344456942882;5325.97337013328;5109.9233511498105;5140;5164.767585458739;5175.378954525481;5182.352205974254;5096.796128154832;5171.224316352577;5181.678671938632;5182.424127352115;5224.9738751306;4761.262004389187;4938.901221975469;5000.474950130184;5020.138521042971;5022.899542009066;4952.356193694796;5033.446320904771;5092.1229505329375;5092.388913330424;5100.056489549445;4961.6030717543235;4965.45380008206;4966.701997880139;5023.020511000466;5030.471800461045 10:28:54 INFO - PROCESS | 13485 | |5;yui.html;673.8517526144248;720.6612891940786;738.0516036892594;765.4221063097363;771.2942657468417;12382.31897245651;12688.30214338211;13397.598072057854;13415.79876301855;13440.260785656785;13033.41349639266;13099.08306418551;13165.605031849036;13246.072774905737;13247.138935969155;627.8116565030496;777.6733771815851;783.0955246690082;798.8601994650942;803.0884945586772;805.1545876829306;805.4965646470955;811.7727036429809;812.3014207781304;812.8983877015373;845.1801752300258;850.4557083466586;850.5364576305928;851.0255757158051;851.4167795060404;651.6806764685317;804.7103042904608;827.2967977219375;841.1210285251896;841.4152164245883;606.2210060072829;607.5261296188979;607.6020206764576;607.7234858139536;607.7720854679495;13351.399187036606;13353.666158346023;13368.598942031755;13390.397432115578;13391.665208369772;12750.29873356965;13274.137181083199;13281.402336894864;13334.58987852845;13462.564378698771;11935.94032029843;11947.701307467296;12015.459304331325;12362.19645723034;12415.130940834146;4254.298040823261;4256.59562341577;4308.6983911126235;4341.522432532419;4395.120975804852;60514;60549.394506054814;60586.697066514826;61170;61558;9656;9894.60421583143;9903.80192396148;10037.44794036335;10263.640772572924;18695.252189912524;18717.812821871878;18721.906390468233;18729.719054214198;18732.344367947055;6828.52200345981;6843.135501435773;6960.79117626472;6989.857931336764;6994.8950765738555;3678.3746763050344;3692.796896170683;3735.4193897887335;3782.3569993101237;3813.580506144322;2726.6864310604137;2829.066408085327;2833.943321133566;2836.0215725574644;2839.275984623908;497.7610746841464;511.4399732293133;511.81318818630933;512.625783178282;530.0406264660976;500.15973165082283;561.9606627536115;562.2718579439636;575.3326141675636;589.1604463639297;8128.59357032146;8477.788055298666;8832.55837208137;9022.548872556346;9057.18485336323;580.4659713063992;585.4233579923772;605.7758629307184;625.9311475737666;640.478010421505;3961.920761584752;4013.337799263089;4080.510338759368;4242.596953289432;4547.613452856544;77366;80688;81127;84950.15049849423;107897.46051269694;75528.62235688786;77974.610126949;78521;78938;79458;48396.51603483991;68384.3161568378;69403.3059669407;70975;71196.57606847835;7064.576125432491;7186.820329491805;7406.740764073232;8332.833343333221;8891.73324800257;32028.359432811678;39421.226044828625;39811.805645830675;42496.30014799374;42860.78569607132;40443;40796;45386.319205211286;51041;58087.70956145192;10759.946200268949;11063.778724425305;11081.168912331768;11749.76500470003;12245.938770306091;13426.932865335611;13430.261335626634;13552.322383880964;13656.590302290948;14407.096404455437;12114.575989840665;12154.02767778558;12359;12777.105602607728;13313.068085234328;12147.696307592381;12200.389980501117;12333.260004399765;12632.557860474839;13636.113652612548;10297.845532316871;10589.841152382567;10733.624323148964;11428.599999000327;11649.41752912334;9759.219262458844;9836.557354919189;9857.211423086279;9900.702978910644;9982.301238913205;10322.48387580633;10423.791524169323;10429;10519;10550.155987521133 10:28:54 INFO - PROCESS | 13485 | __end_tp_report 10:28:54 INFO - PROCESS | 13485 | __start_cc_report 10:28:54 INFO - PROCESS | 13485 | _x_x_mozilla_cycle_collect,886 10:28:54 INFO - PROCESS | 13485 | __end_cc_report 10:28:54 INFO - PROCESS | 13485 | __startTimestamp1468344534721__endTimestamp 10:28:54 INFO - PROCESS | 13485 | 10:28:54 INFO - PROCESS | 13485 | ------- Summary: start ------- 10:28:54 INFO - PROCESS | 13485 | Number of tests: 6 10:28:54 INFO - PROCESS | 13485 | 10:28:54 INFO - PROCESS | 13485 | [#0] dojo.html Cycles:165 Average:4686.81 Median:4787.71 stddev:498.48 (10.4%) stddev-sans-first:473.64 10:28:54 INFO - PROCESS | 13485 | Values: 2647.5 2650.4 2667.3 2668.9 2670.9 4608.5 4702.6 4718.8 4766.8 4843.7 4752.0 4755.7 4757.5 4771.8 4776.4 4322.0 4345.4 4410.9 4445.9 4488.7 4400.7 4437.3 4446.3 4460.1 4490.1 4209.3 4254.1 4312.2 4359.7 4367.3 4329.2 4347.4 4350.3 4383.5 4385.8 4355.2 4375.3 4385.7 4421.4 4430.2 4644.5 4686.5 4714.9 4787.7 4791.2 5119.1 5122.3 5186.1 5188.6 5189.1 5189.1 5216.0 5223.2 5224.7 5227.1 4656.7 4672.2 4723.0 4726.7 4726.7 5189.7 5200.3 5207.7 5218.8 5222.8 4749.8 4995.3 5001.7 5002.7 5004.9 5030.8 5112.5 5115.4 5151.5 5176.1 5064.3 5065.4 5072.0 5078.0 5125.1 5033.9 5041.5 5041.8 5043.4 5044.5 4127.7 4147.5 4153.3 4200.1 4201.6 3716.3 3740.4 3752.7 3754.5 3757.9 4342.8 4371.5 4371.9 4383.3 4388.6 5093.9 5098.7 5101.3 5107.9 5112.6 4283.4 4309.9 4380.3 4382.0 4427.7 4473.3 4496.3 4519.6 4563.6 4567.0 4716.1 4729.8 4731.5 4733.5 4775.4 4866.2 4999.4 5038.9 5051.8 5053.1 4730.8 4755.9 4784.6 4799.7 4803.4 4985.2 4986.8 4992.0 4998.6 5021.3 4951.1 5049.4 5054.5 5061.4 5110.5 4862.0 4886.5 4906.0 4912.1 4916.4 4882.0 4891.0 4893.6 4893.7 4938.8 4764.3 4799.5 4829.4 4886.2 4891.3 4971.1 5018.2 5045.3 5049.6 5095.7 4890.1 4903.8 4912.1 4934.0 4963.8 10:28:54 INFO - PROCESS | 13485 | 10:28:54 INFO - PROCESS | 13485 | [#1] ext.html Cycles:180 Average:49050.18 Median:18411.75 stddev:85730.36 (465.6%) stddev-sans-first:85893.50 10:28:54 INFO - PROCESS | 13485 | Values: 544.9 584.9 586.3 593.2 593.9 41718.0 42446.0 42502.4 42538.4 46215.5 42109.0 42628.6 42677.1 42679.0 42685.4 7525.4 7927.1 8068.9 8072.0 10218.2 9788.1 10170.1 10193.7 10201.7 10262.1 10565.9 10611.4 10616.2 10618.2 10622.2 7649.9 10195.8 10425.3 10449.2 10487.6 10295.6 10376.5 10379.7 10383.7 10386.9 40152.2 40379.4 40412.6 40435.0 40545.8 2431.2 2800.0 2936.4 2945.5 3042.4 30576.5 30929.2 31011.8 31339.1 32024.0 3251.3 3259.7 3309.3 3361.5 3368.7 284665.0 287011.0 287470.0 287826.0 290748.5 47463.3 53064.7 54644.2 56915.9 57407.7 59035.0 59181.7 59319.1 59406.4 59466.7 15281.5 15533.1 15542.4 15631.7 15639.7 9913.4 10655.9 10878.9 11024.1 11328.1 17689.9 17767.5 17773.4 17790.7 17791.7 6485.9 6525.9 6616.6 6702.1 6728.4 802.6 899.7 936.3 1015.4 1033.5 28552.6 29093.1 29258.4 29379.4 29396.0 956.7 959.5 987.6 1015.9 1023.9 14909.2 15263.8 15360.9 15420.0 15483.8 383582.0 384204.0 387173.0 387311.0 392242.0 51927.5 51994.7 52087.5 52128.5 52135.0 1062.0 1104.6 1173.3 1193.2 1202.9 29356.9 29868.1 30345.7 30381.8 30466.5 42706.0 43452.1 43595.0 43691.0 43720.0 293307.0 296138.5 297655.0 298238.0 298293.0 31829.6 31857.2 33462.0 38178.6 41741.4 42160.7 42359.6 43288.4 43853.1 43938.1 35366.0 37357.3 37589.0 38519.6 38536.4 36887.4 37473.4 38065.0 38117.0 38256.4 32701.5 33646.3 33668.8 33784.2 33978.5 32864.3 33336.7 33924.3 34038.7 34255.7 23286.5 23358.8 23480.5 23656.5 23697.9 10:28:54 INFO - PROCESS | 13485 | 10:28:54 INFO - PROCESS | 13485 | [#2] jquery.html Cycles:180 Average:23543.66 Median:23052.24 stddev:57461.04 (249.3%) stddev-sans-first:57595.84 10:28:54 INFO - PROCESS | 13485 | Values: 347.0 370.3 370.7 373.1 384.8 13025.6 16149.6 16616.4 18461.7 18528.4 17488.9 17936.6 18070.3 18099.1 18390.7 4772.2 5126.4 5173.7 5179.5 5182.5 3756.9 5052.3 5829.9 6143.7 6155.2 6080.5 6089.1 6106.0 6107.7 6115.2 5132.5 5530.5 5538.0 5578.9 5579.1 5257.3 5348.7 5423.6 5430.3 5435.3 12403.6 12745.7 12870.3 12937.6 13051.8 1862.7 1879.7 1888.9 1905.7 1911.6 8763.3 8949.8 9805.3 10073.8 13693.9 1682.2 1747.4 1776.2 1786.9 1800.4 71072.0 74067.0 74707.0 74730.0 75724.3 8711.3 8943.0 9240.4 9371.8 10457.9 12820.9 13496.7 13555.4 13967.2 14052.2 7122.4 7310.2 7382.2 7427.7 7471.2 6857.1 6928.7 7087.6 7090.7 7092.4 4365.5 4458.6 4464.4 4467.1 4518.1 1797.6 1810.6 1826.9 1847.4 1852.2 817.8 849.3 874.9 897.9 910.7 17127.4 17263.0 17829.5 17941.0 18089.5 832.6 842.6 860.7 868.5 879.7 6779.7 10092.4 10156.8 10171.5 10193.9 300687.0 301187.0 304430.0 383598.0 403815.0 85029.6 90218.5 92552.5 93330.0 93401.5 869.7 887.1 890.2 906.4 907.3 16158.7 16469.5 16567.0 16744.6 16878.5 39523.2 39568.8 40085.4 40468.8 41739.0 54302.7 56192.2 56673.1 57116.4 57376.0 7240.5 7378.9 7456.4 7536.1 7663.6 11098.9 11454.2 11488.2 11772.8 11843.9 10474.1 10542.8 10635.8 10729.5 10825.7 10463.7 10480.0 10753.4 10753.9 10888.2 10410.7 10592.9 10632.9 10636.1 10809.6 6783.4 7262.7 7433.2 7460.4 7522.8 9544.5 9904.9 10147.8 10330.8 10681.9 10:28:54 INFO - PROCESS | 13485 | 10:28:54 INFO - PROCESS | 13485 | [#3] mootools.html Cycles:180 Average:4874.78 Median:5477.24 stddev:2669.40 (48.7%) stddev-sans-first:2662.95 10:28:54 INFO - PROCESS | 13485 | Values: 1244.9 1359.7 1401.5 1476.6 1675.5 6387.6 7147.0 7409.3 7430.0 7623.7 7367.4 7394.4 7405.2 7413.7 7471.3 2163.7 2183.7 2184.4 2188.0 2188.8 2136.2 2177.7 2207.6 2208.8 2211.4 2156.6 2169.8 2173.2 2181.2 2198.8 2093.9 2099.3 2101.8 2102.3 2104.2 2083.7 2146.6 2149.2 2150.5 2151.2 7279.7 7437.4 7441.8 7510.5 7527.6 4367.3 4552.3 4564.5 4567.2 4569.3 2742.5 2802.9 2855.0 2867.5 2867.6 860.9 863.0 867.3 872.0 874.9 9709.5 9777.2 9779.4 9821.0 9831.9 3858.8 3910.1 4077.1 4085.5 4092.0 7553.2 7608.5 7616.7 7623.7 7625.7 4445.3 4452.4 4453.2 4456.7 4459.0 3528.5 3949.6 4063.7 4087.8 4124.9 3360.5 3364.4 3525.4 3552.4 3578.6 1010.0 1011.7 1016.3 1016.8 1020.8 670.6 708.7 787.5 792.2 828.9 5131.5 5179.0 5200.6 5275.6 5444.8 450.2 460.4 461.4 467.3 610.0 3532.8 3591.4 3646.7 3702.9 3733.3 8767.0 9038.2 9081.1 9103.0 9134.3 9020.7 9026.2 9026.2 9033.5 9036.3 6685.0 7001.5 7009.3 7168.5 7172.9 5227.3 5434.3 5509.6 5567.2 5619.9 8435.2 8619.9 8631.0 8679.2 8733.5 8037.4 8353.3 8361.5 8608.4 8608.5 5690.0 5825.7 5845.7 6516.9 6667.3 6502.0 6543.6 6873.1 7107.5 7107.9 6456.7 6655.1 6675.2 6750.2 6758.5 6552.7 6570.0 6578.1 6642.0 6653.0 5900.8 5911.3 5958.8 5962.6 5970.2 4280.7 4355.9 4390.1 4445.5 4480.5 4456.8 4474.8 4514.4 4549.5 4572.2 10:28:54 INFO - PROCESS | 13485 | 10:28:54 INFO - PROCESS | 13485 | [#4] prototype.html Cycles:180 Average:4257.48 Median:4881.52 stddev:1219.29 (25.0%) stddev-sans-first:1185.85 10:28:54 INFO - PROCESS | 13485 | Values: 293.4 297.2 299.9 302.7 303.3 4848.7 4880.0 4885.4 4923.2 4991.9 4873.0 4878.9 4883.0 4883.7 4892.4 3671.3 3736.3 3765.1 3872.0 3876.7 3815.8 3842.5 3846.7 3850.4 3856.9 3674.9 3813.3 3856.9 3860.5 3861.5 3728.9 3828.8 3838.8 3853.0 3866.7 3433.1 3437.1 3437.5 3438.4 3444.8 4736.6 4764.4 4779.5 4786.3 4793.9 4217.6 4395.3 4403.9 4425.8 4428.5 5076.5 5076.5 5090.8 5108.7 5110.8 3710.8 3710.9 3753.6 3759.5 3765.8 5079.6 5226.5 5233.7 5272.7 5302.8 3806.1 3816.4 3825.9 3829.0 3835.1 3888.3 3897.8 3910.2 3911.9 3914.2 4323.9 4335.9 4336.9 4377.5 4392.3 4858.4 5015.1 5030.5 5075.4 5083.4 1327.6 1342.7 1345.5 1359.1 1360.6 878.2 882.0 895.8 896.5 904.0 4334.7 4365.5 4491.3 4502.6 4539.8 5203.3 5208.3 5218.6 5220.9 5244.4 4263.3 4479.8 4481.4 4485.7 4513.5 2728.3 2751.3 2767.8 2774.3 2800.6 4898.3 4902.2 4902.5 4906.3 4914.0 5095.0 5321.8 5323.2 5376.2 5380.7 4949.9 4955.2 4960.4 5007.0 5023.5 5324.8 5334.8 5338.8 5350.8 5364.9 4932.2 5214.5 5220.9 5254.6 5259.3 5011.6 5032.7 5036.3 5041.9 5045.3 3787.3 3789.9 3791.2 3793.5 3793.9 5116.2 5210.4 5235.1 5244.3 5326.0 5109.9 5140.0 5164.8 5175.4 5182.4 5096.8 5171.2 5181.7 5182.4 5225.0 4761.3 4938.9 5000.5 5020.1 5022.9 4952.4 5033.4 5092.1 5092.4 5100.1 4961.6 4965.5 4966.7 5023.0 5030.5 10:28:54 INFO - PROCESS | 13485 | 10:28:54 INFO - PROCESS | 13485 | [#5] yui.html Cycles:180 Average:16590.65 Median:26472.06 stddev:22549.11 (85.2%) stddev-sans-first:22580.69 10:28:54 INFO - PROCESS | 13485 | Values: 673.9 720.7 738.1 765.4 771.3 12382.3 12688.3 13397.6 13415.8 13440.3 13033.4 13099.1 13165.6 13246.1 13247.1 627.8 777.7 783.1 798.9 803.1 805.2 805.5 811.8 812.3 812.9 845.2 850.5 850.5 851.0 851.4 651.7 804.7 827.3 841.1 841.4 606.2 607.5 607.6 607.7 607.8 13351.4 13353.7 13368.6 13390.4 13391.7 12750.3 13274.1 13281.4 13334.6 13462.6 11935.9 11947.7 12015.5 12362.2 12415.1 4254.3 4256.6 4308.7 4341.5 4395.1 60514.0 60549.4 60586.7 61170.0 61558.0 9656.0 9894.6 9903.8 10037.4 10263.6 18695.3 18717.8 18721.9 18729.7 18732.3 6828.5 6843.1 6960.8 6989.9 6994.9 3678.4 3692.8 3735.4 3782.4 3813.6 2726.7 2829.1 2833.9 2836.0 2839.3 497.8 511.4 511.8 512.6 530.0 500.2 562.0 562.3 575.3 589.2 8128.6 8477.8 8832.6 9022.5 9057.2 580.5 585.4 605.8 625.9 640.5 3961.9 4013.3 4080.5 4242.6 4547.6 77366.0 80688.0 81127.0 84950.2 107897.5 75528.6 77974.6 78521.0 78938.0 79458.0 48396.5 68384.3 69403.3 70975.0 71196.6 7064.6 7186.8 7406.7 8332.8 8891.7 32028.4 39421.2 39811.8 42496.3 42860.8 40443.0 40796.0 45386.3 51041.0 58087.7 10759.9 11063.8 11081.2 11749.8 12245.9 13426.9 13430.3 13552.3 13656.6 14407.1 12114.6 12154.0 12359.0 12777.1 13313.1 12147.7 12200.4 12333.3 12632.6 13636.1 10297.8 10589.8 10733.6 11428.6 11649.4 9759.2 9836.6 9857.2 9900.7 9982.3 10322.5 10423.8 10429.0 10519.0 10550.2 10:28:54 INFO - PROCESS | 13485 | -------- Summary: end -------- 10:28:54 INFO - PROCESS | 13485 | 10:28:55 INFO - TEST-INFO | 13485: exit 0 10:28:55 INFO - TEST-OK | dromaeo_css | took 1122010ms 10:28:55 INFO - TEST-START | kraken 10:28:55 INFO - operating with platform_type : linux_ 10:28:55 INFO - Initialising browser for kraken test... 10:28:55 INFO - TEST-INFO | started process 13673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdhlV_d/profile http://localhost:38162/getInfo.html) 10:29:00 INFO - PROCESS | 13673 | __metrics Screen width/height:1600/1200 10:29:00 INFO - PROCESS | 13673 | colorDepth:24 10:29:00 INFO - PROCESS | 13673 | Browser inner width/height: 1024/697 10:29:00 INFO - PROCESS | 13673 | __metrics 10:29:01 INFO - PROCESS | 13673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:29:01 INFO - PROCESS | 13673 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:29:02 INFO - TEST-INFO | 13673: exit 0 10:29:02 INFO - Browser initialized. 10:29:02 INFO - Running cycle 1/1 for kraken test... 10:29:02 INFO - TEST-INFO | started process 13756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdhlV_d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:29:14 INFO - PROCESS | 13756 | RSS: Main: 159395840 10:29:14 INFO - PROCESS | 13756 | 10:29:17 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:38162/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38162/tests/kraken/driver.html?testName=audio-beat-detection) 10:29:18 INFO - PROCESS | 13756 | RSS: Main: 216805376 10:29:18 INFO - PROCESS | 13756 | 10:29:21 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:38162/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38162/tests/kraken/driver.html?testName=audio-dft) 10:29:21 INFO - PROCESS | 13756 | RSS: Main: 203788288 10:29:21 INFO - PROCESS | 13756 | 10:29:24 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:38162/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38162/tests/kraken/driver.html?testName=audio-fft) 10:29:25 INFO - PROCESS | 13756 | RSS: Main: 271482880 10:29:25 INFO - PROCESS | 13756 | 10:29:27 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:38162/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38162/tests/kraken/driver.html?testName=audio-oscillator) 10:29:28 INFO - PROCESS | 13756 | RSS: Main: 182083584 10:29:28 INFO - PROCESS | 13756 | 10:29:30 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:38162/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38162/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:29:31 INFO - PROCESS | 13756 | RSS: Main: 186019840 10:29:31 INFO - PROCESS | 13756 | 10:29:34 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:38162/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38162/tests/kraken/driver.html?testName=imaging-darkroom) 10:29:34 INFO - PROCESS | 13756 | RSS: Main: 222384128 10:29:34 INFO - PROCESS | 13756 | 10:29:38 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:38162/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38162/tests/kraken/driver.html?testName=imaging-desaturate) 10:29:39 INFO - PROCESS | 13756 | RSS: Main: 222617600 10:29:39 INFO - PROCESS | 13756 | 10:29:41 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:38162/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38162/tests/kraken/driver.html?testName=json-parse-financial) 10:29:42 INFO - PROCESS | 13756 | RSS: Main: 223391744 10:29:42 INFO - PROCESS | 13756 | 10:29:44 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:38162/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38162/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:29:44 INFO - PROCESS | 13756 | RSS: Main: 209842176 10:29:44 INFO - PROCESS | 13756 | 10:29:46 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:38162/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38162/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:29:47 INFO - PROCESS | 13756 | RSS: Main: 214294528 10:29:47 INFO - PROCESS | 13756 | 10:29:49 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:38162/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38162/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:29:50 INFO - PROCESS | 13756 | RSS: Main: 211263488 10:29:50 INFO - PROCESS | 13756 | 10:29:52 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:38162/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:29:53 INFO - PROCESS | 13756 | RSS: Main: 223588352 10:29:53 INFO - PROCESS | 13756 | 10:29:56 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:38162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:29:57 INFO - PROCESS | 13756 | RSS: Main: 224497664 10:29:57 INFO - PROCESS | 13756 | 10:29:58 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:38162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38162/tests/kraken/driver.html?testName=ai-astar) 10:29:59 INFO - PROCESS | 13756 | RSS: Main: 266891264 10:29:59 INFO - PROCESS | 13756 | 10:29:59 INFO - PROCESS | 13756 | __start_tp_report 10:29:59 INFO - PROCESS | 13756 | _x_x_mozilla_page_load 10:29:59 INFO - PROCESS | 13756 | _x_x_mozilla_page_load_details 10:29:59 INFO - PROCESS | 13756 | |i|pagename|runs| 10:29:59 INFO - PROCESS | 13756 | |0;ai-astar;105;115;114;114;113;114;115;113;114;114 10:29:59 INFO - PROCESS | 13756 | |1;audio-beat-detection;155;130;131;195;124;152;155;124;187;123 10:29:59 INFO - PROCESS | 13756 | |2;audio-dft;162;161;161;158;160;161;162;160;160;160 10:29:59 INFO - PROCESS | 13756 | |3;audio-fft;75;90;77;106;78;77;76;76;100;78 10:29:59 INFO - PROCESS | 13756 | |4;audio-oscillator;86;86;118;85;85;86;115;85;85;124 10:29:59 INFO - PROCESS | 13756 | |5;imaging-gaussian-blur;117;116;118;117;117;117;118;117;117;117 10:29:59 INFO - PROCESS | 13756 | |6;imaging-darkroom;146;147;146;147;146;146;146;146;146;147 10:29:59 INFO - PROCESS | 13756 | |7;imaging-desaturate;95;95;95;96;95;95;95;96;96;95 10:29:59 INFO - PROCESS | 13756 | |8;json-parse-financial;63;62;62;63;63;64;62;62;63;63 10:29:59 INFO - PROCESS | 13756 | |9;json-stringify-tinderbox;64;64;64;64;65;65;64;66;64;65 10:29:59 INFO - PROCESS | 13756 | |10;stanford-crypto-aes;78;78;78;78;79;78;78;80;83;80 10:29:59 INFO - PROCESS | 13756 | |11;stanford-crypto-ccm;130;136;128;138;142;131;129;131;175;127 10:29:59 INFO - PROCESS | 13756 | |12;stanford-crypto-pbkdf2;172;168;168;168;167;170;166;173;170;171 10:29:59 INFO - PROCESS | 13756 | |13;stanford-crypto-sha256-iterative;67;69;67;69;66;74;68;68;66;65 10:29:59 INFO - PROCESS | 13756 | __end_tp_report 10:29:59 INFO - PROCESS | 13756 | __start_cc_report 10:29:59 INFO - PROCESS | 13756 | _x_x_mozilla_cycle_collect,1912 10:29:59 INFO - PROCESS | 13756 | __end_cc_report 10:29:59 INFO - PROCESS | 13756 | __startTimestamp1468344599009__endTimestamp 10:29:59 INFO - PROCESS | 13756 | 10:29:59 INFO - PROCESS | 13756 | ------- Summary: start ------- 10:29:59 INFO - PROCESS | 13756 | Number of tests: 14 10:29:59 INFO - PROCESS | 13756 | 10:29:59 INFO - PROCESS | 13756 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:2.92 (2.6%) stddev-sans-first:0.71 10:29:59 INFO - PROCESS | 13756 | Values: 105.0 115.0 114.0 114.0 113.0 114.0 115.0 113.0 114.0 114.0 10:29:59 INFO - PROCESS | 13756 | 10:29:59 INFO - PROCESS | 13756 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:153.50 stddev:26.32 (17.1%) stddev-sans-first:27.77 10:29:59 INFO - PROCESS | 13756 | Values: 155.0 130.0 131.0 195.0 124.0 152.0 155.0 124.0 187.0 123.0 10:29:59 INFO - PROCESS | 13756 | 10:29:59 INFO - PROCESS | 13756 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.18 (0.7%) stddev-sans-first:1.12 10:29:59 INFO - PROCESS | 13756 | Values: 162.0 161.0 161.0 158.0 160.0 161.0 162.0 160.0 160.0 160.0 10:29:59 INFO - PROCESS | 13756 | 10:29:59 INFO - PROCESS | 13756 | [#3] audio-fft Cycles:10 Average:83.30 Median:77.00 stddev:11.30 (14.7%) stddev-sans-first:11.58 10:29:59 INFO - PROCESS | 13756 | Values: 75.0 90.0 77.0 106.0 78.0 77.0 76.0 76.0 100.0 78.0 10:29:59 INFO - PROCESS | 13756 | 10:29:59 INFO - PROCESS | 13756 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:85.00 stddev:16.37 (19.3%) stddev-sans-first:16.99 10:29:59 INFO - PROCESS | 13756 | Values: 86.0 86.0 118.0 85.0 85.0 86.0 115.0 85.0 85.0 124.0 10:29:59 INFO - PROCESS | 13756 | 10:29:59 INFO - PROCESS | 13756 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 10:29:59 INFO - PROCESS | 13756 | Values: 117.0 116.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 10:29:59 INFO - PROCESS | 13756 | 10:29:59 INFO - PROCESS | 13756 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 10:29:59 INFO - PROCESS | 13756 | Values: 146.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 10:29:59 INFO - PROCESS | 13756 | 10:29:59 INFO - PROCESS | 13756 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:29:59 INFO - PROCESS | 13756 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 10:29:59 INFO - PROCESS | 13756 | 10:29:59 INFO - PROCESS | 13756 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 10:29:59 INFO - PROCESS | 13756 | Values: 63.0 62.0 62.0 63.0 63.0 64.0 62.0 62.0 63.0 63.0 10:29:59 INFO - PROCESS | 13756 | 10:29:59 INFO - PROCESS | 13756 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 10:29:59 INFO - PROCESS | 13756 | Values: 64.0 64.0 64.0 64.0 65.0 65.0 64.0 66.0 64.0 65.0 10:29:59 INFO - PROCESS | 13756 | 10:29:59 INFO - PROCESS | 13756 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:78.50 stddev:1.63 (2.1%) stddev-sans-first:1.69 10:29:59 INFO - PROCESS | 13756 | Values: 78.0 78.0 78.0 78.0 79.0 78.0 78.0 80.0 83.0 80.0 10:29:59 INFO - PROCESS | 13756 | 10:29:59 INFO - PROCESS | 13756 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:133.50 stddev:14.28 (10.7%) stddev-sans-first:14.94 10:29:59 INFO - PROCESS | 13756 | Values: 130.0 136.0 128.0 138.0 142.0 131.0 129.0 131.0 175.0 127.0 10:29:59 INFO - PROCESS | 13756 | 10:29:59 INFO - PROCESS | 13756 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:170.00 stddev:2.26 (1.3%) stddev-sans-first:2.18 10:29:59 INFO - PROCESS | 13756 | Values: 172.0 168.0 168.0 168.0 167.0 170.0 166.0 173.0 170.0 171.0 10:29:59 INFO - PROCESS | 13756 | 10:29:59 INFO - PROCESS | 13756 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:2.51 (3.7%) stddev-sans-first:2.65 10:29:59 INFO - PROCESS | 13756 | Values: 67.0 69.0 67.0 69.0 66.0 74.0 68.0 68.0 66.0 65.0 10:29:59 INFO - PROCESS | 13756 | -------- Summary: end -------- 10:29:59 INFO - PROCESS | 13756 | 10:30:00 INFO - TEST-INFO | 13756: exit 0 10:30:00 INFO - TEST-OK | kraken | took 64571ms 10:30:00 INFO - SUITE-END | took 1186s 10:30:00 INFO - Completed test suite (00:19:46) 10:30:00 INFO - javascript benchmark 10:30:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2647.510210611037, 2650.4301575161335, 2667.3465001074733, 2668.90658826941, 2670.8798104085313, 4608.5161058088925, 4702.576768090871, 4718.811247550098, 4766.833160839371, 4843.685160464567, 4751.9524804751945, 4755.714657120575, 4757.524247575241, 4771.7614119293985, 4776.426828780551, 4321.978390108053, 4345.391645169679, 4410.889727756799, 4445.88885277869, 4488.685791994561, 4400.691951563392, 4437.290033594625, 4446.288593824988, 4460.130274596455, 4490.057088011522, 4209.284421648327, 4254.1279037797485, 4312.202242585132, 4359.651227901761, 4367.279398899178, 4329.242382583036, 4347.413099231595, 4350.260455722503, 4383.495897971742, 4385.846495372647, 4355.150745604608, 4375.343698445226, 4385.671074669381, 4421.381006659039, 4430.24685803411, 4644.535546445362, 4686.461056978457, 4714.882127946795, 4787.712737235777, 4791.209450440673, 5119.129747942859, 5122.257272695476, 5186.092433824066, 5188.558972487343, 5189.143791274435, 5189.143791274435, 5216.035033518811, 5223.2165175223645, 5224.712640804754, 5227.085260079471, 4656.674032817704, 4672.2057250267535, 4723.0, 4726.669133160714, 4726.692764970335, 5189.662671926313, 5200.349956255468, 5207.661502002357, 5218.765155568009, 5222.843314700565, 4749.786259618326, 4995.300657907823, 5001.699898006132, 5002.674826136289, 5004.949950500449, 5030.84907452777, 5112.488751124932, 5115.411727651293, 5151.5363617274625, 5176.120059589879, 5064.341635587423, 5065.39215294167, 5072.0, 5078.035173317058, 5125.1287281162295, 5033.874153146201, 5041.521055499722, 5041.79832806691, 5043.36957880265, 5044.470330615232, 4127.6904232182105, 4147.52303485097, 4153.252414565347, 4200.138971510833, 4201.621854033152, 3716.3310604090984, 3740.4389341598976, 3752.7373083883867, 3754.5494540655295, 3757.868474603376, 4342.848000319974, 4371.519132895379, 4371.868843934623, 4383.276759334738, 4388.5611438856495, 5093.8726531837, 5098.719570423662, 5101.2603172539775, 5107.8723031923755, 5112.6421150519855, 4283.400323954649, 4309.892252693645, 4380.277254253013, 4381.956180438218, 4427.734335939854, 4473.306637471197, 4496.348029535699, 4519.570640789119, 4563.612092972135, 4567.0, 4716.103940251342, 4729.834455794031, 4731.455882573479, 4733.479317275166, 4775.355327030807, 4866.197077482176, 4999.375078115236, 5038.949610503848, 5051.823186188466, 5053.11570475158, 4730.810767569396, 4755.881102972315, 4784.617230621611, 4799.736014519235, 4803.375561177025, 4985.152524070844, 4986.775595098156, 4992.0, 4998.550130488274, 5021.347224860745, 4951.133551628379, 5049.368828896388, 5054.545090941833, 5061.392632884077, 5110.540051395392, 4861.975690121527, 4886.511348865227, 4905.950940490692, 4912.140375434356, 4916.360873086476, 4882.048000639841, 4890.975545122394, 4893.584045356042, 4893.73084480357, 4938.802447902043, 4764.2615394613895, 4799.472058073539, 4829.372181616367, 4886.193778026728, 4891.33966914462, 4971.105201063843, 5018.172001619692, 5045.268436076822, 5049.64652474338, 5095.745212739423, 4890.119778439915, 4903.828366007316, 4912.066707325596, 4933.9506604933495, 4963.776630051729], "value": 4654.7521330527325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.9414812416152, 584.9210356601859, 586.3462239602844, 593.1843714892024, 593.9316978547467, 41718.0, 42446.0, 42502.362464563055, 42538.361924571116, 46215.53784462155, 42109.0, 42628.57371426285, 42677.14645707084, 42679.0, 42685.35971960423, 7525.435592330569, 7927.128015918259, 8068.878966815502, 8071.9596402017905, 10218.233632477593, 9788.070133337322, 10170.135538479239, 10193.694189174337, 10201.744956376113, 10262.127719143882, 10565.947170264139, 10611.363318200894, 10616.20378471614, 10618.203634727388, 10622.203334749885, 7649.923500764977, 10195.847062294071, 10425.322354046963, 10449.216308776871, 10487.632932847351, 10295.639652612123, 10376.533056012422, 10379.688609341732, 10383.688489345332, 10386.948065259625, 40152.19695606101, 40379.394309085386, 40412.59587404118, 40435.0, 40545.783626491255, 2431.222008957134, 2799.986000070007, 2936.3980384021224, 2945.528715405525, 3042.421939831425, 30576.54135187974, 30929.226769330722, 31011.844940775376, 31339.05982820519, 32024.0, 3251.268464595471, 3259.6903294187014, 3309.2885029718486, 3361.4957756336503, 3368.7028956763384, 284665.0, 287011.0, 287470.0, 287826.0, 290748.54625726945, 47463.288050679264, 53064.73467632637, 54644.18033729497, 56915.86168276694, 57407.712961434925, 59035.0, 59181.704091480125, 59319.11021334684, 59406.40593594095, 59466.70266648639, 15281.46514871974, 15533.145676987875, 15542.378304867905, 15631.687366252838, 15639.68720625581, 9913.355631883904, 10655.89344106549, 10878.945605271923, 11024.118070554336, 11328.09375249978, 17689.911550442164, 17767.46697599074, 17773.377931772327, 17790.733139002925, 17791.73312400315, 6485.870282594322, 6525.869482610321, 6616.569922954993, 6702.128723265944, 6728.400305836354, 802.6147449224405, 899.6851102114208, 936.2930987104828, 1015.4313584392763, 1033.5142483032962, 28552.571711424345, 29093.051814292656, 29258.414831703245, 29379.355857972885, 29396.0, 956.6657356051213, 959.4579062829479, 987.6493844685177, 1015.918726501878, 1023.902729240721, 14909.179995100374, 15263.847361526465, 15360.923195383952, 15420.0, 15483.767743483857, 383582.0, 384204.0, 387173.0, 387311.0, 392242.0, 51927.48072519226, 51994.74002629962, 52087.479125208265, 52128.47871521236, 52135.0, 1061.9522121504551, 1104.640991677692, 1173.3253379306761, 1193.2482536002262, 1202.915795894279, 29356.853215733783, 29868.10395688133, 30345.696543034286, 30381.848090759406, 30466.476676166545, 42706.0, 43452.130957380046, 43595.0, 43691.0, 43720.0, 293307.0, 296138.5193074021, 297655.0, 298238.0, 298293.0, 31829.612779042127, 31857.203569910936, 33462.0, 38178.61821381862, 41741.37387939123, 42160.67088960565, 42359.576404235566, 43288.35067474053, 43853.12293754171, 43938.12123757443, 35366.0, 37357.25285494329, 37589.0, 38519.614803852724, 38536.42195367016, 36887.44668829916, 37473.437898431, 38065.0, 38117.04707382338, 38256.426153607164, 32701.509477357384, 33646.32707345888, 33668.83165584156, 33784.1553961153, 33978.49032264567, 32864.342713145124, 33336.666633334324, 33924.32151357008, 34038.65961340355, 34255.65744342525, 23286.534269314856, 23358.76641233566, 23480.508142481925, 23656.52686946217, 23697.881510592335], "value": 18532.56353884096, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.9600995885474, 370.3056768558952, 370.7219585311017, 373.1399125016835, 384.76144790230046, 13025.60923172304, 16149.596260093489, 16616.4184253551, 18461.7230741539, 18528.351507697233, 17488.912555437204, 17936.64126717468, 18070.277188912427, 18099.095045247752, 18390.724139137925, 4772.164871147544, 5126.436092029874, 5173.732435553295, 5179.533841954223, 5182.507661772144, 3756.924861502782, 5052.26742122392, 5829.854253643651, 6143.662098584576, 6155.230596175478, 6080.543959203055, 6089.0866370044405, 6105.969470152643, 6107.694615269241, 6115.205023346981, 5132.512411320938, 5530.5299049580835, 5538.0031594313, 5578.86052848678, 5579.13523403873, 5257.342832145981, 5348.679079255257, 5423.5932305076885, 5430.294061771944, 5435.347758268994, 12403.565875194325, 12745.745085098246, 12870.29213393263, 12937.611871643865, 13051.804222936664, 1862.655408749372, 1879.746234258385, 1888.9338873139511, 1905.7141428785656, 1911.5890083631946, 8763.298936085097, 8949.821003579957, 9805.264605154642, 10073.798524029551, 13693.931530342385, 1682.1925475771575, 1747.432084572519, 1776.209586733904, 1786.8927864328182, 1800.3878681248307, 71072.0, 74067.0, 74707.0, 74730.0, 75724.34964776206, 8711.303095752324, 8942.955285223532, 9240.445573265626, 9371.812563748686, 10457.947710261553, 12820.871791281968, 13496.730065398637, 13555.390007449689, 13967.23180225077, 14052.227127508086, 7122.430205583541, 7310.1593316768185, 7382.224866388952, 7427.740029098955, 7471.215522370073, 6857.074294970215, 6928.688209030605, 7087.610181439967, 7090.680919358641, 7092.361687448154, 4365.4761428628135, 4458.554144585581, 4464.352668863062, 4467.106578684276, 4518.096380723869, 1797.613513094691, 1810.5926166612671, 1826.8629852761096, 1847.3718935561706, 1852.2035524724497, 817.7955511122219, 849.3290300662532, 874.8950125984795, 897.8563429851192, 910.7131253655077, 17127.400540981256, 17263.0, 17829.46511604654, 17941.0, 18089.547761306072, 832.5629044751554, 842.6250318608284, 860.7202659135806, 868.522312727997, 879.7009016934273, 6779.661016949231, 10092.444915529717, 10156.847647285296, 10171.4914254287, 10193.905817174427, 300687.0, 301187.0, 304430.0, 383598.0, 403815.0, 85029.57485212658, 90218.54890725635, 92552.53723731473, 93330.0, 93401.5329923346, 869.7043005378201, 887.0552861202927, 890.2032680750692, 906.419891269588, 907.2605826251583, 16158.67682646364, 16469.505914822574, 16567.0, 16744.581385465463, 16878.493645190665, 39523.20953580855, 39568.84007415247, 40085.398719019824, 40468.797656012706, 41739.0, 54302.728486357315, 56192.15711764245, 56673.149902750665, 57116.42883571277, 57376.0, 7240.52936559122, 7378.852422951618, 7456.366208872307, 7536.095668519593, 7663.578503182379, 11098.889011110108, 11454.198206125491, 11488.195826292414, 11772.823407649063, 11843.940780296389, 10474.057334839901, 10542.8418573723, 10635.787284254116, 10729.517171727135, 10825.67522974312, 10463.738406539898, 10480.0, 10753.408562529135, 10753.89246107529, 10888.183386245904, 10410.68767936963, 10592.947035264775, 10632.893671063499, 10636.095931845879, 10809.56761729522, 6783.389494945479, 7262.745803896838, 7433.182349941394, 7460.440466964891, 7522.811929701801, 9544.475053871825, 9904.900950990397, 10147.79704405893, 10330.793384132425, 10681.946590266998], "value": 8235.379260510874, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1244.9315287659176, 1359.7484465373907, 1401.50947168491, 1476.6086986948453, 1675.4722262487317, 6387.584806987548, 7146.9642651786735, 7409.296116868903, 7429.962850185741, 7623.656935437904, 7367.447441441886, 7394.408447324215, 7405.22245164258, 7413.666385012674, 7471.252874712526, 2163.697082408464, 2183.6942828004094, 2184.4102092435032, 2188.0153930731153, 2188.770179131192, 2136.241634219853, 2177.68423578581, 2207.580559693653, 2208.7901649343366, 2211.436083798629, 2156.611809874222, 2169.8155656769113, 2173.2067795254775, 2181.160253302482, 2198.7801219878043, 2093.905774240163, 2099.265257159997, 2101.800328968753, 2102.316747057205, 2104.2424727098232, 2083.7082808406685, 2146.5599552091785, 2149.215536329244, 2150.451634833123, 2151.247063527768, 7279.745208917715, 7437.405007599379, 7441.776746697607, 7510.474266801326, 7527.5859827709455, 4367.279398899178, 4552.339910712961, 4564.5435456454425, 4567.200739870543, 4569.337446070301, 2742.506348857205, 2802.8738706758245, 2855.029290041375, 2867.5411934090444, 2867.641544806899, 860.8708693695933, 862.9913700863036, 867.2801574693053, 871.9564021798948, 874.8993865705462, 9709.465979371133, 9777.217822574106, 9779.364341317792, 9820.950895245549, 9831.90168098317, 3858.82635281413, 3910.1202229498704, 4077.062275676611, 4085.4893138357706, 4091.9974606221667, 7553.169151393342, 7608.467407281437, 7616.695332186761, 7623.656935437919, 7625.6568454419685, 4445.333200019958, 4452.376667266585, 4453.1761624099645, 4456.665750068758, 4459.0413061192, 3528.5060091587197, 3949.565547789741, 4063.7358571692744, 4087.7751723655483, 4124.896877578025, 3360.462326027824, 3364.3944090063533, 3525.4006818840858, 3552.4316109422884, 3578.6063533011347, 1010.030370843998, 1011.6964910526813, 1016.348433795083, 1016.8017236638784, 1020.7652239984845, 670.5909395268882, 708.7165133946463, 787.4723934963588, 792.2275781113368, 828.9088200297963, 5131.538161565402, 5179.04187725272, 5200.557952573998, 5275.630705850554, 5444.8366549003595, 450.19415246708024, 460.35090522363305, 461.3978757721139, 467.3480494709861, 610.0483246135954, 3532.788032718045, 3591.3894637911617, 3646.650739226503, 3702.9074273143387, 3733.2720119576966, 8767.0, 9038.186563209343, 9081.137291957253, 9103.0, 9134.269258459308, 9020.729378118667, 9026.18764311202, 9026.18764311215, 9033.503157326279, 9036.277097832157, 6684.966575167093, 7001.474889383317, 7009.264027277164, 7168.462365322517, 7172.892406614009, 5227.3465816772905, 5434.266374039454, 5509.641873278224, 5567.248421463212, 5619.859503512282, 8435.186434916523, 8619.913800862161, 8631.0, 8679.218870301704, 8733.475991440533, 8037.397195210499, 8353.289970352587, 8361.456505327134, 8608.440451370641, 8608.526531040852, 5689.971550142222, 5825.679587622722, 5845.678487683048, 6516.934830651633, 6667.266600674019, 6501.9674901625185, 6543.607383557001, 6873.072135261876, 7107.466939979626, 7107.928920710933, 6456.677166141768, 6655.101561289358, 6675.165604299463, 6750.1562304711915, 6758.493113016445, 6552.705128269335, 6570.0, 6578.079068930258, 6641.9667901662115, 6653.0, 5900.793472228452, 5911.290645122441, 5958.76164953397, 5962.642241465526, 5970.194023806731, 4280.72175308604, 4355.934660980024, 4390.07808360248, 4445.5109937907455, 4480.462344518679, 4456.844010459618, 4474.753888536032, 4514.367988481681, 4549.499555048876, 4572.154151481986], "value": 3899.407598661918, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.39267715828237, 297.16941149487184, 299.8515734711318, 302.6776483045555, 303.3478022252156, 4848.684835485691, 4880.048390563837, 4885.4381746099125, 4923.212286034235, 4991.900161996758, 4872.975635121828, 4878.8780280493, 4883.0, 4883.682560633556, 4892.412910450751, 3671.3024525340234, 3736.318656604525, 3765.1151979284846, 3871.9806400968096, 3876.7286289959716, 3815.771053736785, 3842.5004749382542, 3846.673032792216, 3850.402083135509, 3856.86500972466, 3674.8530058797614, 3813.294540510001, 3856.9421458678144, 3860.478835357233, 3861.4980052593123, 3728.8881333559902, 3828.808559572024, 3838.7696738195796, 3853.034952174411, 3866.729328946975, 3433.0902310887636, 3437.089171369589, 3437.4843773433936, 3438.398280300937, 3444.8459765978428, 4736.550027747358, 4764.380630518045, 4779.545943135397, 4786.2581299898575, 4793.904121917542, 4217.6204141627095, 4395.274779661352, 4403.889902752425, 4425.845095421677, 4428.535003824616, 5076.466970968032, 5076.54311111998, 5090.752765572422, 5108.693478391308, 5110.795568177268, 3710.7588006779474, 3710.9443358349645, 3753.6058713834927, 3759.496201519387, 3765.849366025383, 5079.593632509391, 5226.529612334908, 5233.738313084331, 5272.708186494295, 5302.814401495968, 3806.1245913440066, 3816.3702989007056, 3825.923481530354, 3829.0, 3835.1179228776978, 3888.300105980894, 3897.7661340319673, 3910.2375036868107, 3911.941320880189, 3914.236723838881, 4323.891902702458, 4335.913281734348, 4336.869893903188, 4377.5403582624, 4392.253316936129, 4858.392700912386, 5015.097282489187, 5030.496950305013, 5075.390953085654, 5083.389993200765, 1327.5950834995226, 1342.664333916521, 1345.5492410042746, 1359.0826192320144, 1360.5986234060977, 878.2359347367831, 881.9603117859712, 895.7581453007782, 896.5472436419566, 903.9683611073581, 4334.718243314238, 4365.541618130114, 4491.281394976788, 4502.57225563571, 4539.795709193094, 5203.297554830049, 5208.270842082035, 5218.582513398919, 5220.947790522122, 5244.423113457517, 4263.2752432086, 4479.843205487858, 4481.4174157359985, 4485.6860019798305, 4513.480949690762, 2728.2770065932546, 2751.2984189031667, 2767.8062535622716, 2774.320291528548, 2800.635917330734, 4898.338724272249, 4902.240152776325, 4902.48523904992, 4906.2640603908985, 4913.960706306914, 5094.974525127351, 5321.780322904664, 5323.22813192085, 5376.1935709643085, 5380.650257733235, 4949.925751113737, 4955.182394904872, 4960.379952505937, 5006.974965125224, 5023.522765337287, 5324.7870085196155, 5334.75993580282, 5338.839834804962, 5350.839474815762, 5364.919526207188, 4932.235503496964, 5214.504622060898, 5220.947790522198, 5254.632175747661, 5259.342582177228, 5011.574016208663, 5032.6980381177245, 5036.320096786887, 5041.949580504294, 5045.293658887832, 3787.3182827091387, 3789.886303410902, 3791.241751649736, 3793.487879136281, 3793.9241215176094, 5116.232565115262, 5210.400803907599, 5235.136202526541, 5244.344456942882, 5325.97337013328, 5109.9233511498105, 5140.0, 5164.767585458739, 5175.378954525481, 5182.352205974254, 5096.796128154832, 5171.224316352577, 5181.678671938632, 5182.424127352115, 5224.9738751306, 4761.262004389187, 4938.901221975469, 5000.474950130184, 5020.138521042971, 5022.899542009066, 4952.356193694796, 5033.446320904771, 5092.1229505329375, 5092.388913330424, 5100.056489549445, 4961.6030717543235, 4965.45380008206, 4966.701997880139, 5023.020511000466, 5030.471800461045], "value": 3870.3042511730846, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.8517526144248, 720.6612891940786, 738.0516036892594, 765.4221063097363, 771.2942657468417, 12382.31897245651, 12688.30214338211, 13397.598072057854, 13415.79876301855, 13440.260785656785, 13033.41349639266, 13099.08306418551, 13165.605031849036, 13246.072774905737, 13247.138935969155, 627.8116565030496, 777.6733771815851, 783.0955246690082, 798.8601994650942, 803.0884945586772, 805.1545876829306, 805.4965646470955, 811.7727036429809, 812.3014207781304, 812.8983877015373, 845.1801752300258, 850.4557083466586, 850.5364576305928, 851.0255757158051, 851.4167795060404, 651.6806764685317, 804.7103042904608, 827.2967977219375, 841.1210285251896, 841.4152164245883, 606.2210060072829, 607.5261296188979, 607.6020206764576, 607.7234858139536, 607.7720854679495, 13351.399187036606, 13353.666158346023, 13368.598942031755, 13390.397432115578, 13391.665208369772, 12750.29873356965, 13274.137181083199, 13281.402336894864, 13334.58987852845, 13462.564378698771, 11935.94032029843, 11947.701307467296, 12015.459304331325, 12362.19645723034, 12415.130940834146, 4254.298040823261, 4256.59562341577, 4308.6983911126235, 4341.522432532419, 4395.120975804852, 60514.0, 60549.394506054814, 60586.697066514826, 61170.0, 61558.0, 9656.0, 9894.60421583143, 9903.80192396148, 10037.44794036335, 10263.640772572924, 18695.252189912524, 18717.812821871878, 18721.906390468233, 18729.719054214198, 18732.344367947055, 6828.52200345981, 6843.135501435773, 6960.79117626472, 6989.857931336764, 6994.8950765738555, 3678.3746763050344, 3692.796896170683, 3735.4193897887335, 3782.3569993101237, 3813.580506144322, 2726.6864310604137, 2829.066408085327, 2833.943321133566, 2836.0215725574644, 2839.275984623908, 497.7610746841464, 511.4399732293133, 511.81318818630933, 512.625783178282, 530.0406264660976, 500.15973165082283, 561.9606627536115, 562.2718579439636, 575.3326141675636, 589.1604463639297, 8128.59357032146, 8477.788055298666, 8832.55837208137, 9022.548872556346, 9057.18485336323, 580.4659713063992, 585.4233579923772, 605.7758629307184, 625.9311475737666, 640.478010421505, 3961.920761584752, 4013.337799263089, 4080.510338759368, 4242.596953289432, 4547.613452856544, 77366.0, 80688.0, 81127.0, 84950.15049849423, 107897.46051269694, 75528.62235688786, 77974.610126949, 78521.0, 78938.0, 79458.0, 48396.51603483991, 68384.3161568378, 69403.3059669407, 70975.0, 71196.57606847835, 7064.576125432491, 7186.820329491805, 7406.740764073232, 8332.833343333221, 8891.73324800257, 32028.359432811678, 39421.226044828625, 39811.805645830675, 42496.30014799374, 42860.78569607132, 40443.0, 40796.0, 45386.319205211286, 51041.0, 58087.70956145192, 10759.946200268949, 11063.778724425305, 11081.168912331768, 11749.76500470003, 12245.938770306091, 13426.932865335611, 13430.261335626634, 13552.322383880964, 13656.590302290948, 14407.096404455437, 12114.575989840665, 12154.02767778558, 12359.0, 12777.105602607728, 13313.068085234328, 12147.696307592381, 12200.389980501117, 12333.260004399765, 12632.557860474839, 13636.113652612548, 10297.845532316871, 10589.841152382567, 10733.624323148964, 11428.599999000327, 11649.41752912334, 9759.219262458844, 9836.557354919189, 9857.211423086279, 9900.702978910644, 9982.301238913205, 10322.48387580633, 10423.791524169323, 10429.0, 10519.0, 10550.155987521133], "value": 6572.079482087109, "unit": "score"}], "name": "dromaeo_css", "value": 6426.916355406598, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 114.0, 114.0, 113.0, 114.0, 115.0, 113.0, 114.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 130.0, 131.0, 195.0, 124.0, 152.0, 155.0, 124.0, 187.0, 123.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 158.0, 160.0, 161.0, 162.0, 160.0, 160.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 90.0, 77.0, 106.0, 78.0, 77.0, 76.0, 76.0, 100.0, 78.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 118.0, 85.0, 85.0, 86.0, 115.0, 85.0, 85.0, 124.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 63.0, 63.0, 64.0, 62.0, 62.0, 63.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 64.0, 66.0, 64.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 78.0, 79.0, 78.0, 78.0, 80.0, 83.0, 80.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 136.0, 128.0, 138.0, 142.0, 131.0, 129.0, 131.0, 175.0, 127.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 168.0, 168.0, 167.0, 170.0, 166.0, 173.0, 170.0, 171.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 69.0, 66.0, 74.0, 68.0, 68.0, 66.0, 65.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1538.8000000000002, "alertThreshold": 2.0}]} 10:30:00 INFO - Return code: 0 10:30:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:30:00 INFO - # TBPL SUCCESS # 10:30:00 INFO - Running post-action listener: _resource_record_post_action 10:30:00 INFO - ##### 10:30:00 INFO - ##### Finished run-tests step (success) 10:30:00 INFO - ##### 10:30:00 INFO - Running post-run listener: _resource_record_post_run 10:30:00 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545918976; Read time: 36; Write time: 1170072 10:30:00 INFO - TinderboxPrint: CPU usage
13.0% 10:30:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 36 10:30:00 INFO - TinderboxPrint: I/O write bytes / time
545,918,976 / 1,170,072 10:30:00 INFO - TinderboxPrint: CPU idle
8,358.9 (87.0%) 10:30:00 INFO - TinderboxPrint: CPU user
1,201.2 (12.5%) 10:30:00 INFO - TinderboxPrint: Swap in / out
0 / 0 10:30:00 INFO - install - Wall time: 18s; CPU: 17.0%; Read bytes: 0; Write bytes: 247689216; Read time: 0; Write time: 788048 10:30:00 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298229760; Read time: 36; Write time: 382024 10:30:00 INFO - Running post-run listener: _upload_blobber_files 10:30:00 INFO - Blob upload gear active. 10:30:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:30:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:30:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:30:01 INFO - (blobuploader) - INFO - Open directory for files ... 10:30:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:30:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:30:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:07 INFO - (blobuploader) - INFO - Done attempting. 10:30:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:30:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:30:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:08 INFO - (blobuploader) - INFO - Done attempting. 10:30:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:30:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:30:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:10 INFO - (blobuploader) - INFO - Done attempting. 10:30:10 INFO - (blobuploader) - INFO - Iteration through files over. 10:30:10 INFO - Return code: 0 10:30:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:30:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:30:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eca85c0029694a73006aa103b1757cfa8a156171f06630d1ad7b9634a8886b2959dcfada545ad67d13c9813fb7d35fca84781afaabcf86dfda9dc740283dc6b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3ecfac971eded2163aa395679dbc1caa96de84628917966b5b617261a83712a33b5da9e6d852feb4b1bc2104f26b2b75335145735b77c5eef09837dc76ebaedc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/59eff796193c2b204e4025a513646964fb24a2eebbc4bfd031dada5373933055b0ad68d4188e22ccd7c3f82c8e5cd279a8da4c77a38c3a6603b5a58c03dc4569"} 10:30:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:30:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:30:10 INFO - Contents: 10:30:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eca85c0029694a73006aa103b1757cfa8a156171f06630d1ad7b9634a8886b2959dcfada545ad67d13c9813fb7d35fca84781afaabcf86dfda9dc740283dc6b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3ecfac971eded2163aa395679dbc1caa96de84628917966b5b617261a83712a33b5da9e6d852feb4b1bc2104f26b2b75335145735b77c5eef09837dc76ebaedc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/59eff796193c2b204e4025a513646964fb24a2eebbc4bfd031dada5373933055b0ad68d4188e22ccd7c3f82c8e5cd279a8da4c77a38c3a6603b5a58c03dc4569"} 10:30:10 INFO - Running post-run listener: copy_logs_to_upload_dir 10:30:10 INFO - Copying logs to upload dir... 10:30:10 INFO - mkdir: /builds/slave/test/build/upload/logs 10:30:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.083854 ========= master_lag: 11.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-07-12 10:30:21.482172) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 10:30:21.486093) ========= 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=df17445c3590ff7897617a0e00000225-1468342715.103934-535090140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eca85c0029694a73006aa103b1757cfa8a156171f06630d1ad7b9634a8886b2959dcfada545ad67d13c9813fb7d35fca84781afaabcf86dfda9dc740283dc6b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3ecfac971eded2163aa395679dbc1caa96de84628917966b5b617261a83712a33b5da9e6d852feb4b1bc2104f26b2b75335145735b77c5eef09837dc76ebaedc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/59eff796193c2b204e4025a513646964fb24a2eebbc4bfd031dada5373933055b0ad68d4188e22ccd7c3f82c8e5cd279a8da4c77a38c3a6603b5a58c03dc4569"} build_url:https://queue.taskcluster.net/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011408 build_url: 'https://queue.taskcluster.net/v1/task/eqcozRVISKGix8erxMRjqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eca85c0029694a73006aa103b1757cfa8a156171f06630d1ad7b9634a8886b2959dcfada545ad67d13c9813fb7d35fca84781afaabcf86dfda9dc740283dc6b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3ecfac971eded2163aa395679dbc1caa96de84628917966b5b617261a83712a33b5da9e6d852feb4b1bc2104f26b2b75335145735b77c5eef09837dc76ebaedc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/59eff796193c2b204e4025a513646964fb24a2eebbc4bfd031dada5373933055b0ad68d4188e22ccd7c3f82c8e5cd279a8da4c77a38c3a6603b5a58c03dc4569"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 10:30:21.511884) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 10:30:21.512273) ========= 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=df17445c3590ff7897617a0e00000225-1468342715.103934-535090140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 10:30:21.562778) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 10:30:21.563128) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 10:30:21.563464) ========= ========= Total master_lag: 11.84 =========