builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1467203088.98 results: success (0) buildid: 20160629050409 builduid: 3e7ca8ebf16746d3b8cfe73bae014375 revision: cda8c83f6a5727cad1d971a6ccf0660aa4ea0fb7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 05:24:48.983889) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 05:24:48.984299) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 05:24:48.988608) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 05:24:49.067883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 05:24:49.068153) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 05:24:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2016-06-29 05:24:49 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144984 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 05:24:49.229475) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 05:24:49.232828) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020508 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 05:24:49.282046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 05:24:49.282381) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cda8c83f6a5727cad1d971a6ccf0660aa4ea0fb7 --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 cda8c83f6a5727cad1d971a6ccf0660aa4ea0fb7 --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=5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 05:24:49,533 truncating revision to first 12 chars 2016-06-29 05:24:49,533 Setting DEBUG logging. 2016-06-29 05:24:49,533 attempt 1/10 2016-06-29 05:24:49,533 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cda8c83f6a57?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 05:24:49,971 unpacking tar archive at: fx-team-cda8c83f6a57/testing/mozharness/ program finished with exit code 0 elapsedTime=0.737071 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 05:24:50.035990) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 05:24:50.036288) ========= script_repo_revision: cda8c83f6a5727cad1d971a6ccf0660aa4ea0fb7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 05:24:50.037383) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 05:24:50.037662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 05:24:50.048688) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-29 05:24:50.049059) ========= /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=5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:24:50 INFO - MultiFileLogger online at 20160629 05:24:50 in /builds/slave/test 05:24:50 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 05:24:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:24:50 INFO - {'append_to_log': False, 05:24:50 INFO - 'base_work_dir': '/builds/slave/test', 05:24:50 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:24:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:24:50 INFO - 'branch': 'Fx-Team-Non-PGO', 05:24:50 INFO - 'buildbot_json_path': 'buildprops.json', 05:24:50 INFO - 'config_files': ('talos/linux_config.py',), 05:24:50 INFO - 'default_actions': ('clobber', 05:24:50 INFO - 'read-buildbot-config', 05:24:50 INFO - 'download-and-extract', 05:24:50 INFO - 'populate-webroot', 05:24:50 INFO - 'create-virtualenv', 05:24:50 INFO - 'install', 05:24:50 INFO - 'run-tests'), 05:24:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:24:50 INFO - 'download_minidump_stackwalk': True, 05:24:50 INFO - 'download_symbols': 'ondemand', 05:24:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:24:50 INFO - 'tooltool.py': '/tools/tooltool.py', 05:24:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:24:50 INFO - '/tools/misc-python/virtualenv.py')}, 05:24:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:24:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:24:50 INFO - 'installer_path': 'installer.exe', 05:24:50 INFO - 'log_level': 'info', 05:24:50 INFO - 'log_name': 'talos', 05:24:50 INFO - 'log_to_console': True, 05:24:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:24:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:24:50 INFO - 'opt_config_files': (), 05:24:50 INFO - 'pip_index': False, 05:24:50 INFO - 'sps_profile': False, 05:24:50 INFO - 'sps_profile_interval': 0, 05:24:50 INFO - 'suite': 'dromaeojs', 05:24:50 INFO - 'system_bits': '32', 05:24:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:24:50 INFO - 'title': 'talos-linux64-ix-039', 05:24:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:24:50 INFO - 'use_talos_json': True, 05:24:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:24:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:24:50 INFO - 'work_dir': 'build'} 05:24:50 INFO - ##### 05:24:50 INFO - ##### Running clobber step. 05:24:50 INFO - ##### 05:24:50 INFO - Running pre-action listener: _resource_record_pre_action 05:24:50 INFO - Running main action method: clobber 05:24:50 INFO - rmtree: /builds/slave/test/build 05:24:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:24:50 INFO - Running post-action listener: _resource_record_post_action 05:24:50 INFO - ##### 05:24:50 INFO - ##### Finished clobber step (success) 05:24:50 INFO - ##### 05:24:50 INFO - ##### 05:24:50 INFO - ##### Running read-buildbot-config step. 05:24:50 INFO - ##### 05:24:50 INFO - Running pre-action listener: _resource_record_pre_action 05:24:50 INFO - Running main action method: read_buildbot_config 05:24:50 INFO - Using buildbot properties: 05:24:50 INFO - { 05:24:50 INFO - "project": "", 05:24:50 INFO - "product": "firefox", 05:24:50 INFO - "script_repo_revision": "production", 05:24:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:24:50 INFO - "repository": "", 05:24:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:24:50 INFO - "buildid": "20160629050409", 05:24:50 INFO - "pgo_build": "False", 05:24:50 INFO - "basedir": "/builds/slave/test", 05:24:50 INFO - "buildnumber": 1901, 05:24:50 INFO - "slavename": "talos-linux64-ix-039", 05:24:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:24:50 INFO - "platform": "ubuntu64_hw", 05:24:50 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:24:50 INFO - "branch": "fx-team", 05:24:50 INFO - "repo_path": "integration/fx-team", 05:24:50 INFO - "revision": "cda8c83f6a5727cad1d971a6ccf0660aa4ea0fb7", 05:24:50 INFO - "stage_platform": "linux64", 05:24:50 INFO - "builduid": "3e7ca8ebf16746d3b8cfe73bae014375", 05:24:50 INFO - "slavebuilddir": "test" 05:24:50 INFO - } 05:24:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:24:50 INFO - Running post-action listener: _resource_record_post_action 05:24:50 INFO - ##### 05:24:50 INFO - ##### Finished read-buildbot-config step (success) 05:24:50 INFO - ##### 05:24:50 INFO - ##### 05:24:50 INFO - ##### Running download-and-extract step. 05:24:50 INFO - ##### 05:24:50 INFO - Running pre-action listener: _resource_record_pre_action 05:24:50 INFO - Running main action method: download_and_extract 05:24:50 INFO - mkdir: /builds/slave/test/build/tests 05:24:50 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')]} 05:24:50 INFO - https://queue.taskcluster.net/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:24:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:24:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:24:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/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 05:24:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/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 05:24:52 INFO - Downloaded 1361 bytes. 05:24:52 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:24:52 INFO - Using the following test package requirements: 05:24:52 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:24:52 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:24:52 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:24:52 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:52 INFO - u'jsshell-linux-x86_64.zip'], 05:24:52 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:24:52 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:24:52 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:24:52 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:24:52 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:24:52 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:24:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:52 INFO - https://queue.taskcluster.net/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:24:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:24:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:24:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/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 05:24:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/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 05:24:53 INFO - Downloaded 22701541 bytes. 05:24:53 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'] 05:24:53 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 05:24:54 INFO - Return code: 0 05:24:54 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 05:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:54 INFO - https://queue.taskcluster.net/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:24:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:24:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:24:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/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 05:24:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/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 05:24:56 INFO - Downloaded 22701541 bytes. 05:24:56 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'] 05:24:56 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 05:24:58 INFO - Return code: 0 05:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:58 INFO - https://queue.taskcluster.net/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:24:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:24:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:24:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/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 05:24:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/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 05:24:59 INFO - Downloaded 14405245 bytes. 05:24:59 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'] 05:24:59 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 05:24:59 INFO - Return code: 0 05:24:59 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')]} 05:24:59 INFO - https://queue.taskcluster.net/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:24:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:24:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:24:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/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 05:24:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ICmJOcDlSDWWLiRC5SfCWg/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 05:25:04 INFO - Downloaded 56467522 bytes. 05:25:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:25:04 INFO - mkdir: /builds/slave/test/properties 05:25:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:25:04 INFO - Writing to file /builds/slave/test/properties/build_url 05:25:04 INFO - Contents: 05:25:04 INFO - build_url:https://queue.taskcluster.net/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:25:05 INFO - Running post-action listener: _resource_record_post_action 05:25:05 INFO - Running post-action listener: set_extra_try_arguments 05:25:05 INFO - ##### 05:25:05 INFO - ##### Finished download-and-extract step (success) 05:25:05 INFO - ##### 05:25:05 INFO - ##### 05:25:05 INFO - ##### Running populate-webroot step. 05:25:05 INFO - ##### 05:25:05 INFO - Running pre-action listener: _resource_record_pre_action 05:25:05 INFO - Running main action method: populate_webroot 05:25:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:25:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:25:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:25:05 INFO - '--tppagecycles', 05:25:05 INFO - '7'], 05:25:05 INFO - 'tests': ['tsvgm']}}, 05:25:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:25:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:25:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:25:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:25:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:25:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:25:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:05 INFO - 'talos_options': ['--disable-e10s'], 05:25:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:05 INFO - 'talos_options': ['--disable-e10s'], 05:25:05 INFO - 'tests': ['damp', 'tps']}, 05:25:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:05 INFO - 'tests': ['damp', 'tps']}, 05:25:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:25:05 INFO - 'tests': ['dromaeo_dom']}, 05:25:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:25:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:25:05 INFO - 'tests': ['basic_compositor_video']}, 05:25:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:25:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:25:05 INFO - 'tests': ['a11yr', 05:25:05 INFO - 'ts_paint', 05:25:05 INFO - 'tpaint', 05:25:05 INFO - 'sessionrestore', 05:25:05 INFO - 'sessionrestore_no_auto_restore', 05:25:05 INFO - 'tabpaint']}, 05:25:05 INFO - 'other-e10s': {'tests': ['a11yr', 05:25:05 INFO - 'ts_paint', 05:25:05 INFO - 'tpaint', 05:25:05 INFO - 'sessionrestore', 05:25:05 INFO - 'sessionrestore_no_auto_restore', 05:25:05 INFO - 'tabpaint']}, 05:25:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:25:05 INFO - 'ts_paint', 05:25:05 INFO - 'tpaint', 05:25:05 INFO - 'sessionrestore', 05:25:05 INFO - 'sessionrestore_no_auto_restore', 05:25:05 INFO - 'tabpaint']}, 05:25:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:25:05 INFO - 'ts_paint', 05:25:05 INFO - 'tpaint', 05:25:05 INFO - 'sessionrestore', 05:25:05 INFO - 'sessionrestore_no_auto_restore', 05:25:05 INFO - 'tabpaint']}, 05:25:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:25:05 INFO - 'tests': ['a11yr', 05:25:05 INFO - 'ts_paint', 05:25:05 INFO - 'tpaint', 05:25:05 INFO - 'sessionrestore', 05:25:05 INFO - 'sessionrestore_no_auto_restore', 05:25:05 INFO - 'tabpaint']}, 05:25:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:25:05 INFO - 'tests': ['a11yr', 05:25:05 INFO - 'ts_paint', 05:25:05 INFO - 'tpaint', 05:25:05 INFO - 'sessionrestore', 05:25:05 INFO - 'sessionrestore_no_auto_restore', 05:25:05 INFO - 'tabpaint']}, 05:25:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:25:05 INFO - 'tests': ['tsvgx', 05:25:05 INFO - 'tsvgr_opacity', 05:25:05 INFO - 'tart', 05:25:05 INFO - 'tscrollx', 05:25:05 INFO - 'cart']}, 05:25:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:25:05 INFO - 'tsvgr_opacity', 05:25:05 INFO - 'tart', 05:25:05 INFO - 'tscrollx', 05:25:05 INFO - 'cart']}, 05:25:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:05 INFO - 'talos_options': ['--disable-e10s'], 05:25:05 INFO - 'tests': ['tp5o']}, 05:25:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:05 INFO - 'tests': ['tp5o']}, 05:25:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:05 INFO - 'talos_options': ['--disable-e10s', 05:25:05 INFO - '--xperf_path', 05:25:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:05 INFO - 'tests': ['tp5n']}, 05:25:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:05 INFO - 'talos_options': ['--xperf_path', 05:25:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:05 INFO - 'tests': ['tp5n']}}, 05:25:05 INFO - 'talos.zip': {'path': '', 05:25:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:25:05 INFO - Running post-action listener: _resource_record_post_action 05:25:05 INFO - ##### 05:25:05 INFO - ##### Finished populate-webroot step (success) 05:25:05 INFO - ##### 05:25:05 INFO - ##### 05:25:05 INFO - ##### Running create-virtualenv step. 05:25:05 INFO - ##### 05:25:05 INFO - Running pre-action listener: _resource_record_pre_action 05:25:05 INFO - Running main action method: create_virtualenv 05:25:05 INFO - Creating virtualenv /builds/slave/test/build/venv 05:25:05 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 05:25:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:25:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:25:05 INFO - Using real prefix '/usr' 05:25:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:25:05 INFO - Installing distribute.............................................................................................................................................................................................done. 05:25:07 INFO - Installing pip.................done. 05:25:07 INFO - Return code: 0 05:25:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:25:07 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')]} 05:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:07 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')]} 05:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:07 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 0x1d40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff3b0>, '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 0x20002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', '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 05:25:07 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 05:25:07 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 05:25:07 INFO - Using env: {'DISPLAY': ':0', 05:25:07 INFO - 'HOME': '/home/cltbld', 05:25:07 INFO - 'LANG': 'en_US.UTF-8', 05:25:07 INFO - 'LANGUAGE': 'en_US:en', 05:25:07 INFO - 'LOGNAME': 'cltbld', 05:25:07 INFO - 'MAIL': '/var/mail/cltbld', 05:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:07 INFO - 'MOZ_NO_REMOTE': '1', 05:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:07 INFO - 'NO_EM_RESTART': '1', 05:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:07 INFO - 'PWD': '/builds/slave/test', 05:25:07 INFO - 'SHELL': '/bin/bash', 05:25:07 INFO - 'SHLVL': '1', 05:25:07 INFO - 'TERM': 'linux', 05:25:07 INFO - 'TMOUT': '86400', 05:25:07 INFO - 'USER': 'cltbld', 05:25:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', 05:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:07 INFO - '_': '/tools/buildbot/bin/python'} 05:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:07 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 05:25:07 INFO - Cleaning up... 05:25:07 INFO - Return code: 0 05:25:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:25:07 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')]} 05:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:07 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')]} 05:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:07 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 0x1d40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff3b0>, '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 0x20002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', '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 05:25:07 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 05:25:07 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 05:25:07 INFO - Using env: {'DISPLAY': ':0', 05:25:07 INFO - 'HOME': '/home/cltbld', 05:25:07 INFO - 'LANG': 'en_US.UTF-8', 05:25:07 INFO - 'LANGUAGE': 'en_US:en', 05:25:07 INFO - 'LOGNAME': 'cltbld', 05:25:07 INFO - 'MAIL': '/var/mail/cltbld', 05:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:07 INFO - 'MOZ_NO_REMOTE': '1', 05:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:07 INFO - 'NO_EM_RESTART': '1', 05:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:07 INFO - 'PWD': '/builds/slave/test', 05:25:07 INFO - 'SHELL': '/bin/bash', 05:25:07 INFO - 'SHLVL': '1', 05:25:07 INFO - 'TERM': 'linux', 05:25:07 INFO - 'TMOUT': '86400', 05:25:07 INFO - 'USER': 'cltbld', 05:25:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', 05:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:07 INFO - '_': '/tools/buildbot/bin/python'} 05:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:08 INFO - Downloading/unpacking psutil>=3.1.1 05:25:08 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 05:25:08 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 05:25:08 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 05:25:08 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 05:25:08 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 05:25:08 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 05:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:25:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:10 INFO - Installing collected packages: psutil 05:25:10 INFO - Running setup.py install for psutil 05:25:10 INFO - building 'psutil._psutil_linux' extension 05:25:10 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 05:25:10 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 05:25:10 INFO - building 'psutil._psutil_posix' extension 05:25:10 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 05:25:10 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 05:25:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:10 INFO - Successfully installed psutil 05:25:10 INFO - Cleaning up... 05:25:10 INFO - Return code: 0 05:25:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:10 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 0x1d40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff3b0>, '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 0x20002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', '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 05:25:10 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 05:25:10 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 05:25:10 INFO - Using env: {'DISPLAY': ':0', 05:25:10 INFO - 'HOME': '/home/cltbld', 05:25:10 INFO - 'LANG': 'en_US.UTF-8', 05:25:10 INFO - 'LANGUAGE': 'en_US:en', 05:25:10 INFO - 'LOGNAME': 'cltbld', 05:25:10 INFO - 'MAIL': '/var/mail/cltbld', 05:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:10 INFO - 'MOZ_NO_REMOTE': '1', 05:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:10 INFO - 'NO_EM_RESTART': '1', 05:25:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:10 INFO - 'PWD': '/builds/slave/test', 05:25:10 INFO - 'SHELL': '/bin/bash', 05:25:10 INFO - 'SHLVL': '1', 05:25:10 INFO - 'TERM': 'linux', 05:25:10 INFO - 'TMOUT': '86400', 05:25:10 INFO - 'USER': 'cltbld', 05:25:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', 05:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:10 INFO - '_': '/tools/buildbot/bin/python'} 05:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:25:10 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 05:25:10 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 05:25:10 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 05:25:10 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 05:25:10 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 05:25:10 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 05:25:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:25:12 INFO - Installing collected packages: mozsystemmonitor 05:25:12 INFO - Running setup.py install for mozsystemmonitor 05:25:12 INFO - Successfully installed mozsystemmonitor 05:25:12 INFO - Cleaning up... 05:25:12 INFO - Return code: 0 05:25:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:25:12 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')]} 05:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:12 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')]} 05:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:12 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 0x1d40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff3b0>, '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 0x20002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', '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 05:25:12 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 05:25:12 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 05:25:12 INFO - Using env: {'DISPLAY': ':0', 05:25:12 INFO - 'HOME': '/home/cltbld', 05:25:12 INFO - 'LANG': 'en_US.UTF-8', 05:25:12 INFO - 'LANGUAGE': 'en_US:en', 05:25:12 INFO - 'LOGNAME': 'cltbld', 05:25:12 INFO - 'MAIL': '/var/mail/cltbld', 05:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:12 INFO - 'MOZ_NO_REMOTE': '1', 05:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:12 INFO - 'NO_EM_RESTART': '1', 05:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:12 INFO - 'PWD': '/builds/slave/test', 05:25:12 INFO - 'SHELL': '/bin/bash', 05:25:12 INFO - 'SHLVL': '1', 05:25:12 INFO - 'TERM': 'linux', 05:25:12 INFO - 'TMOUT': '86400', 05:25:12 INFO - 'USER': 'cltbld', 05:25:12 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', 05:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:12 INFO - '_': '/tools/buildbot/bin/python'} 05:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:13 INFO - Downloading/unpacking jsonschema==2.5.1 05:25:13 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 05:25:13 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 05:25:13 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 05:25:13 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 05:25:13 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 05:25:13 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 05:25:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:25:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:25:15 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 05:25:15 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 05:25:15 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 05:25:15 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 05:25:15 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 05:25:15 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 05:25:15 INFO - Downloading functools32-3.2.3-2.tar.gz 05:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:25:15 INFO - warning: no files found matching '*.txt' 05:25:15 INFO - no previously-included directories found matching 'build' 05:25:15 INFO - no previously-included directories found matching 'dist' 05:25:15 INFO - no previously-included directories found matching '.git*' 05:25:15 INFO - Installing collected packages: jsonschema, functools32 05:25:15 INFO - Running setup.py install for functools32 05:25:15 INFO - warning: no files found matching '*.txt' 05:25:15 INFO - no previously-included directories found matching 'build' 05:25:15 INFO - no previously-included directories found matching 'dist' 05:25:15 INFO - no previously-included directories found matching '.git*' 05:25:15 INFO - Successfully installed jsonschema functools32 05:25:15 INFO - Cleaning up... 05:25:15 INFO - Return code: 0 05:25:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:25:15 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')]} 05:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:15 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')]} 05:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:15 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 0x1d40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff3b0>, '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 0x20002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', '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 05:25:15 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 05:25:15 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 05:25:15 INFO - Using env: {'DISPLAY': ':0', 05:25:15 INFO - 'HOME': '/home/cltbld', 05:25:15 INFO - 'LANG': 'en_US.UTF-8', 05:25:15 INFO - 'LANGUAGE': 'en_US:en', 05:25:15 INFO - 'LOGNAME': 'cltbld', 05:25:15 INFO - 'MAIL': '/var/mail/cltbld', 05:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:15 INFO - 'MOZ_NO_REMOTE': '1', 05:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:15 INFO - 'NO_EM_RESTART': '1', 05:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:15 INFO - 'PWD': '/builds/slave/test', 05:25:15 INFO - 'SHELL': '/bin/bash', 05:25:15 INFO - 'SHLVL': '1', 05:25:15 INFO - 'TERM': 'linux', 05:25:15 INFO - 'TMOUT': '86400', 05:25:15 INFO - 'USER': 'cltbld', 05:25:15 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', 05:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:15 INFO - '_': '/tools/buildbot/bin/python'} 05:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:15 INFO - Downloading/unpacking blobuploader==1.2.4 05:25:15 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 05:25:15 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 05:25:15 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 05:25:15 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 05:25:15 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 05:25:15 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 05:25:17 INFO - Downloading blobuploader-1.2.4.tar.gz 05:25:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:25:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:25:17 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 05:25:17 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 05:25:17 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 05:25:17 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 05:25:17 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 05:25:17 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 05:25:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:25:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:25:18 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 05:25:18 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 05:25:18 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 05:25:18 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 05:25:18 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 05:25:18 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 05:25:18 INFO - Downloading docopt-0.6.1.tar.gz 05:25:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:25:18 INFO - Installing collected packages: blobuploader, requests, docopt 05:25:18 INFO - Running setup.py install for blobuploader 05:25:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:25:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:25:18 INFO - Running setup.py install for requests 05:25:18 INFO - Running setup.py install for docopt 05:25:18 INFO - Successfully installed blobuploader requests docopt 05:25:18 INFO - Cleaning up... 05:25:19 INFO - Return code: 0 05:25:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:19 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')]} 05:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:19 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')]} 05:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:19 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 0x1d40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff3b0>, '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 0x20002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', '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 05:25:19 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 05:25:19 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 05:25:19 INFO - Using env: {'DISPLAY': ':0', 05:25:19 INFO - 'HOME': '/home/cltbld', 05:25:19 INFO - 'LANG': 'en_US.UTF-8', 05:25:19 INFO - 'LANGUAGE': 'en_US:en', 05:25:19 INFO - 'LOGNAME': 'cltbld', 05:25:19 INFO - 'MAIL': '/var/mail/cltbld', 05:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:19 INFO - 'MOZ_NO_REMOTE': '1', 05:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:19 INFO - 'NO_EM_RESTART': '1', 05:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:19 INFO - 'PWD': '/builds/slave/test', 05:25:19 INFO - 'SHELL': '/bin/bash', 05:25:19 INFO - 'SHLVL': '1', 05:25:19 INFO - 'TERM': 'linux', 05:25:19 INFO - 'TMOUT': '86400', 05:25:19 INFO - 'USER': 'cltbld', 05:25:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', 05:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:19 INFO - '_': '/tools/buildbot/bin/python'} 05:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:25:19 INFO - Running setup.py (path:/tmp/pip-3VrFfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:25:19 INFO - Running setup.py (path:/tmp/pip-jTDFCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:25:19 INFO - Running setup.py (path:/tmp/pip-eThJ_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:25:19 INFO - Running setup.py (path:/tmp/pip-3r698i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:25:19 INFO - Running setup.py (path:/tmp/pip-Temerr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:25:19 INFO - Running setup.py (path:/tmp/pip-6xt8AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:25:19 INFO - Running setup.py (path:/tmp/pip-kH25ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:25:19 INFO - Running setup.py (path:/tmp/pip-CVgSd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:25:19 INFO - Running setup.py (path:/tmp/pip-fI3wga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:25:19 INFO - Running setup.py (path:/tmp/pip-R2MZDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:25:19 INFO - Running setup.py (path:/tmp/pip-Up10YL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:25:20 INFO - Running setup.py (path:/tmp/pip-ijJczN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:25:20 INFO - Running setup.py (path:/tmp/pip-2xwu4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:25:20 INFO - Running setup.py (path:/tmp/pip-IeOxEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:20 INFO - Running setup.py (path:/tmp/pip-zyvZDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:25:20 INFO - Running setup.py (path:/tmp/pip-yU1Wc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:25:20 INFO - Running setup.py (path:/tmp/pip-5N6Qxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:25:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:25:20 INFO - Running setup.py install for manifestparser 05:25:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:25:20 INFO - Running setup.py install for mozcrash 05:25:20 INFO - Running setup.py install for mozdebug 05:25:20 INFO - Running setup.py install for mozdevice 05:25:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:25:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:25:20 INFO - Running setup.py install for mozfile 05:25:21 INFO - Running setup.py install for mozhttpd 05:25:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:25:21 INFO - Running setup.py install for mozinfo 05:25:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:25:21 INFO - Running setup.py install for mozInstall 05:25:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:25:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:25:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:25:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:25:21 INFO - Running setup.py install for mozleak 05:25:21 INFO - Running setup.py install for mozlog 05:25:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:25:21 INFO - Running setup.py install for moznetwork 05:25:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:25:21 INFO - Running setup.py install for mozprocess 05:25:21 INFO - Running setup.py install for mozprofile 05:25:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:25:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:25:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:25:21 INFO - Running setup.py install for mozrunner 05:25:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:25:21 INFO - Running setup.py install for mozscreenshot 05:25:22 INFO - Running setup.py install for moztest 05:25:22 INFO - Running setup.py install for mozversion 05:25:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:25:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:25:22 INFO - Cleaning up... 05:25:22 INFO - Return code: 0 05:25:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:22 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 0x1d40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff3b0>, '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 0x20002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', '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 05:25:22 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 05:25:22 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 05:25:22 INFO - Using env: {'DISPLAY': ':0', 05:25:22 INFO - 'HOME': '/home/cltbld', 05:25:22 INFO - 'LANG': 'en_US.UTF-8', 05:25:22 INFO - 'LANGUAGE': 'en_US:en', 05:25:22 INFO - 'LOGNAME': 'cltbld', 05:25:22 INFO - 'MAIL': '/var/mail/cltbld', 05:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:22 INFO - 'MOZ_NO_REMOTE': '1', 05:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:22 INFO - 'NO_EM_RESTART': '1', 05:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:22 INFO - 'PWD': '/builds/slave/test', 05:25:22 INFO - 'SHELL': '/bin/bash', 05:25:22 INFO - 'SHLVL': '1', 05:25:22 INFO - 'TERM': 'linux', 05:25:22 INFO - 'TMOUT': '86400', 05:25:22 INFO - 'USER': 'cltbld', 05:25:22 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', 05:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:22 INFO - '_': '/tools/buildbot/bin/python'} 05:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:25:22 INFO - Running setup.py (path:/tmp/pip-DaH2Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:25:22 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)) 05:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:25:22 INFO - Running setup.py (path:/tmp/pip-2BOVXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:25:22 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)) 05:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:25:22 INFO - Running setup.py (path:/tmp/pip-yqyqU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:25:22 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)) 05:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:25:22 INFO - Running setup.py (path:/tmp/pip-B8Qvy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:25:22 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)) 05:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:25:22 INFO - Running setup.py (path:/tmp/pip-jvPxZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:25:22 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)) 05:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:25:22 INFO - Running setup.py (path:/tmp/pip-YUXhuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:25:22 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)) 05:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:25:22 INFO - Running setup.py (path:/tmp/pip-BdmLSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:25:23 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)) 05:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:25:23 INFO - Running setup.py (path:/tmp/pip-sr3441-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:25:23 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)) 05:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:25:23 INFO - Running setup.py (path:/tmp/pip-AZ_abY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:25:23 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)) 05:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:25:23 INFO - Running setup.py (path:/tmp/pip-xCHa0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:25:23 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)) 05:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:25:23 INFO - Running setup.py (path:/tmp/pip-iz8dK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:25:23 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)) 05:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:25:23 INFO - Running setup.py (path:/tmp/pip-en0Lll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 05:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:25:23 INFO - Running setup.py (path:/tmp/pip-D5x9tB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:25:23 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)) 05:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:25:23 INFO - Running setup.py (path:/tmp/pip-jWYCfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 05:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:23 INFO - Running setup.py (path:/tmp/pip-p9MsIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:23 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)) 05:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:25:23 INFO - Running setup.py (path:/tmp/pip-5uEBvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:25:23 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)) 05:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:25:23 INFO - Running setup.py (path:/tmp/pip-vejYfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:25:23 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)) 05:25:23 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)) 05:25:23 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)) 05:25:23 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)) 05:25:23 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)) 05:25:23 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)) 05:25:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:25:23 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 05:25:23 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 05:25:23 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 05:25:23 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 05:25:23 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 05:25:23 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 05:25:25 INFO - Downloading blessings-1.6.tar.gz 05:25:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:25:25 INFO - Installing collected packages: blessings 05:25:25 INFO - Running setup.py install for blessings 05:25:25 INFO - Successfully installed blessings 05:25:25 INFO - Cleaning up... 05:25:25 INFO - Return code: 0 05:25:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:25:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:25:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:25:26 INFO - Reading from file tmpfile_stdout 05:25:26 INFO - Current package versions: 05:25:26 INFO - argparse == 1.2.1 05:25:26 INFO - blessings == 1.6 05:25:26 INFO - blobuploader == 1.2.4 05:25:26 INFO - docopt == 0.6.1 05:25:26 INFO - functools32 == 3.2.3-2 05:25:26 INFO - jsonschema == 2.5.1 05:25:26 INFO - manifestparser == 1.1 05:25:26 INFO - mozInstall == 1.12 05:25:26 INFO - mozcrash == 0.17 05:25:26 INFO - mozdebug == 0.1 05:25:26 INFO - mozdevice == 0.48 05:25:26 INFO - mozfile == 1.2 05:25:26 INFO - mozhttpd == 0.7 05:25:26 INFO - mozinfo == 0.9 05:25:26 INFO - mozleak == 0.1 05:25:26 INFO - mozlog == 3.2 05:25:26 INFO - moznetwork == 0.27 05:25:26 INFO - mozprocess == 0.22 05:25:26 INFO - mozprofile == 0.28 05:25:26 INFO - mozrunner == 6.11 05:25:26 INFO - mozscreenshot == 0.1 05:25:26 INFO - mozsystemmonitor == 0.3 05:25:26 INFO - moztest == 0.7 05:25:26 INFO - mozversion == 1.4 05:25:26 INFO - psutil == 3.1.1 05:25:26 INFO - requests == 1.2.3 05:25:26 INFO - wsgiref == 0.1.2 05:25:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:26 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 0x1d40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff3b0>, '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 0x20002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', '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 05:25:26 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 05:25:26 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 05:25:26 INFO - Using env: {'DISPLAY': ':0', 05:25:26 INFO - 'HOME': '/home/cltbld', 05:25:26 INFO - 'LANG': 'en_US.UTF-8', 05:25:26 INFO - 'LANGUAGE': 'en_US:en', 05:25:26 INFO - 'LOGNAME': 'cltbld', 05:25:26 INFO - 'MAIL': '/var/mail/cltbld', 05:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:26 INFO - 'MOZ_NO_REMOTE': '1', 05:25:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:26 INFO - 'NO_EM_RESTART': '1', 05:25:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:26 INFO - 'PWD': '/builds/slave/test', 05:25:26 INFO - 'SHELL': '/bin/bash', 05:25:26 INFO - 'SHLVL': '1', 05:25:26 INFO - 'TERM': 'linux', 05:25:26 INFO - 'TMOUT': '86400', 05:25:26 INFO - 'USER': 'cltbld', 05:25:26 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', 05:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:26 INFO - '_': '/tools/buildbot/bin/python'} 05:25:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:26 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)) 05:25:26 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)) 05:25:26 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)) 05:25:26 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)) 05:25:26 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)) 05:25:26 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)) 05:25:26 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)) 05:25:26 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)) 05:25:26 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)) 05:25:26 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)) 05:25:26 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)) 05:25:26 INFO - Cleaning up... 05:25:26 INFO - Return code: 0 05:25:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:26 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 0x1d40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff3b0>, '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 0x20002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', '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 05:25:26 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 05:25:26 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 05:25:26 INFO - Using env: {'DISPLAY': ':0', 05:25:26 INFO - 'HOME': '/home/cltbld', 05:25:26 INFO - 'LANG': 'en_US.UTF-8', 05:25:26 INFO - 'LANGUAGE': 'en_US:en', 05:25:26 INFO - 'LOGNAME': 'cltbld', 05:25:26 INFO - 'MAIL': '/var/mail/cltbld', 05:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:26 INFO - 'MOZ_NO_REMOTE': '1', 05:25:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:26 INFO - 'NO_EM_RESTART': '1', 05:25:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:26 INFO - 'PWD': '/builds/slave/test', 05:25:26 INFO - 'SHELL': '/bin/bash', 05:25:26 INFO - 'SHLVL': '1', 05:25:26 INFO - 'TERM': 'linux', 05:25:26 INFO - 'TMOUT': '86400', 05:25:26 INFO - 'USER': 'cltbld', 05:25:26 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', 05:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:26 INFO - '_': '/tools/buildbot/bin/python'} 05:25:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:25:26 INFO - Cleaning up... 05:25:26 INFO - Return code: 0 05:25:26 INFO - Running post-action listener: _resource_record_post_action 05:25:26 INFO - Running post-action listener: _start_resource_monitoring 05:25:26 INFO - Starting resource monitoring. 05:25:26 INFO - ##### 05:25:26 INFO - ##### Finished create-virtualenv step (success) 05:25:26 INFO - ##### 05:25:26 INFO - ##### 05:25:26 INFO - ##### Running install step. 05:25:26 INFO - ##### 05:25:26 INFO - Running pre-action listener: _resource_record_pre_action 05:25:26 INFO - Running main action method: install 05:25:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:25:26 INFO - Reading from file tmpfile_stdout 05:25:26 INFO - Detecting whether we're running mozinstall >=1.0... 05:25:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:25:26 INFO - Reading from file tmpfile_stdout 05:25:26 INFO - Output received: 05:25:26 INFO - Usage: mozinstall [options] installer 05:25:26 INFO - Options: 05:25:26 INFO - -h, --help show this help message and exit 05:25:26 INFO - -d DEST, --destination=DEST 05:25:26 INFO - Directory to install application into. [default: 05:25:26 INFO - "/builds/slave/test"] 05:25:26 INFO - --app=APP Application being installed. [default: firefox] 05:25:26 INFO - mkdir: /builds/slave/test/build/application 05:25:26 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'] 05:25:26 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 05:25:43 INFO - Reading from file tmpfile_stdout 05:25:43 INFO - Output received: 05:25:43 INFO - /builds/slave/test/build/application/firefox/firefox 05:25:43 INFO - Running post-action listener: _resource_record_post_action 05:25:43 INFO - ##### 05:25:43 INFO - ##### Finished install step (success) 05:25:43 INFO - ##### 05:25:43 INFO - ##### 05:25:43 INFO - ##### Running run-tests step. 05:25:43 INFO - ##### 05:25:43 INFO - Running pre-action listener: _resource_record_pre_action 05:25:43 INFO - Running main action method: run_tests 05:25:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:25:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:25:43 INFO - Python 2.7.3 05:25:43 INFO - Return code: 0 05:25:43 INFO - grabbing minidump binary from tooltool 05:25:43 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')]} 05:25:43 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 0x1fff3b0>, '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 0x20002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:25:43 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 05:25:43 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 05:25:43 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 05:25:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:25:43 INFO - Return code: 0 05:25:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:25:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:25:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:25:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:25:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:25:43 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/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 05:25:43 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/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 05:25:43 INFO - Using env: {'DISPLAY': ':0', 05:25:43 INFO - 'HOME': '/home/cltbld', 05:25:43 INFO - 'LANG': 'en_US.UTF-8', 05:25:43 INFO - 'LANGUAGE': 'en_US:en', 05:25:43 INFO - 'LOGNAME': 'cltbld', 05:25:43 INFO - 'MAIL': '/var/mail/cltbld', 05:25:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:25:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:43 INFO - 'MOZ_NO_REMOTE': '1', 05:25:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:25:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:43 INFO - 'NO_EM_RESTART': '1', 05:25:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:43 INFO - 'PWD': '/builds/slave/test', 05:25:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:25:43 INFO - 'SHELL': '/bin/bash', 05:25:43 INFO - 'SHLVL': '1', 05:25:43 INFO - 'TERM': 'linux', 05:25:43 INFO - 'TMOUT': '86400', 05:25:43 INFO - 'USER': 'cltbld', 05:25:43 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373', 05:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:43 INFO - '_': '/tools/buildbot/bin/python'} 05:25:43 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/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 05:25:43 INFO - mozversion application_buildid: 20160629050409 05:25:43 INFO - mozversion application_changeset: cda8c83f6a5727cad1d971a6ccf0660aa4ea0fb7 05:25:43 INFO - mozversion application_display_name: Nightly 05:25:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:25:43 INFO - mozversion application_name: Firefox 05:25:43 INFO - mozversion application_remotingname: firefox 05:25:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:25:43 INFO - mozversion application_vendor: Mozilla 05:25:43 INFO - mozversion application_version: 50.0a1 05:25:43 INFO - mozversion platform_buildid: 20160629050409 05:25:43 INFO - mozversion platform_changeset: cda8c83f6a5727cad1d971a6ccf0660aa4ea0fb7 05:25:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:25:43 INFO - mozversion platform_version: 50.0a1 05:25:43 INFO - using testdate: 1467203143 05:25:43 INFO - actual date: 1467203143 05:25:43 INFO - starting webserver on 'localhost:60745' 05:25:43 INFO - SUITE-START | Running 2 tests 05:25:43 INFO - TEST-START | dromaeo_css 05:25:43 INFO - operating with platform_type : linux_ 05:25:43 INFO - Initialising browser for dromaeo_css test... 05:25:43 INFO - TEST-INFO | started process 23749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps_NDyg/profile http://localhost:60745/getInfo.html) 05:25:47 INFO - PROCESS | 23749 | __metrics Screen width/height:1600/1200 05:25:47 INFO - PROCESS | 23749 | colorDepth:24 05:25:47 INFO - PROCESS | 23749 | Browser inner width/height: 1024/697 05:25:47 INFO - PROCESS | 23749 | __metrics 05:25:48 INFO - PROCESS | 23749 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:25:49 INFO - TEST-INFO | 23749: exit 0 05:25:49 INFO - Browser initialized. 05:25:49 INFO - Running cycle 1/1 for dromaeo_css test... 05:25:49 INFO - TEST-INFO | started process 23828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps_NDyg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:01 INFO - PROCESS | 23828 | RSS: Main: 158531584 05:26:01 INFO - PROCESS | 23828 | 05:26:52 INFO - PROCESS | 23828 | 1467203212378 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] 05:29:05 INFO - PROCESS | 23828 | Cycle 1(1): loaded http://localhost:60745/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60745/tests/dromaeo/cssquery-ext.html) 05:29:06 INFO - PROCESS | 23828 | RSS: Main: 272625664 05:29:06 INFO - PROCESS | 23828 | 05:32:09 INFO - PROCESS | 23828 | Cycle 1(1): loaded http://localhost:60745/tests/dromaeo/cssquery-ext.html (next: http://localhost:60745/tests/dromaeo/cssquery-jquery.html) 05:32:09 INFO - PROCESS | 23828 | RSS: Main: 240013312 05:32:09 INFO - PROCESS | 23828 | 05:35:11 INFO - PROCESS | 23828 | Cycle 1(1): loaded http://localhost:60745/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60745/tests/dromaeo/cssquery-mootools.html) 05:35:12 INFO - PROCESS | 23828 | RSS: Main: 233746432 05:35:12 INFO - PROCESS | 23828 | 05:38:14 INFO - PROCESS | 23828 | Cycle 1(1): loaded http://localhost:60745/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60745/tests/dromaeo/cssquery-prototype.html) 05:38:15 INFO - PROCESS | 23828 | RSS: Main: 231424000 05:38:15 INFO - PROCESS | 23828 | 05:41:18 INFO - PROCESS | 23828 | Cycle 1(1): loaded http://localhost:60745/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60745/tests/dromaeo/cssquery-yui.html) 05:41:19 INFO - PROCESS | 23828 | RSS: Main: 221052928 05:41:19 INFO - PROCESS | 23828 | 05:44:22 INFO - PROCESS | 23828 | Cycle 1(1): loaded http://localhost:60745/tests/dromaeo/cssquery-yui.html (next: http://localhost:60745/tests/dromaeo/cssquery-dojo.html) 05:44:22 INFO - PROCESS | 23828 | RSS: Main: 271814656 05:44:22 INFO - PROCESS | 23828 | 05:44:22 INFO - PROCESS | 23828 | __start_tp_report 05:44:22 INFO - PROCESS | 23828 | _x_x_mozilla_page_load 05:44:22 INFO - PROCESS | 23828 | _x_x_mozilla_page_load_details 05:44:22 INFO - PROCESS | 23828 | |i|pagename|runs| 05:44:22 INFO - PROCESS | 23828 | |0;dojo.html;2600.3889086064773;2607.1657069737666;2656.6147908553253;2665.6401385812924;2666.9866650666745;4643.767811609423;4677.204875171221;4689.9062018759605;4740.597049250818;4815.470298267188;4637.026224492852;4706.552877476643;4719.90560188796;4760.928586071203;4766.642501812361;4162.458880345551;4309.3320535317;4393.51671316155;4422.7788610569505;4529.162105010567;4431.401760762305;4456.041950980539;4474.993126546534;4485.058137791068;4509.278515437531;4264.29639109545;4306.74159550428;4321.2005778931;4366.148601022802;4400.405945197389;4307.82768689252;4309.482862056542;4310.094880075188;4379.1022840317655;4387.122575484884;4353.934690979638;4364.10535840152;4366.8034938427845;4405.911881762347;4410.250257456208;4580.610648094916;4703.082898834728;4770.546798054179;4775.212090005145;4780.139574876521;5190.766415511311;5199.870003249911;5214.270002199695;5214.687118772886;5215.191645294985;5199.506046925574;5221.451747566527;5238.030964271584;5240;5242.842714718565;4620.214563524175;4685.01614660925;4718;4730.739809310452;4780.665353425227;5207.765650545734;5225.790968361299;5234.162533994542;5235.790568377222;5236.162214045735;4850.029994001144;5014.172661510883;5018.347614810052;5022.196448568212;5024.171011783088;5126.2054381570915;5172.870678233075;5175.171972484384;5186.247994040843;5205.141151710001;5134.435212126663;5139.871503212375;5143.948560514422;5149.45930677281;5151.6908985461;4877.146499362598;4908.558229759267;5120.257562653469;5138.409082955433;5140.537351638371;4264.275073237557;4330.653547716175;4333.285007973649;4343.630791382705;4368.584984426474;3746.569144548357;3756.248750249906;3764.661180493769;3794.582595914447;3798.3732684106812;4206.663466922639;4378.715383500126;4384.539623339567;4425.778711064434;4435.866923992286;5053.317802096743;5102.795888164506;5104.897902041938;5173.586113110942;5186.092433824141;4340.761258130833;4354.629856462173;4367.868963931087;4373.431453911035;4405.427294451701;4589.472210695746;4594.264917613166;4594.655400844883;4596.88507787308;4645.744484053342;4630.3748993886065;4752.097101550833;4788;4797.4482934461585;4813.470518243061;5149.9742501287255;5159.509846564571;5166.3025491558155;5166.741662916915;5224;4574.5425457453985;4787.61699064067;4822.035592881508;4822.083804077214;4876.073546026244;5044.697318160922;5085.084684756632;5098.413682426569;5098.5411312982005;5117.692938423706;5154.716490593053;5190.766415511235;5197.038547868657;5205.427402985592;5252.9737351313;4847.5394837490385;4919.778609962632;5046.041252162077;5066.746662666778;5071.290019397361;4919.926201106915;4964.7765850537535;4981.252812078073;4985.75071246429;5028.924566131438;4888.877778055577;4907.631927605373;4961.181405068123;4971.080350135092;4976.2286845539;4810.037992401463;4926.901461970812;4981.576565991932;5057;5070.062038522885;4883.291922671264;4911.533404326726;4911.7298548580175;4915.992221594636;4958.7024778513405 05:44:22 INFO - PROCESS | 23828 | |1;ext.html;544.9073039451099;573.9885202295955;588.3469349022585;591.9852003699909;598.1207624791556;27404.86297568512;40502.39246411302;40763.79618101913;40928.79535602325;40936;41793.79103104488;42272.365914511305;42278.788606057;42286.36570451446;42298;7515.924840751577;7842.882356764668;7989.081255655587;8002.119766825645;10087.596496140182;9922.801543969117;10245.590176392972;10257.43584102874;10266.178705703525;10279.537420816045;10238.078572928434;10259.948700256487;10290.279680422373;10309.072183503484;10310.381377117359;7569.243075692414;10031;10220.693379198636;10371.844422333672;10430;10189.847152292721;10265.435401052939;10277.075063244343;10279.126274266697;10281;38906.41640375397;39194.41208381877;39221;39285;39362.21275574501;3218.5494030835466;3299.2411745298714;3414.726821854246;3496.283261931298;3740.8503659853573;29820.84511545655;29875.551866722017;29892.70107298921;30283.394332113454;30513;3412.3687117883023;3512.438009918401;3548.361294966905;3605.6394360563995;3615.7649752766247;257003;261030;261059.9999999981;261440;262818;51262.231066534034;51327.230091548656;51638.74180629073;51708.48291517112;51722.74138629358;55186.17220741692;55319.72340138354;55679.443205567426;55681;55745.442545574835;14936.477223297132;15339.846601533842;15424.305906234247;15507.379704811681;15520.146391948325;9739.707808765748;10350.016748408889;10715.892841071489;10771.83842242367;10845.620403285848;15009.624759381102;15075.773863392058;15099.245037748069;15125.168115753519;15284.923575382052;5767.653940763567;5825.2135961644635;5893.44012318829;5929.466348028698;5959.67221802805;781.4451739265186;843.8565443874556;896.9372143949861;984.4093543873619;992.4392718114386;25697;26733.732662673123;27063.323416914736;27150.321241969108;27272.86363568209;952.8999455057119;961.423146112327;996.4768496539375;1004.7889943112028;1015.7105225010837;14318.284085795669;14529.200893950934;14553.417863285349;14563.781543276858;14744.926275368769;295536;295915;297016;298178;298348;45945.54054459413;45998.77000614975;46074;46135.76932115318;46279.07441851144;1087.896649818266;1154.4054811771775;1178.6228406909706;1193.6240084373394;1238.6036468330408;26205.475890482467;29358.12801486059;29494.41011179807;29747.958821441145;29927.251818703837;43186.56813431825;44028.77985610051;44080;44168.55831441644;44205.55794442014;331953;342682;343076;343841;344104;33633.49549756707;38236.235275294894;39442;40643.593564065166;42365.152696945275;42090;42347;42686;42746.5725342755;43369.56630433655;36126.458103127945;36453.63546364608;36502.26995460129;36595.34376317223;37029.44455833219;36333.27333453369;36340.81829590941;36422.635773642985;36451.635483645885;36683.44974825326;35666.46500302446;35878;35963;36144.27711445809;36486.27027459383;32492.512612311308;33379.83310083434;33998.49002264919;34014;34189.14527136841;25028.874855626334;25240.747592524574;25367.873160634077;25561.74438255668;25715.485690286463 05:44:22 INFO - PROCESS | 23828 | |2;jquery.html;358.3227699647666;360.58532687409473;360.93142302962434;376.51053630280626;380.4483498926557;16106.114163721006;17585.3845115421;18167.182476788545;18196.181171847267;18210;14888.404463821435;15350.385984560631;15643.217839108056;15643.452479163232;15655;4883.413990321166;5076.416212135615;5101.030804147219;5125.8462246132485;5128;3730.6455886690856;3925.548561915388;5026.246063090547;5794.71026448678;6122.448979591836;6178.165947597062;6183.567150299481;6190.071489276599;6199.9690001549925;6209.844753881144;5838.737256823432;6063;6070.332263451017;6074.726637301288;6080.665563394012;3366.2930784535033;4939.703617782909;5212.218167274939;5216.165413533854;5250.8687282817855;20746.27388041411;20942.685859712117;20979.685304720442;21033.5793284135;21322.147114115418;1951.5218771400955;2124.925627603042;2508.8996440142373;2539.212844018342;2566.0762125634756;12944.546940857024;13007.674808129777;13436.596902092953;13437.798433023512;13466.461341546326;1693.4665580342153;1719.2263481433406;1765.4350607805507;1799.5501124718821;1825.7535232743542;67664.66167669179;68152;68659.3134068658;69526;69866.3013369865;9239.445633262027;9254.444733316022;9340.20608248293;9543.61825526985;9610.183134433511;12907.031972602092;13003.674908127372;13004.154729942524;13040.413181406859;13050.54323098687;7382.483226174224;7537.2462753724185;7557.4331925105835;7585.658645360972;7646.35006024483;7373.004644373048;7419.183889772229;7483.251674832473;7502.924970750222;7606.125295590967;5831.88336233273;6045.093236014545;6087.421694938974;6154.446099851035;6219.875602487925;1578.486991727693;1580.2730743857953;1613.9354425822835;1668.9415870444477;1675.698374292639;852.5950173667459;863.5250612163285;877.4954401219325;900.9774755631162;968.3366893677853;16441.91779041097;17297.65404691899;17964;18003.549911252063;18340.15831292477;850.1753299299669;867.913208679127;868.2619773192736;880.0011986395359;971.9222462203007;9881.308308418342;10330.320199243928;10368.170546356425;10391.68824935238;10414.947925260325;410409;411225;425249;427257;428452;68962.31037689559;69617.65191174114;69677;72389.63805181046;73158.63420682863;908.5502676175336;930.9627614895328;937.086340817711;937.4890684576922;945.3146468810057;15426.228688565303;15879.047257164608;15927.68144637124;16219.51341459758;16245.756313655069;34795.130121747155;35926.28147437089;37303.626963730014;40058.39912401375;40549;48251.75874120607;49362.77452288658;57408.71295643495;57667;57811.06267247957;7416.480846340704;7734.651940662571;7826.139124696165;7866.410019248465;7952.403569732178;11417;11976.46105925253;11987.880121198676;12138.878611213775;12187.207831490925;9853.655122070693;9878.604855805686;9889.604415823575;10097.141742951637;10548.841767373342;10356.430396327973;10392.42841643717;10692.8930710695;10792.406417646791;10991.571095757501;10073.798524029331;10077.546510407195;10202.081812636898;10469.68590942273;10472.476376181008;6715.127033485615;6936.375726184668;7032.331928466788;7108.466864985044;7956.681732730626;7321.78034658961;7389.445791565547;9071.909280907106;9955.800883982425;10268.691939241835 05:44:22 INFO - PROCESS | 23828 | |3;mootools.html;1183.846100006999;1337.5251785616108;1379.8620137986202;1435.9641008974775;1677.5806048487887;7287.6356182190875;7678.769636910894;7684.385249180066;7834.138244793068;7852.725154619589;7621.428392870529;7785.532868027923;7790.104138024129;7792.96103519483;7796.41526885483;1879.7744270687467;1966.862319637626;1967.6359873423391;2211.7345918489764;2241.9887900560557;1942.689169732843;2166.2201607421316;2259.062489067035;2259.344790010903;2270.6139956207485;2171.9782802172012;2180.5093853882827;2209.5359974405396;2210.204326442479;2213.6679498075255;1842.8617853661028;2182.3452964110784;2188.562287542498;2192.7478339990944;2195.8243340532717;2084.4684605425673;2172.0985790896757;2174.3803016140323;2189.6715492676226;2192.506685995654;7847.293743563107;7898.960505197495;7906.486078404942;7908.051033875914;7913.723019694341;4374.693771436001;4509.301058335963;4516.36770852081;4519.435070616173;4523.954760452386;2819.6757372902175;2905.128461461553;2927.0779704393262;2930.897418590339;2967.1543610071244;951.4766878216954;953.5470651440579;966.5457235099492;992.9602815887356;995.7261753017906;10527.105196058345;10547.367157970546;10568.15454763617;10571.20715946307;10572.471376431147;4025.677945764332;4109.753414795122;4217.557156498585;4219.767912764827;4241.745495270294;9061.456312621263;9082.772930676654;9090;9090.13643703847;9106.18044375996;4464.17412778637;4496.662750293741;4501.527339629357;4502.054568540578;4504.527024662363;3542.929141417157;3544.8227588620466;4078.6329230368815;4168.291390463629;4169.353750168729;3542.220711443478;3643.908902277464;3671.5777685565968;3700.9074773130887;3721.1813401051727;1142.5886680794906;1152.6945359479744;1157.4617802721775;1160.9841388784814;1169.152364535705;769.6459628570808;871.2550769092461;889.4396530185942;911.4576826788051;911.8449863523217;5296.390915044819;5415.323084614423;5673.716314184274;5705.172749951317;5899.085641725539;864.9611559206195;882.2368651116738;912;921.8663293822358;960.7213907966751;3560.626134255918;3674.0998455378603;3808.4287356896134;3931.2727145477606;3960.7623542587535;9238.815223695488;9586.808263834824;9669.613215471443;9671.468069256258;9671.564779584936;9516.333856630108;9519.952400237955;9521;9530.904690953003;9539;6834.794956151323;7161.67772450241;7168;7320.670569824264;7325.523840950321;5242.449542797951;5597.356304024926;5630.296212973379;5631.662100273997;5784.94215057844;8836.160564746338;8947.686830961145;9003.234725048444;9047.140521650434;9086.954565227132;9138.17756401927;9165.450072995374;9167.17495425415;9181.081891810765;9318.580663870278;6044.969775151096;6572.737090516326;6751.49363797727;6796.422304104207;6933.583984960918;7521.511101778586;7535.8492830141995;7607.771766847003;7613.885791713018;7621.085469743444;6584.604923704593;6708.731650733916;6788.864222715617;6845.452363810784;6885.483588730765;6712.127423434922;6785.08401365829;6802.489813263926;6857.759978400932;6873.1064961554675;6271.874562508633;6272.8118156455375;6326.051092336186;6398.87202255943;6410.647414392253;4667.766611669471;4708.3643708100335;4761.6904901181315;4770.308305295644;4815.662903596854;4544.636429085731;4634.72191668501;4694.859154225379;4711.599514041345;4722.1972264714395 05:44:22 INFO - PROCESS | 23828 | |4;prototype.html;294.20857892269794;297.64134218266986;305.87306267898816;306.9869430878102;307.6631088957592;4704.4589872164715;4838.153323168441;4913.828016019435;4944.6044316454645;4971.036440605963;4598.620413875832;4787.688800227983;4795.376601041859;4818.325434439182;4847.878803029926;3819.427085937104;3822.503074600298;3833.3291673957087;3846.961530384688;3861.7489863158944;3653.981730091346;3681.6561954886406;3788.0908581940275;3854.94217586735;3856.479375284329;3731.4962480065115;3750.4374343848367;3768.3028639701743;3774.3017541754725;3778.2821263959895;3727.1613886875234;3745.62543745626;3749.3626083565723;3763.9623603763885;3774.6036666149935;3339.5658564386717;3377.0881861897396;3382.8308584570673;3385.559877215946;3394.2702319001287;4627.3521706961055;4695.906081878344;4714.245720684708;4717.0330082333385;4719.292106184065;4303.35449682547;4314.741115533078;4317.03574873435;4321.870343889688;4330.978345108286;4794.674582827326;4939.234418665113;4979.759108401234;4994.500549945013;4998.375203099613;3568.8215589220695;3579.94630080549;3580.9283814323567;3581.2658405026905;3587.4798154267487;5333.919991200135;5345.1447768356875;5353.946460535384;5363.490468405495;5395.5953303502;3634.0914771307175;3736.5889752127246;3737.570179429346;3740.7942563158745;3754.755940863835;3695.8521659133335;3723.515942927402;3735.159589092487;3758.3422900992764;3762.9435558466644;4257.850380397275;4290.356446533045;4314.848980285675;4321.805518751664;4330.198913201068;4857.805687772449;5101.387833460009;5111.5655169310285;5149.433562308143;5152.92270615941;1257.1702676233642;1288.5103660608909;1288.9033322500663;1295.1452041652465;1302.3878776974807;810.6745471154704;813.2111851504031;822.5147163173756;829.2909562324126;832.9837598130272;3990.541087774943;3994.6205110514456;4021.1756589899;4023.456833327522;4033.4554835096887;4592.540745925381;4601.3558101865765;4620.966774619157;4645.3032045193495;4647.883802904955;4005.1989602079702;4056.0265536271672;4056.229316429869;4066.1664358806374;4072.816723247461;2279.384566167159;2470.962935555968;2473.2085732565765;2501.537215615117;2514.6605208296646;4340.958170039168;4356.520782713899;4385.429894113809;4386.692931494765;4387.012922092504;4692.967547139624;4739.7630118493935;4752.976235118802;4784.258439941815;4818.301346304766;4378.591774524063;4394.714343567658;4545.999880026389;4936.481669424658;4937.950620493821;5253.50091741284;5275.601965479074;5287.841364759063;5301.125314323093;5307.601929855354;5199.688018718889;5204.479552044765;5225.88351717555;5233.712145832016;5269.78920843162;4651.651126165619;4913.533214344631;4944.208926571731;4957.231629097496;4964.304997300453;3702.4816525686965;3720.2001569662652;3721.776693398405;3751.34351488483;3757.6805971491635;5049.444561098203;5273.549773812232;5281.181416880389;5312.150055991023;5357.357117145967;4979.825706100414;5112.667676601009;5113.565346945551;5125.615578831528;5130.820421285237;5042.621803364836;5087.313212716236;5096.974515127401;5142.794288228429;5144.9742751286;4786.928196077131;4930.211166213388;5036.169032109661;5046.520580544842;5049.823256186163;5034.823781167642;5091.847244582668;5094.949050509447;5169.172932330809;5180.792768289377;4987.326710893983;5008.874778130576;5010.724410157476;5025.366755804305;5035.496450354935 05:44:22 INFO - PROCESS | 23828 | |5;yui.html;701.7017767448833;724.5145752345928;726.5894769455255;732.0264048815077;751.7256201486459;12445.688857778548;13518.324083795795;13520.797188042186;13539.119957202774;13540.864591354084;12730.172538784997;12835.871641283584;12842.101052926275;12842.293673847935;12854.228746275207;616.8797084568499;766.6013672890094;790.4703848421572;793.3375631347802;794.1185284334384;778.264540009691;782.7103971530541;783.2050468774198;784.5606460382176;785.1481142959896;647.2621211818531;837.9497230166179;843.7595285343679;845.4208866926175;845.9703910363138;657.9440747536441;662.3575132121834;663.3565441521716;796.1878883538758;828.0394742099136;604.9758009679651;608.1455554945264;608.2609629300377;608.4888693497439;608.9634621922698;12742.490300387974;12771.106022578424;12774.105812593121;12780.680482987907;12820.102592818506;12041.638750837488;12582.496700131984;12592.370381480981;12776.552820651232;13056.347182640924;11777.352245626487;11871.347075910822;11876.703082422922;11877.940610296979;12228.144029917908;4146.219828446046;4210.831566737327;4215.831366745327;4240.257954857888;4288.292431748789;59748.10377844336;59749.40250597482;59860.401395985915;59866;59934.40065599332;9862.161716254055;10020.298579099393;10371.377717336984;10583.206259530565;10585.364878107339;15945.840541594667;16085.678286434206;16195.109268990318;16195.271212795453;16204.918975405284;7030.543014704028;7035.894461583081;7094.68073936674;7139.143302803697;7183.89224161638;3844.2119365530557;3870.59358767331;3919.647231749156;3923.352646813301;3957.92084158321;2775.500409926233;2876.137158852336;2881.135659302201;2882.1641723899834;2885.192146199068;464.6491898616523;464.92096343621665;477.48908667725897;486.09828767635526;488.6042305732368;486.60098719050745;544.9863753406197;554.9667019978814;578.8350320158735;590.7991282963812;8089.716859909875;8147.063087744985;8174.550399728072;8422.578871056423;8645.481271123752;475.43898200124187;513.9537441630197;523.5419008367678;553.5129086403939;589.6108568344872;4011.939820902689;4022.1151346703678;4025.959740402617;4103.384492326115;4114.136031433432;54566.181507277426;54916.45083549113;55343.16985245224;55348.16977745337;76886.23113768903;67884.6605766968;78495.60752196203;79835.60082199668;80219.59890200628;81056.08383077857;58078.4192158073;69553;69753.65123174351;71096.64451677709;71099;8577.17465975047;8617.69838055665;8659.177378149066;8671.739847804576;8761.167689069529;44264.336034958855;45512.54487455083;45525;45771.77114114408;46431.12473190401;57246.42753572411;57458;61336.386636133066;65431.018534721064;65744.6712766433;9910.008999100033;10064.194864410683;10593.735156620838;10991.285566438157;11077.889221107685;9975.800483990135;11583.826242606536;11671.183017188716;12202.633920982385;12271.509139634672;9073.59168837417;10294.330868493524;10433.46324338813;11840.526378945091;12016.279023258632;11343.319400835977;11459.942700286445;12118.818217726917;12224.205426647239;12245.938770306091;11303.773924521627;11471.655850324503;12011.579594714492;12029.45867435985;12088.939555302168;9057.592408341508;9312.068793120905;9617.71146865595;9931.602735890772;10106.646267380607;9796.65711700087;9812.116909478182;9821.165200958;9899.455529945923;9967.50162491858 05:44:22 INFO - PROCESS | 23828 | __end_tp_report 05:44:22 INFO - PROCESS | 23828 | __start_cc_report 05:44:22 INFO - PROCESS | 23828 | _x_x_mozilla_cycle_collect,1112 05:44:22 INFO - PROCESS | 23828 | __end_cc_report 05:44:22 INFO - PROCESS | 23828 | __startTimestamp1467204262260__endTimestamp 05:44:22 INFO - PROCESS | 23828 | 05:44:22 INFO - PROCESS | 23828 | ------- Summary: start ------- 05:44:22 INFO - PROCESS | 23828 | Number of tests: 6 05:44:22 INFO - PROCESS | 23828 | 05:44:22 INFO - PROCESS | 23828 | [#0] dojo.html Cycles:165 Average:4719.38 Median:4815.47 stddev:514.62 (10.7%) stddev-sans-first:488.61 05:44:22 INFO - PROCESS | 23828 | Values: 2600.4 2607.2 2656.6 2665.6 2667.0 4643.8 4677.2 4689.9 4740.6 4815.5 4637.0 4706.6 4719.9 4760.9 4766.6 4162.5 4309.3 4393.5 4422.8 4529.2 4431.4 4456.0 4475.0 4485.1 4509.3 4264.3 4306.7 4321.2 4366.1 4400.4 4307.8 4309.5 4310.1 4379.1 4387.1 4353.9 4364.1 4366.8 4405.9 4410.3 4580.6 4703.1 4770.5 4775.2 4780.1 5190.8 5199.9 5214.3 5214.7 5215.2 5199.5 5221.5 5238.0 5240.0 5242.8 4620.2 4685.0 4718.0 4730.7 4780.7 5207.8 5225.8 5234.2 5235.8 5236.2 4850.0 5014.2 5018.3 5022.2 5024.2 5126.2 5172.9 5175.2 5186.2 5205.1 5134.4 5139.9 5143.9 5149.5 5151.7 4877.1 4908.6 5120.3 5138.4 5140.5 4264.3 4330.7 4333.3 4343.6 4368.6 3746.6 3756.2 3764.7 3794.6 3798.4 4206.7 4378.7 4384.5 4425.8 4435.9 5053.3 5102.8 5104.9 5173.6 5186.1 4340.8 4354.6 4367.9 4373.4 4405.4 4589.5 4594.3 4594.7 4596.9 4645.7 4630.4 4752.1 4788.0 4797.4 4813.5 5150.0 5159.5 5166.3 5166.7 5224.0 4574.5 4787.6 4822.0 4822.1 4876.1 5044.7 5085.1 5098.4 5098.5 5117.7 5154.7 5190.8 5197.0 5205.4 5253.0 4847.5 4919.8 5046.0 5066.7 5071.3 4919.9 4964.8 4981.3 4985.8 5028.9 4888.9 4907.6 4961.2 4971.1 4976.2 4810.0 4926.9 4981.6 5057.0 5070.1 4883.3 4911.5 4911.7 4916.0 4958.7 05:44:22 INFO - PROCESS | 23828 | 05:44:22 INFO - PROCESS | 23828 | [#1] ext.html Cycles:180 Average:46428.21 Median:173800.14 stddev:78819.44 (45.4%) stddev-sans-first:78965.26 05:44:22 INFO - PROCESS | 23828 | Values: 544.9 574.0 588.3 592.0 598.1 27404.9 40502.4 40763.8 40928.8 40936.0 41793.8 42272.4 42278.8 42286.4 42298.0 7515.9 7842.9 7989.1 8002.1 10087.6 9922.8 10245.6 10257.4 10266.2 10279.5 10238.1 10259.9 10290.3 10309.1 10310.4 7569.2 10031.0 10220.7 10371.8 10430.0 10189.8 10265.4 10277.1 10279.1 10281.0 38906.4 39194.4 39221.0 39285.0 39362.2 3218.5 3299.2 3414.7 3496.3 3740.9 29820.8 29875.6 29892.7 30283.4 30513.0 3412.4 3512.4 3548.4 3605.6 3615.8 257003.0 261030.0 261060.0 261440.0 262818.0 51262.2 51327.2 51638.7 51708.5 51722.7 55186.2 55319.7 55679.4 55681.0 55745.4 14936.5 15339.8 15424.3 15507.4 15520.1 9739.7 10350.0 10715.9 10771.8 10845.6 15009.6 15075.8 15099.2 15125.2 15284.9 5767.7 5825.2 5893.4 5929.5 5959.7 781.4 843.9 896.9 984.4 992.4 25697.0 26733.7 27063.3 27150.3 27272.9 952.9 961.4 996.5 1004.8 1015.7 14318.3 14529.2 14553.4 14563.8 14744.9 295536.0 295915.0 297016.0 298178.0 298348.0 45945.5 45998.8 46074.0 46135.8 46279.1 1087.9 1154.4 1178.6 1193.6 1238.6 26205.5 29358.1 29494.4 29748.0 29927.3 43186.6 44028.8 44080.0 44168.6 44205.6 331953.0 342682.0 343076.0 343841.0 344104.0 33633.5 38236.2 39442.0 40643.6 42365.2 42090.0 42347.0 42686.0 42746.6 43369.6 36126.5 36453.6 36502.3 36595.3 37029.4 36333.3 36340.8 36422.6 36451.6 36683.4 35666.5 35878.0 35963.0 36144.3 36486.3 32492.5 33379.8 33998.5 34014.0 34189.1 25028.9 25240.7 25367.9 25561.7 25715.5 05:44:22 INFO - PROCESS | 23828 | 05:44:22 INFO - PROCESS | 23828 | [#2] jquery.html Cycles:180 Average:25248.70 Median:26567.59 stddev:69137.77 (260.2%) stddev-sans-first:69306.46 05:44:22 INFO - PROCESS | 23828 | Values: 358.3 360.6 360.9 376.5 380.4 16106.1 17585.4 18167.2 18196.2 18210.0 14888.4 15350.4 15643.2 15643.5 15655.0 4883.4 5076.4 5101.0 5125.8 5128.0 3730.6 3925.5 5026.2 5794.7 6122.4 6178.2 6183.6 6190.1 6200.0 6209.8 5838.7 6063.0 6070.3 6074.7 6080.7 3366.3 4939.7 5212.2 5216.2 5250.9 20746.3 20942.7 20979.7 21033.6 21322.1 1951.5 2124.9 2508.9 2539.2 2566.1 12944.5 13007.7 13436.6 13437.8 13466.5 1693.5 1719.2 1765.4 1799.6 1825.8 67664.7 68152.0 68659.3 69526.0 69866.3 9239.4 9254.4 9340.2 9543.6 9610.2 12907.0 13003.7 13004.2 13040.4 13050.5 7382.5 7537.2 7557.4 7585.7 7646.4 7373.0 7419.2 7483.3 7502.9 7606.1 5831.9 6045.1 6087.4 6154.4 6219.9 1578.5 1580.3 1613.9 1668.9 1675.7 852.6 863.5 877.5 901.0 968.3 16441.9 17297.7 17964.0 18003.5 18340.2 850.2 867.9 868.3 880.0 971.9 9881.3 10330.3 10368.2 10391.7 10414.9 410409.0 411225.0 425249.0 427257.0 428452.0 68962.3 69617.7 69677.0 72389.6 73158.6 908.6 931.0 937.1 937.5 945.3 15426.2 15879.0 15927.7 16219.5 16245.8 34795.1 35926.3 37303.6 40058.4 40549.0 48251.8 49362.8 57408.7 57667.0 57811.1 7416.5 7734.7 7826.1 7866.4 7952.4 11417.0 11976.5 11987.9 12138.9 12187.2 9853.7 9878.6 9889.6 10097.1 10548.8 10356.4 10392.4 10692.9 10792.4 10991.6 10073.8 10077.5 10202.1 10469.7 10472.5 6715.1 6936.4 7032.3 7108.5 7956.7 7321.8 7389.4 9071.9 9955.8 10268.7 05:44:22 INFO - PROCESS | 23828 | 05:44:22 INFO - PROCESS | 23828 | [#3] mootools.html Cycles:180 Average:5152.95 Median:5652.69 stddev:2879.28 (50.9%) stddev-sans-first:2871.91 05:44:22 INFO - PROCESS | 23828 | Values: 1183.8 1337.5 1379.9 1436.0 1677.6 7287.6 7678.8 7684.4 7834.1 7852.7 7621.4 7785.5 7790.1 7793.0 7796.4 1879.8 1966.9 1967.6 2211.7 2242.0 1942.7 2166.2 2259.1 2259.3 2270.6 2172.0 2180.5 2209.5 2210.2 2213.7 1842.9 2182.3 2188.6 2192.7 2195.8 2084.5 2172.1 2174.4 2189.7 2192.5 7847.3 7899.0 7906.5 7908.1 7913.7 4374.7 4509.3 4516.4 4519.4 4524.0 2819.7 2905.1 2927.1 2930.9 2967.2 951.5 953.5 966.5 993.0 995.7 10527.1 10547.4 10568.2 10571.2 10572.5 4025.7 4109.8 4217.6 4219.8 4241.7 9061.5 9082.8 9090.0 9090.1 9106.2 4464.2 4496.7 4501.5 4502.1 4504.5 3542.9 3544.8 4078.6 4168.3 4169.4 3542.2 3643.9 3671.6 3700.9 3721.2 1142.6 1152.7 1157.5 1161.0 1169.2 769.6 871.3 889.4 911.5 911.8 5296.4 5415.3 5673.7 5705.2 5899.1 865.0 882.2 912.0 921.9 960.7 3560.6 3674.1 3808.4 3931.3 3960.8 9238.8 9586.8 9669.6 9671.5 9671.6 9516.3 9520.0 9521.0 9530.9 9539.0 6834.8 7161.7 7168.0 7320.7 7325.5 5242.4 5597.4 5630.3 5631.7 5784.9 8836.2 8947.7 9003.2 9047.1 9087.0 9138.2 9165.5 9167.2 9181.1 9318.6 6045.0 6572.7 6751.5 6796.4 6933.6 7521.5 7535.8 7607.8 7613.9 7621.1 6584.6 6708.7 6788.9 6845.5 6885.5 6712.1 6785.1 6802.5 6857.8 6873.1 6271.9 6272.8 6326.1 6398.9 6410.6 4667.8 4708.4 4761.7 4770.3 4815.7 4544.6 4634.7 4694.9 4711.6 4722.2 05:44:22 INFO - PROCESS | 23828 | 05:44:22 INFO - PROCESS | 23828 | [#4] prototype.html Cycles:180 Average:4134.73 Median:4611.16 stddev:1212.24 (26.3%) stddev-sans-first:1180.87 05:44:22 INFO - PROCESS | 23828 | Values: 294.2 297.6 305.9 307.0 307.7 4704.5 4838.2 4913.8 4944.6 4971.0 4598.6 4787.7 4795.4 4818.3 4847.9 3819.4 3822.5 3833.3 3847.0 3861.7 3654.0 3681.7 3788.1 3854.9 3856.5 3731.5 3750.4 3768.3 3774.3 3778.3 3727.2 3745.6 3749.4 3764.0 3774.6 3339.6 3377.1 3382.8 3385.6 3394.3 4627.4 4695.9 4714.2 4717.0 4719.3 4303.4 4314.7 4317.0 4321.9 4331.0 4794.7 4939.2 4979.8 4994.5 4998.4 3568.8 3579.9 3580.9 3581.3 3587.5 5333.9 5345.1 5353.9 5363.5 5395.6 3634.1 3736.6 3737.6 3740.8 3754.8 3695.9 3723.5 3735.2 3758.3 3762.9 4257.9 4290.4 4314.8 4321.8 4330.2 4857.8 5101.4 5111.6 5149.4 5152.9 1257.2 1288.5 1288.9 1295.1 1302.4 810.7 813.2 822.5 829.3 833.0 3990.5 3994.6 4021.2 4023.5 4033.5 4592.5 4601.4 4621.0 4645.3 4647.9 4005.2 4056.0 4056.2 4066.2 4072.8 2279.4 2471.0 2473.2 2501.5 2514.7 4341.0 4356.5 4385.4 4386.7 4387.0 4693.0 4739.8 4753.0 4784.3 4818.3 4378.6 4394.7 4546.0 4936.5 4938.0 5253.5 5275.6 5287.8 5301.1 5307.6 5199.7 5204.5 5225.9 5233.7 5269.8 4651.7 4913.5 4944.2 4957.2 4964.3 3702.5 3720.2 3721.8 3751.3 3757.7 5049.4 5273.5 5281.2 5312.2 5357.4 4979.8 5112.7 5113.6 5125.6 5130.8 5042.6 5087.3 5097.0 5142.8 5145.0 4786.9 4930.2 5036.2 5046.5 5049.8 5034.8 5091.8 5094.9 5169.2 5180.8 4987.3 5008.9 5010.7 5025.4 5035.5 05:44:22 INFO - PROCESS | 23828 | 05:44:22 INFO - PROCESS | 23828 | [#5] yui.html Cycles:180 Average:16178.55 Median:534.26 stddev:21500.45 (4024.3%) stddev-sans-first:21529.36 05:44:22 INFO - PROCESS | 23828 | Values: 701.7 724.5 726.6 732.0 751.7 12445.7 13518.3 13520.8 13539.1 13540.9 12730.2 12835.9 12842.1 12842.3 12854.2 616.9 766.6 790.5 793.3 794.1 778.3 782.7 783.2 784.6 785.1 647.3 837.9 843.8 845.4 846.0 657.9 662.4 663.4 796.2 828.0 605.0 608.1 608.3 608.5 609.0 12742.5 12771.1 12774.1 12780.7 12820.1 12041.6 12582.5 12592.4 12776.6 13056.3 11777.4 11871.3 11876.7 11877.9 12228.1 4146.2 4210.8 4215.8 4240.3 4288.3 59748.1 59749.4 59860.4 59866.0 59934.4 9862.2 10020.3 10371.4 10583.2 10585.4 15945.8 16085.7 16195.1 16195.3 16204.9 7030.5 7035.9 7094.7 7139.1 7183.9 3844.2 3870.6 3919.6 3923.4 3957.9 2775.5 2876.1 2881.1 2882.2 2885.2 464.6 464.9 477.5 486.1 488.6 486.6 545.0 555.0 578.8 590.8 8089.7 8147.1 8174.6 8422.6 8645.5 475.4 514.0 523.5 553.5 589.6 4011.9 4022.1 4026.0 4103.4 4114.1 54566.2 54916.5 55343.2 55348.2 76886.2 67884.7 78495.6 79835.6 80219.6 81056.1 58078.4 69553.0 69753.7 71096.6 71099.0 8577.2 8617.7 8659.2 8671.7 8761.2 44264.3 45512.5 45525.0 45771.8 46431.1 57246.4 57458.0 61336.4 65431.0 65744.7 9910.0 10064.2 10593.7 10991.3 11077.9 9975.8 11583.8 11671.2 12202.6 12271.5 9073.6 10294.3 10433.5 11840.5 12016.3 11343.3 11459.9 12118.8 12224.2 12245.9 11303.8 11471.7 12011.6 12029.5 12088.9 9057.6 9312.1 9617.7 9931.6 10106.6 9796.7 9812.1 9821.2 9899.5 9967.5 05:44:22 INFO - PROCESS | 23828 | -------- Summary: end -------- 05:44:22 INFO - PROCESS | 23828 | 05:44:23 INFO - TEST-INFO | 23828: exit 0 05:44:23 INFO - TEST-OK | dromaeo_css | took 1119631ms 05:44:23 INFO - TEST-START | kraken 05:44:23 INFO - operating with platform_type : linux_ 05:44:23 INFO - Initialising browser for kraken test... 05:44:23 INFO - TEST-INFO | started process 24005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDp0uEC/profile http://localhost:60745/getInfo.html) 05:44:27 INFO - PROCESS | 24005 | __metrics Screen width/height:1600/1200 05:44:27 INFO - PROCESS | 24005 | colorDepth:24 05:44:27 INFO - PROCESS | 24005 | Browser inner width/height: 1024/697 05:44:27 INFO - PROCESS | 24005 | __metrics 05:44:28 INFO - PROCESS | 24005 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:44:29 INFO - TEST-INFO | 24005: exit 0 05:44:29 INFO - Browser initialized. 05:44:29 INFO - Running cycle 1/1 for kraken test... 05:44:29 INFO - TEST-INFO | started process 24085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDp0uEC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:41 INFO - PROCESS | 24085 | RSS: Main: 158248960 05:44:41 INFO - PROCESS | 24085 | 05:44:43 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:60745/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60745/tests/kraken/driver.html?testName=audio-beat-detection) 05:44:44 INFO - PROCESS | 24085 | RSS: Main: 215621632 05:44:44 INFO - PROCESS | 24085 | 05:44:47 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:60745/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60745/tests/kraken/driver.html?testName=audio-dft) 05:44:48 INFO - PROCESS | 24085 | RSS: Main: 205537280 05:44:48 INFO - PROCESS | 24085 | 05:44:51 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:60745/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60745/tests/kraken/driver.html?testName=audio-fft) 05:44:51 INFO - PROCESS | 24085 | RSS: Main: 270434304 05:44:51 INFO - PROCESS | 24085 | 05:44:54 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:60745/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60745/tests/kraken/driver.html?testName=audio-oscillator) 05:44:54 INFO - PROCESS | 24085 | RSS: Main: 181198848 05:44:54 INFO - PROCESS | 24085 | 05:44:56 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:60745/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60745/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:44:57 INFO - PROCESS | 24085 | RSS: Main: 185495552 05:44:57 INFO - PROCESS | 24085 | 05:45:00 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:60745/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60745/tests/kraken/driver.html?testName=imaging-darkroom) 05:45:01 INFO - PROCESS | 24085 | RSS: Main: 221417472 05:45:01 INFO - PROCESS | 24085 | 05:45:04 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:60745/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60745/tests/kraken/driver.html?testName=imaging-desaturate) 05:45:05 INFO - PROCESS | 24085 | RSS: Main: 217067520 05:45:05 INFO - PROCESS | 24085 | 05:45:08 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:60745/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60745/tests/kraken/driver.html?testName=json-parse-financial) 05:45:08 INFO - PROCESS | 24085 | RSS: Main: 219693056 05:45:08 INFO - PROCESS | 24085 | 05:45:10 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:60745/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60745/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:45:11 INFO - PROCESS | 24085 | RSS: Main: 206991360 05:45:11 INFO - PROCESS | 24085 | 05:45:13 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:60745/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60745/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:45:13 INFO - PROCESS | 24085 | RSS: Main: 211714048 05:45:13 INFO - PROCESS | 24085 | 05:45:15 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:60745/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60745/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:45:16 INFO - PROCESS | 24085 | RSS: Main: 218071040 05:45:16 INFO - PROCESS | 24085 | 05:45:19 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:60745/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:45:19 INFO - PROCESS | 24085 | RSS: Main: 223551488 05:45:19 INFO - PROCESS | 24085 | 05:45:22 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:60745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:45:23 INFO - PROCESS | 24085 | RSS: Main: 223612928 05:45:23 INFO - PROCESS | 24085 | 05:45:25 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:60745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60745/tests/kraken/driver.html?testName=ai-astar) 05:45:25 INFO - PROCESS | 24085 | RSS: Main: 265904128 05:45:25 INFO - PROCESS | 24085 | 05:45:25 INFO - PROCESS | 24085 | __start_tp_report 05:45:25 INFO - PROCESS | 24085 | _x_x_mozilla_page_load 05:45:25 INFO - PROCESS | 24085 | _x_x_mozilla_page_load_details 05:45:25 INFO - PROCESS | 24085 | |i|pagename|runs| 05:45:25 INFO - PROCESS | 24085 | |0;ai-astar;103;113;111;112;113;114;113;114;113;114 05:45:25 INFO - PROCESS | 24085 | |1;audio-beat-detection;153;137;131;181;129;161;158;131;199;129 05:45:25 INFO - PROCESS | 24085 | |2;audio-dft;161;162;160;161;161;162;161;162;162;160 05:45:25 INFO - PROCESS | 24085 | |3;audio-fft;75;76;75;121;75;76;75;76;98;76 05:45:25 INFO - PROCESS | 24085 | |4;audio-oscillator;86;87;113;85;86;86;123;86;86;125 05:45:25 INFO - PROCESS | 24085 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 05:45:25 INFO - PROCESS | 24085 | |6;imaging-darkroom;145;148;146;146;147;146;146;146;146;145 05:45:25 INFO - PROCESS | 24085 | |7;imaging-desaturate;94;95;95;96;95;95;95;95;95;95 05:45:25 INFO - PROCESS | 24085 | |8;json-parse-financial;64;63;65;65;65;66;65;64;63;65 05:45:25 INFO - PROCESS | 24085 | |9;json-stringify-tinderbox;65;64;65;65;65;64;65;64;64;64 05:45:25 INFO - PROCESS | 24085 | |10;stanford-crypto-aes;86;88;81;82;84;89;87;84;108;91 05:45:25 INFO - PROCESS | 24085 | |11;stanford-crypto-ccm;135;149;130;140;137;129;129;132;157;131 05:45:25 INFO - PROCESS | 24085 | |12;stanford-crypto-pbkdf2;169;167;180;175;166;167;168;171;166;166 05:45:25 INFO - PROCESS | 24085 | |13;stanford-crypto-sha256-iterative;68;67;66;68;70;66;66;66;67;65 05:45:25 INFO - PROCESS | 24085 | __end_tp_report 05:45:25 INFO - PROCESS | 24085 | __start_cc_report 05:45:25 INFO - PROCESS | 24085 | _x_x_mozilla_cycle_collect,1871 05:45:25 INFO - PROCESS | 24085 | __end_cc_report 05:45:25 INFO - PROCESS | 24085 | __startTimestamp1467204325438__endTimestamp 05:45:25 INFO - PROCESS | 24085 | 05:45:25 INFO - PROCESS | 24085 | ------- Summary: start ------- 05:45:25 INFO - PROCESS | 24085 | Number of tests: 14 05:45:25 INFO - PROCESS | 24085 | 05:45:25 INFO - PROCESS | 24085 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.30 (2.9%) stddev-sans-first:1.00 05:45:25 INFO - PROCESS | 24085 | Values: 103.0 113.0 111.0 112.0 113.0 114.0 113.0 114.0 113.0 114.0 05:45:25 INFO - PROCESS | 24085 | 05:45:25 INFO - PROCESS | 24085 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:155.50 stddev:24.31 (15.6%) stddev-sans-first:25.78 05:45:25 INFO - PROCESS | 24085 | Values: 153.0 137.0 131.0 181.0 129.0 161.0 158.0 131.0 199.0 129.0 05:45:25 INFO - PROCESS | 24085 | 05:45:25 INFO - PROCESS | 24085 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 05:45:25 INFO - PROCESS | 24085 | Values: 161.0 162.0 160.0 161.0 161.0 162.0 161.0 162.0 162.0 160.0 05:45:25 INFO - PROCESS | 24085 | 05:45:25 INFO - PROCESS | 24085 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:15.33 (20.2%) stddev-sans-first:16.03 05:45:25 INFO - PROCESS | 24085 | Values: 75.0 76.0 75.0 121.0 75.0 76.0 75.0 76.0 98.0 76.0 05:45:25 INFO - PROCESS | 24085 | 05:45:25 INFO - PROCESS | 24085 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:86.00 stddev:16.87 (19.6%) stddev-sans-first:17.47 05:45:25 INFO - PROCESS | 24085 | Values: 86.0 87.0 113.0 85.0 86.0 86.0 123.0 86.0 86.0 125.0 05:45:25 INFO - PROCESS | 24085 | 05:45:25 INFO - PROCESS | 24085 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:45:25 INFO - PROCESS | 24085 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 05:45:25 INFO - PROCESS | 24085 | 05:45:25 INFO - PROCESS | 24085 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 05:45:25 INFO - PROCESS | 24085 | Values: 145.0 148.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 05:45:25 INFO - PROCESS | 24085 | 05:45:25 INFO - PROCESS | 24085 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 05:45:25 INFO - PROCESS | 24085 | Values: 94.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 05:45:25 INFO - PROCESS | 24085 | 05:45:25 INFO - PROCESS | 24085 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 05:45:25 INFO - PROCESS | 24085 | Values: 64.0 63.0 65.0 65.0 65.0 66.0 65.0 64.0 63.0 65.0 05:45:25 INFO - PROCESS | 24085 | 05:45:25 INFO - PROCESS | 24085 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 05:45:25 INFO - PROCESS | 24085 | Values: 65.0 64.0 65.0 65.0 65.0 64.0 65.0 64.0 64.0 64.0 05:45:25 INFO - PROCESS | 24085 | 05:45:25 INFO - PROCESS | 24085 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:86.50 stddev:7.69 (8.9%) stddev-sans-first:8.12 05:45:25 INFO - PROCESS | 24085 | Values: 86.0 88.0 81.0 82.0 84.0 89.0 87.0 84.0 108.0 91.0 05:45:25 INFO - PROCESS | 24085 | 05:45:25 INFO - PROCESS | 24085 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:136.00 stddev:9.40 (6.9%) stddev-sans-first:9.94 05:45:25 INFO - PROCESS | 24085 | Values: 135.0 149.0 130.0 140.0 137.0 129.0 129.0 132.0 157.0 131.0 05:45:25 INFO - PROCESS | 24085 | 05:45:25 INFO - PROCESS | 24085 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:168.50 stddev:4.65 (2.8%) stddev-sans-first:4.93 05:45:25 INFO - PROCESS | 24085 | Values: 169.0 167.0 180.0 175.0 166.0 167.0 168.0 171.0 166.0 166.0 05:45:25 INFO - PROCESS | 24085 | 05:45:25 INFO - PROCESS | 24085 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.45 (2.2%) stddev-sans-first:1.48 05:45:25 INFO - PROCESS | 24085 | Values: 68.0 67.0 66.0 68.0 70.0 66.0 66.0 66.0 67.0 65.0 05:45:25 INFO - PROCESS | 24085 | -------- Summary: end -------- 05:45:25 INFO - PROCESS | 24085 | 05:45:26 INFO - TEST-INFO | 24085: exit 0 05:45:26 INFO - TEST-OK | kraken | took 63339ms 05:45:26 INFO - SUITE-END | took 1182s 05:45:26 INFO - Completed test suite (00:19:43) 05:45:26 INFO - javascript benchmark 05:45:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2600.3889086064773, 2607.1657069737666, 2656.6147908553253, 2665.6401385812924, 2666.9866650666745, 4643.767811609423, 4677.204875171221, 4689.9062018759605, 4740.597049250818, 4815.470298267188, 4637.026224492852, 4706.552877476643, 4719.90560188796, 4760.928586071203, 4766.642501812361, 4162.458880345551, 4309.3320535317, 4393.51671316155, 4422.7788610569505, 4529.162105010567, 4431.401760762305, 4456.041950980539, 4474.993126546534, 4485.058137791068, 4509.278515437531, 4264.29639109545, 4306.74159550428, 4321.2005778931, 4366.148601022802, 4400.405945197389, 4307.82768689252, 4309.482862056542, 4310.094880075188, 4379.1022840317655, 4387.122575484884, 4353.934690979638, 4364.10535840152, 4366.8034938427845, 4405.911881762347, 4410.250257456208, 4580.610648094916, 4703.082898834728, 4770.546798054179, 4775.212090005145, 4780.139574876521, 5190.766415511311, 5199.870003249911, 5214.270002199695, 5214.687118772886, 5215.191645294985, 5199.506046925574, 5221.451747566527, 5238.030964271584, 5240.0, 5242.842714718565, 4620.214563524175, 4685.01614660925, 4718.0, 4730.739809310452, 4780.665353425227, 5207.765650545734, 5225.790968361299, 5234.162533994542, 5235.790568377222, 5236.162214045735, 4850.029994001144, 5014.172661510883, 5018.347614810052, 5022.196448568212, 5024.171011783088, 5126.2054381570915, 5172.870678233075, 5175.171972484384, 5186.247994040843, 5205.141151710001, 5134.435212126663, 5139.871503212375, 5143.948560514422, 5149.45930677281, 5151.6908985461, 4877.146499362598, 4908.558229759267, 5120.257562653469, 5138.409082955433, 5140.537351638371, 4264.275073237557, 4330.653547716175, 4333.285007973649, 4343.630791382705, 4368.584984426474, 3746.569144548357, 3756.248750249906, 3764.661180493769, 3794.582595914447, 3798.3732684106812, 4206.663466922639, 4378.715383500126, 4384.539623339567, 4425.778711064434, 4435.866923992286, 5053.317802096743, 5102.795888164506, 5104.897902041938, 5173.586113110942, 5186.092433824141, 4340.761258130833, 4354.629856462173, 4367.868963931087, 4373.431453911035, 4405.427294451701, 4589.472210695746, 4594.264917613166, 4594.655400844883, 4596.88507787308, 4645.744484053342, 4630.3748993886065, 4752.097101550833, 4788.0, 4797.4482934461585, 4813.470518243061, 5149.9742501287255, 5159.509846564571, 5166.3025491558155, 5166.741662916915, 5224.0, 4574.5425457453985, 4787.61699064067, 4822.035592881508, 4822.083804077214, 4876.073546026244, 5044.697318160922, 5085.084684756632, 5098.413682426569, 5098.5411312982005, 5117.692938423706, 5154.716490593053, 5190.766415511235, 5197.038547868657, 5205.427402985592, 5252.9737351313, 4847.5394837490385, 4919.778609962632, 5046.041252162077, 5066.746662666778, 5071.290019397361, 4919.926201106915, 4964.7765850537535, 4981.252812078073, 4985.75071246429, 5028.924566131438, 4888.877778055577, 4907.631927605373, 4961.181405068123, 4971.080350135092, 4976.2286845539, 4810.037992401463, 4926.901461970812, 4981.576565991932, 5057.0, 5070.062038522885, 4883.291922671264, 4911.533404326726, 4911.7298548580175, 4915.992221594636, 4958.7024778513405], "value": 4685.560643806364, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.9073039451099, 573.9885202295955, 588.3469349022585, 591.9852003699909, 598.1207624791556, 27404.86297568512, 40502.39246411302, 40763.79618101913, 40928.79535602325, 40936.0, 41793.79103104488, 42272.365914511305, 42278.788606057, 42286.36570451446, 42298.0, 7515.924840751577, 7842.882356764668, 7989.081255655587, 8002.119766825645, 10087.596496140182, 9922.801543969117, 10245.590176392972, 10257.43584102874, 10266.178705703525, 10279.537420816045, 10238.078572928434, 10259.948700256487, 10290.279680422373, 10309.072183503484, 10310.381377117359, 7569.243075692414, 10031.0, 10220.693379198636, 10371.844422333672, 10430.0, 10189.847152292721, 10265.435401052939, 10277.075063244343, 10279.126274266697, 10281.0, 38906.41640375397, 39194.41208381877, 39221.0, 39285.0, 39362.21275574501, 3218.5494030835466, 3299.2411745298714, 3414.726821854246, 3496.283261931298, 3740.8503659853573, 29820.84511545655, 29875.551866722017, 29892.70107298921, 30283.394332113454, 30513.0, 3412.3687117883023, 3512.438009918401, 3548.361294966905, 3605.6394360563995, 3615.7649752766247, 257003.0, 261030.0, 261059.9999999981, 261440.0, 262818.0, 51262.231066534034, 51327.230091548656, 51638.74180629073, 51708.48291517112, 51722.74138629358, 55186.17220741692, 55319.72340138354, 55679.443205567426, 55681.0, 55745.442545574835, 14936.477223297132, 15339.846601533842, 15424.305906234247, 15507.379704811681, 15520.146391948325, 9739.707808765748, 10350.016748408889, 10715.892841071489, 10771.83842242367, 10845.620403285848, 15009.624759381102, 15075.773863392058, 15099.245037748069, 15125.168115753519, 15284.923575382052, 5767.653940763567, 5825.2135961644635, 5893.44012318829, 5929.466348028698, 5959.67221802805, 781.4451739265186, 843.8565443874556, 896.9372143949861, 984.4093543873619, 992.4392718114386, 25697.0, 26733.732662673123, 27063.323416914736, 27150.321241969108, 27272.86363568209, 952.8999455057119, 961.423146112327, 996.4768496539375, 1004.7889943112028, 1015.7105225010837, 14318.284085795669, 14529.200893950934, 14553.417863285349, 14563.781543276858, 14744.926275368769, 295536.0, 295915.0, 297016.0, 298178.0, 298348.0, 45945.54054459413, 45998.77000614975, 46074.0, 46135.76932115318, 46279.07441851144, 1087.896649818266, 1154.4054811771775, 1178.6228406909706, 1193.6240084373394, 1238.6036468330408, 26205.475890482467, 29358.12801486059, 29494.41011179807, 29747.958821441145, 29927.251818703837, 43186.56813431825, 44028.77985610051, 44080.0, 44168.55831441644, 44205.55794442014, 331953.0, 342682.0, 343076.0, 343841.0, 344104.0, 33633.49549756707, 38236.235275294894, 39442.0, 40643.593564065166, 42365.152696945275, 42090.0, 42347.0, 42686.0, 42746.5725342755, 43369.56630433655, 36126.458103127945, 36453.63546364608, 36502.26995460129, 36595.34376317223, 37029.44455833219, 36333.27333453369, 36340.81829590941, 36422.635773642985, 36451.635483645885, 36683.44974825326, 35666.46500302446, 35878.0, 35963.0, 36144.27711445809, 36486.27027459383, 32492.512612311308, 33379.83310083434, 33998.49002264919, 34014.0, 34189.14527136841, 25028.874855626334, 25240.747592524574, 25367.873160634077, 25561.74438255668, 25715.485690286463], "value": 18133.31508062129, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.3227699647666, 360.58532687409473, 360.93142302962434, 376.51053630280626, 380.4483498926557, 16106.114163721006, 17585.3845115421, 18167.182476788545, 18196.181171847267, 18210.0, 14888.404463821435, 15350.385984560631, 15643.217839108056, 15643.452479163232, 15655.0, 4883.413990321166, 5076.416212135615, 5101.030804147219, 5125.8462246132485, 5128.0, 3730.6455886690856, 3925.548561915388, 5026.246063090547, 5794.71026448678, 6122.448979591836, 6178.165947597062, 6183.567150299481, 6190.071489276599, 6199.9690001549925, 6209.844753881144, 5838.737256823432, 6063.0, 6070.332263451017, 6074.726637301288, 6080.665563394012, 3366.2930784535033, 4939.703617782909, 5212.218167274939, 5216.165413533854, 5250.8687282817855, 20746.27388041411, 20942.685859712117, 20979.685304720442, 21033.5793284135, 21322.147114115418, 1951.5218771400955, 2124.925627603042, 2508.8996440142373, 2539.212844018342, 2566.0762125634756, 12944.546940857024, 13007.674808129777, 13436.596902092953, 13437.798433023512, 13466.461341546326, 1693.4665580342153, 1719.2263481433406, 1765.4350607805507, 1799.5501124718821, 1825.7535232743542, 67664.66167669179, 68152.0, 68659.3134068658, 69526.0, 69866.3013369865, 9239.445633262027, 9254.444733316022, 9340.20608248293, 9543.61825526985, 9610.183134433511, 12907.031972602092, 13003.674908127372, 13004.154729942524, 13040.413181406859, 13050.54323098687, 7382.483226174224, 7537.2462753724185, 7557.4331925105835, 7585.658645360972, 7646.35006024483, 7373.004644373048, 7419.183889772229, 7483.251674832473, 7502.924970750222, 7606.125295590967, 5831.88336233273, 6045.093236014545, 6087.421694938974, 6154.446099851035, 6219.875602487925, 1578.486991727693, 1580.2730743857953, 1613.9354425822835, 1668.9415870444477, 1675.698374292639, 852.5950173667459, 863.5250612163285, 877.4954401219325, 900.9774755631162, 968.3366893677853, 16441.91779041097, 17297.65404691899, 17964.0, 18003.549911252063, 18340.15831292477, 850.1753299299669, 867.913208679127, 868.2619773192736, 880.0011986395359, 971.9222462203007, 9881.308308418342, 10330.320199243928, 10368.170546356425, 10391.68824935238, 10414.947925260325, 410409.0, 411225.0, 425249.0, 427257.0, 428452.0, 68962.31037689559, 69617.65191174114, 69677.0, 72389.63805181046, 73158.63420682863, 908.5502676175336, 930.9627614895328, 937.086340817711, 937.4890684576922, 945.3146468810057, 15426.228688565303, 15879.047257164608, 15927.68144637124, 16219.51341459758, 16245.756313655069, 34795.130121747155, 35926.28147437089, 37303.626963730014, 40058.39912401375, 40549.0, 48251.75874120607, 49362.77452288658, 57408.71295643495, 57667.0, 57811.06267247957, 7416.480846340704, 7734.651940662571, 7826.139124696165, 7866.410019248465, 7952.403569732178, 11417.0, 11976.46105925253, 11987.880121198676, 12138.878611213775, 12187.207831490925, 9853.655122070693, 9878.604855805686, 9889.604415823575, 10097.141742951637, 10548.841767373342, 10356.430396327973, 10392.42841643717, 10692.8930710695, 10792.406417646791, 10991.571095757501, 10073.798524029331, 10077.546510407195, 10202.081812636898, 10469.68590942273, 10472.476376181008, 6715.127033485615, 6936.375726184668, 7032.331928466788, 7108.466864985044, 7956.681732730626, 7321.78034658961, 7389.445791565547, 9071.909280907106, 9955.800883982425, 10268.691939241835], "value": 8413.347178931292, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1183.846100006999, 1337.5251785616108, 1379.8620137986202, 1435.9641008974775, 1677.5806048487887, 7287.6356182190875, 7678.769636910894, 7684.385249180066, 7834.138244793068, 7852.725154619589, 7621.428392870529, 7785.532868027923, 7790.104138024129, 7792.96103519483, 7796.41526885483, 1879.7744270687467, 1966.862319637626, 1967.6359873423391, 2211.7345918489764, 2241.9887900560557, 1942.689169732843, 2166.2201607421316, 2259.062489067035, 2259.344790010903, 2270.6139956207485, 2171.9782802172012, 2180.5093853882827, 2209.5359974405396, 2210.204326442479, 2213.6679498075255, 1842.8617853661028, 2182.3452964110784, 2188.562287542498, 2192.7478339990944, 2195.8243340532717, 2084.4684605425673, 2172.0985790896757, 2174.3803016140323, 2189.6715492676226, 2192.506685995654, 7847.293743563107, 7898.960505197495, 7906.486078404942, 7908.051033875914, 7913.723019694341, 4374.693771436001, 4509.301058335963, 4516.36770852081, 4519.435070616173, 4523.954760452386, 2819.6757372902175, 2905.128461461553, 2927.0779704393262, 2930.897418590339, 2967.1543610071244, 951.4766878216954, 953.5470651440579, 966.5457235099492, 992.9602815887356, 995.7261753017906, 10527.105196058345, 10547.367157970546, 10568.15454763617, 10571.20715946307, 10572.471376431147, 4025.677945764332, 4109.753414795122, 4217.557156498585, 4219.767912764827, 4241.745495270294, 9061.456312621263, 9082.772930676654, 9090.0, 9090.13643703847, 9106.18044375996, 4464.17412778637, 4496.662750293741, 4501.527339629357, 4502.054568540578, 4504.527024662363, 3542.929141417157, 3544.8227588620466, 4078.6329230368815, 4168.291390463629, 4169.353750168729, 3542.220711443478, 3643.908902277464, 3671.5777685565968, 3700.9074773130887, 3721.1813401051727, 1142.5886680794906, 1152.6945359479744, 1157.4617802721775, 1160.9841388784814, 1169.152364535705, 769.6459628570808, 871.2550769092461, 889.4396530185942, 911.4576826788051, 911.8449863523217, 5296.390915044819, 5415.323084614423, 5673.716314184274, 5705.172749951317, 5899.085641725539, 864.9611559206195, 882.2368651116738, 912.0, 921.8663293822358, 960.7213907966751, 3560.626134255918, 3674.0998455378603, 3808.4287356896134, 3931.2727145477606, 3960.7623542587535, 9238.815223695488, 9586.808263834824, 9669.613215471443, 9671.468069256258, 9671.564779584936, 9516.333856630108, 9519.952400237955, 9521.0, 9530.904690953003, 9539.0, 6834.794956151323, 7161.67772450241, 7168.0, 7320.670569824264, 7325.523840950321, 5242.449542797951, 5597.356304024926, 5630.296212973379, 5631.662100273997, 5784.94215057844, 8836.160564746338, 8947.686830961145, 9003.234725048444, 9047.140521650434, 9086.954565227132, 9138.17756401927, 9165.450072995374, 9167.17495425415, 9181.081891810765, 9318.580663870278, 6044.969775151096, 6572.737090516326, 6751.49363797727, 6796.422304104207, 6933.583984960918, 7521.511101778586, 7535.8492830141995, 7607.771766847003, 7613.885791713018, 7621.085469743444, 6584.604923704593, 6708.731650733916, 6788.864222715617, 6845.452363810784, 6885.483588730765, 6712.127423434922, 6785.08401365829, 6802.489813263926, 6857.759978400932, 6873.1064961554675, 6271.874562508633, 6272.8118156455375, 6326.051092336186, 6398.87202255943, 6410.647414392253, 4667.766611669471, 4708.3643708100335, 4761.6904901181315, 4770.308305295644, 4815.662903596854, 4544.636429085731, 4634.72191668501, 4694.859154225379, 4711.599514041345, 4722.1972264714395], "value": 4153.238758584187, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.20857892269794, 297.64134218266986, 305.87306267898816, 306.9869430878102, 307.6631088957592, 4704.4589872164715, 4838.153323168441, 4913.828016019435, 4944.6044316454645, 4971.036440605963, 4598.620413875832, 4787.688800227983, 4795.376601041859, 4818.325434439182, 4847.878803029926, 3819.427085937104, 3822.503074600298, 3833.3291673957087, 3846.961530384688, 3861.7489863158944, 3653.981730091346, 3681.6561954886406, 3788.0908581940275, 3854.94217586735, 3856.479375284329, 3731.4962480065115, 3750.4374343848367, 3768.3028639701743, 3774.3017541754725, 3778.2821263959895, 3727.1613886875234, 3745.62543745626, 3749.3626083565723, 3763.9623603763885, 3774.6036666149935, 3339.5658564386717, 3377.0881861897396, 3382.8308584570673, 3385.559877215946, 3394.2702319001287, 4627.3521706961055, 4695.906081878344, 4714.245720684708, 4717.0330082333385, 4719.292106184065, 4303.35449682547, 4314.741115533078, 4317.03574873435, 4321.870343889688, 4330.978345108286, 4794.674582827326, 4939.234418665113, 4979.759108401234, 4994.500549945013, 4998.375203099613, 3568.8215589220695, 3579.94630080549, 3580.9283814323567, 3581.2658405026905, 3587.4798154267487, 5333.919991200135, 5345.1447768356875, 5353.946460535384, 5363.490468405495, 5395.5953303502, 3634.0914771307175, 3736.5889752127246, 3737.570179429346, 3740.7942563158745, 3754.755940863835, 3695.8521659133335, 3723.515942927402, 3735.159589092487, 3758.3422900992764, 3762.9435558466644, 4257.850380397275, 4290.356446533045, 4314.848980285675, 4321.805518751664, 4330.198913201068, 4857.805687772449, 5101.387833460009, 5111.5655169310285, 5149.433562308143, 5152.92270615941, 1257.1702676233642, 1288.5103660608909, 1288.9033322500663, 1295.1452041652465, 1302.3878776974807, 810.6745471154704, 813.2111851504031, 822.5147163173756, 829.2909562324126, 832.9837598130272, 3990.541087774943, 3994.6205110514456, 4021.1756589899, 4023.456833327522, 4033.4554835096887, 4592.540745925381, 4601.3558101865765, 4620.966774619157, 4645.3032045193495, 4647.883802904955, 4005.1989602079702, 4056.0265536271672, 4056.229316429869, 4066.1664358806374, 4072.816723247461, 2279.384566167159, 2470.962935555968, 2473.2085732565765, 2501.537215615117, 2514.6605208296646, 4340.958170039168, 4356.520782713899, 4385.429894113809, 4386.692931494765, 4387.012922092504, 4692.967547139624, 4739.7630118493935, 4752.976235118802, 4784.258439941815, 4818.301346304766, 4378.591774524063, 4394.714343567658, 4545.999880026389, 4936.481669424658, 4937.950620493821, 5253.50091741284, 5275.601965479074, 5287.841364759063, 5301.125314323093, 5307.601929855354, 5199.688018718889, 5204.479552044765, 5225.88351717555, 5233.712145832016, 5269.78920843162, 4651.651126165619, 4913.533214344631, 4944.208926571731, 4957.231629097496, 4964.304997300453, 3702.4816525686965, 3720.2001569662652, 3721.776693398405, 3751.34351488483, 3757.6805971491635, 5049.444561098203, 5273.549773812232, 5281.181416880389, 5312.150055991023, 5357.357117145967, 4979.825706100414, 5112.667676601009, 5113.565346945551, 5125.615578831528, 5130.820421285237, 5042.621803364836, 5087.313212716236, 5096.974515127401, 5142.794288228429, 5144.9742751286, 4786.928196077131, 4930.211166213388, 5036.169032109661, 5046.520580544842, 5049.823256186163, 5034.823781167642, 5091.847244582668, 5094.949050509447, 5169.172932330809, 5180.792768289377, 4987.326710893983, 5008.874778130576, 5010.724410157476, 5025.366755804305, 5035.496450354935], "value": 3750.6660361474756, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.7017767448833, 724.5145752345928, 726.5894769455255, 732.0264048815077, 751.7256201486459, 12445.688857778548, 13518.324083795795, 13520.797188042186, 13539.119957202774, 13540.864591354084, 12730.172538784997, 12835.871641283584, 12842.101052926275, 12842.293673847935, 12854.228746275207, 616.8797084568499, 766.6013672890094, 790.4703848421572, 793.3375631347802, 794.1185284334384, 778.264540009691, 782.7103971530541, 783.2050468774198, 784.5606460382176, 785.1481142959896, 647.2621211818531, 837.9497230166179, 843.7595285343679, 845.4208866926175, 845.9703910363138, 657.9440747536441, 662.3575132121834, 663.3565441521716, 796.1878883538758, 828.0394742099136, 604.9758009679651, 608.1455554945264, 608.2609629300377, 608.4888693497439, 608.9634621922698, 12742.490300387974, 12771.106022578424, 12774.105812593121, 12780.680482987907, 12820.102592818506, 12041.638750837488, 12582.496700131984, 12592.370381480981, 12776.552820651232, 13056.347182640924, 11777.352245626487, 11871.347075910822, 11876.703082422922, 11877.940610296979, 12228.144029917908, 4146.219828446046, 4210.831566737327, 4215.831366745327, 4240.257954857888, 4288.292431748789, 59748.10377844336, 59749.40250597482, 59860.401395985915, 59866.0, 59934.40065599332, 9862.161716254055, 10020.298579099393, 10371.377717336984, 10583.206259530565, 10585.364878107339, 15945.840541594667, 16085.678286434206, 16195.109268990318, 16195.271212795453, 16204.918975405284, 7030.543014704028, 7035.894461583081, 7094.68073936674, 7139.143302803697, 7183.89224161638, 3844.2119365530557, 3870.59358767331, 3919.647231749156, 3923.352646813301, 3957.92084158321, 2775.500409926233, 2876.137158852336, 2881.135659302201, 2882.1641723899834, 2885.192146199068, 464.6491898616523, 464.92096343621665, 477.48908667725897, 486.09828767635526, 488.6042305732368, 486.60098719050745, 544.9863753406197, 554.9667019978814, 578.8350320158735, 590.7991282963812, 8089.716859909875, 8147.063087744985, 8174.550399728072, 8422.578871056423, 8645.481271123752, 475.43898200124187, 513.9537441630197, 523.5419008367678, 553.5129086403939, 589.6108568344872, 4011.939820902689, 4022.1151346703678, 4025.959740402617, 4103.384492326115, 4114.136031433432, 54566.181507277426, 54916.45083549113, 55343.16985245224, 55348.16977745337, 76886.23113768903, 67884.6605766968, 78495.60752196203, 79835.60082199668, 80219.59890200628, 81056.08383077857, 58078.4192158073, 69553.0, 69753.65123174351, 71096.64451677709, 71099.0, 8577.17465975047, 8617.69838055665, 8659.177378149066, 8671.739847804576, 8761.167689069529, 44264.336034958855, 45512.54487455083, 45525.0, 45771.77114114408, 46431.12473190401, 57246.42753572411, 57458.0, 61336.386636133066, 65431.018534721064, 65744.6712766433, 9910.008999100033, 10064.194864410683, 10593.735156620838, 10991.285566438157, 11077.889221107685, 9975.800483990135, 11583.826242606536, 11671.183017188716, 12202.633920982385, 12271.509139634672, 9073.59168837417, 10294.330868493524, 10433.46324338813, 11840.526378945091, 12016.279023258632, 11343.319400835977, 11459.942700286445, 12118.818217726917, 12224.205426647239, 12245.938770306091, 11303.773924521627, 11471.655850324503, 12011.579594714492, 12029.45867435985, 12088.939555302168, 9057.592408341508, 9312.068793120905, 9617.71146865595, 9931.602735890772, 10106.646267380607, 9796.65711700087, 9812.116909478182, 9821.165200958, 9899.455529945923, 9967.50162491858], "value": 6394.313011338056, "unit": "score"}], "name": "dromaeo_css", "value": 6438.105528324975, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 111.0, 112.0, 113.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 137.0, 131.0, 181.0, 129.0, 161.0, 158.0, 131.0, 199.0, 129.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 161.0, 162.0, 161.0, 162.0, 162.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 121.0, 75.0, 76.0, 75.0, 76.0, 98.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 113.0, 85.0, 86.0, 86.0, 123.0, 86.0, 86.0, 125.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 65.0, 65.0, 66.0, 65.0, 64.0, 63.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 81.0, 82.0, 84.0, 89.0, 87.0, 84.0, 108.0, 91.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 149.0, 130.0, 140.0, 137.0, 129.0, 129.0, 132.0, 157.0, 131.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 180.0, 175.0, 166.0, 167.0, 168.0, 171.0, 166.0, 166.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 68.0, 70.0, 66.0, 66.0, 66.0, 67.0, 65.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1551.0, "alertThreshold": 2.0}]} 05:45:26 INFO - Return code: 0 05:45:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:45:26 INFO - # TBPL SUCCESS # 05:45:26 INFO - Running post-action listener: _resource_record_post_action 05:45:26 INFO - ##### 05:45:26 INFO - ##### Finished run-tests step (success) 05:45:26 INFO - ##### 05:45:26 INFO - Running post-run listener: _resource_record_post_run 05:45:26 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534253568; Read time: 20; Write time: 612256 05:45:26 INFO - TinderboxPrint: CPU usage
13.2% 05:45:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 05:45:26 INFO - TinderboxPrint: I/O write bytes / time
534,253,568 / 612,256 05:45:26 INFO - TinderboxPrint: CPU idle
8,314.9 (86.8%) 05:45:26 INFO - TinderboxPrint: CPU user
1,216.7 (12.7%) 05:45:26 INFO - TinderboxPrint: Swap in / out
0 / 0 05:45:26 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246108160; Read time: 0; Write time: 307132 05:45:26 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288145408; Read time: 0; Write time: 305124 05:45:27 INFO - Running post-run listener: _upload_blobber_files 05:45:27 INFO - Blob upload gear active. 05:45:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:45:27 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 05:45:27 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'] 05:45:27 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 05:45:27 INFO - (blobuploader) - INFO - Open directory for files ... 05:45:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:45:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:45:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:31 INFO - (blobuploader) - INFO - Done attempting. 05:45:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:45:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:45:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:32 INFO - (blobuploader) - INFO - Done attempting. 05:45:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:45:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:45:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:32 INFO - (blobuploader) - INFO - Done attempting. 05:45:32 INFO - (blobuploader) - INFO - Iteration through files over. 05:45:32 INFO - Return code: 0 05:45:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:45:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:45:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/76638fba840f6435dca917b7e0da57b0702fa0f542aee6c4228e29d8b8466d4a1a4514010104c0716ea62dbe497af92594894b74eccd9926644d6bc99ccc3f9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b6fd7a01d2c02740179443cdabe44f769bf35e56aa262128282e8b7b85f0631ff217044502518448c8755c973549dbc0f23f15ddf1c5775950a22f52ea78921a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d40dc4e8dbb2b482a607634d57513c1b30e1f5cb794ac73e67eb26ab41e82da8a5fa52a92b64ce03cf904d45cabaa06108f32c1a8bc744f47ce881e92792a541"} 05:45:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:45:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:45:32 INFO - Contents: 05:45:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/76638fba840f6435dca917b7e0da57b0702fa0f542aee6c4228e29d8b8466d4a1a4514010104c0716ea62dbe497af92594894b74eccd9926644d6bc99ccc3f9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b6fd7a01d2c02740179443cdabe44f769bf35e56aa262128282e8b7b85f0631ff217044502518448c8755c973549dbc0f23f15ddf1c5775950a22f52ea78921a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d40dc4e8dbb2b482a607634d57513c1b30e1f5cb794ac73e67eb26ab41e82da8a5fa52a92b64ce03cf904d45cabaa06108f32c1a8bc744f47ce881e92792a541"} 05:45:32 INFO - Running post-run listener: copy_logs_to_upload_dir 05:45:32 INFO - Copying logs to upload dir... 05:45:32 INFO - mkdir: /builds/slave/test/build/upload/logs 05:45:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.606457 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-29 05:45:32.688902) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 05:45:32.691924) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373 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/76638fba840f6435dca917b7e0da57b0702fa0f542aee6c4228e29d8b8466d4a1a4514010104c0716ea62dbe497af92594894b74eccd9926644d6bc99ccc3f9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b6fd7a01d2c02740179443cdabe44f769bf35e56aa262128282e8b7b85f0631ff217044502518448c8755c973549dbc0f23f15ddf1c5775950a22f52ea78921a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d40dc4e8dbb2b482a607634d57513c1b30e1f5cb794ac73e67eb26ab41e82da8a5fa52a92b64ce03cf904d45cabaa06108f32c1a8bc744f47ce881e92792a541"} build_url:https://queue.taskcluster.net/v1/task/ICmJOcDlSDWWLiRC5SfCWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/ICmJOcDlSDWWLiRC5SfCWg/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/76638fba840f6435dca917b7e0da57b0702fa0f542aee6c4228e29d8b8466d4a1a4514010104c0716ea62dbe497af92594894b74eccd9926644d6bc99ccc3f9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b6fd7a01d2c02740179443cdabe44f769bf35e56aa262128282e8b7b85f0631ff217044502518448c8755c973549dbc0f23f15ddf1c5775950a22f52ea78921a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d40dc4e8dbb2b482a607634d57513c1b30e1f5cb794ac73e67eb26ab41e82da8a5fa52a92b64ce03cf904d45cabaa06108f32c1a8bc744f47ce881e92792a541"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 05:45:32.720403) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 05:45:32.720756) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467202807.228953-129338373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 05:45:32.800446) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 05:45:32.803869) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 05:45:32.804241) ========= ========= Total master_lag: 0.19 =========