builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1467412740.52 results: success (0) buildid: 20160701144623 builduid: 3ee81b4b4ea947d79cae7c45fb7f471b revision: 9b5be9da64bafc31baba3bc81c5d42785081e3d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 15:39:00.525002) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 15:39:00.525554) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 15:39:00.525839) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 15:39:00.548042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:39:00.548467) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 15:39:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2016-07-01 15:39:00 (42.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.347883 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:39:00.911289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:39:00.911662) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023349 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:39:00.962892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:39:00.963214) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9b5be9da64bafc31baba3bc81c5d42785081e3d9 --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 9b5be9da64bafc31baba3bc81c5d42785081e3d9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 15:39:01,100 truncating revision to first 12 chars 2016-07-01 15:39:01,100 Setting DEBUG logging. 2016-07-01 15:39:01,100 attempt 1/10 2016-07-01 15:39:01,100 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9b5be9da64ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 15:39:01,416 unpacking tar archive at: fx-team-9b5be9da64ba/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656556 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:39:01.633809) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 15:39:01.634138) ========= script_repo_revision: 9b5be9da64bafc31baba3bc81c5d42785081e3d9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 15:39:01.634583) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 15:39:01.634867) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 15:39:01.644989) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-01 15:39:01.645404) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:39:01 INFO - MultiFileLogger online at 20160701 15:39:01 in /builds/slave/test 15:39:01 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 15:39:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:39:01 INFO - {'append_to_log': False, 15:39:01 INFO - 'base_work_dir': '/builds/slave/test', 15:39:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:39:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:39:01 INFO - 'branch': 'Fx-Team-Non-PGO', 15:39:01 INFO - 'buildbot_json_path': 'buildprops.json', 15:39:01 INFO - 'config_files': ('talos/linux_config.py',), 15:39:01 INFO - 'default_actions': ('clobber', 15:39:01 INFO - 'read-buildbot-config', 15:39:01 INFO - 'download-and-extract', 15:39:01 INFO - 'populate-webroot', 15:39:01 INFO - 'create-virtualenv', 15:39:01 INFO - 'install', 15:39:01 INFO - 'run-tests'), 15:39:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:39:01 INFO - 'download_minidump_stackwalk': True, 15:39:01 INFO - 'download_symbols': 'ondemand', 15:39:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:39:01 INFO - 'tooltool.py': '/tools/tooltool.py', 15:39:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:39:01 INFO - '/tools/misc-python/virtualenv.py')}, 15:39:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:39:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:39:01 INFO - 'installer_path': 'installer.exe', 15:39:01 INFO - 'log_level': 'info', 15:39:01 INFO - 'log_name': 'talos', 15:39:01 INFO - 'log_to_console': True, 15:39:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:39:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:39:01 INFO - 'opt_config_files': (), 15:39:01 INFO - 'pip_index': False, 15:39:01 INFO - 'sps_profile': False, 15:39:01 INFO - 'sps_profile_interval': 0, 15:39:01 INFO - 'suite': 'dromaeojs', 15:39:01 INFO - 'system_bits': '32', 15:39:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:39:01 INFO - 'title': 'talos-linux64-ix-042', 15:39:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:39:01 INFO - 'use_talos_json': True, 15:39:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:39:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:39:01 INFO - 'work_dir': 'build'} 15:39:01 INFO - ##### 15:39:01 INFO - ##### Running clobber step. 15:39:01 INFO - ##### 15:39:01 INFO - Running pre-action listener: _resource_record_pre_action 15:39:01 INFO - Running main action method: clobber 15:39:01 INFO - rmtree: /builds/slave/test/build 15:39:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:39:02 INFO - Running post-action listener: _resource_record_post_action 15:39:02 INFO - ##### 15:39:02 INFO - ##### Finished clobber step (success) 15:39:02 INFO - ##### 15:39:02 INFO - ##### 15:39:02 INFO - ##### Running read-buildbot-config step. 15:39:02 INFO - ##### 15:39:02 INFO - Running pre-action listener: _resource_record_pre_action 15:39:02 INFO - Running main action method: read_buildbot_config 15:39:02 INFO - Using buildbot properties: 15:39:02 INFO - { 15:39:02 INFO - "project": "", 15:39:02 INFO - "product": "firefox", 15:39:02 INFO - "script_repo_revision": "production", 15:39:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:39:02 INFO - "repository": "", 15:39:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:39:02 INFO - "buildid": "20160701144623", 15:39:02 INFO - "pgo_build": "False", 15:39:02 INFO - "basedir": "/builds/slave/test", 15:39:02 INFO - "buildnumber": 1922, 15:39:02 INFO - "slavename": "talos-linux64-ix-042", 15:39:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:39:02 INFO - "platform": "ubuntu64_hw", 15:39:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:39:02 INFO - "branch": "fx-team", 15:39:02 INFO - "repo_path": "integration/fx-team", 15:39:02 INFO - "revision": "9b5be9da64bafc31baba3bc81c5d42785081e3d9", 15:39:02 INFO - "stage_platform": "linux64", 15:39:02 INFO - "builduid": "3ee81b4b4ea947d79cae7c45fb7f471b", 15:39:02 INFO - "slavebuilddir": "test" 15:39:02 INFO - } 15:39:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:39:02 INFO - Running post-action listener: _resource_record_post_action 15:39:02 INFO - ##### 15:39:02 INFO - ##### Finished read-buildbot-config step (success) 15:39:02 INFO - ##### 15:39:02 INFO - ##### 15:39:02 INFO - ##### Running download-and-extract step. 15:39:02 INFO - ##### 15:39:02 INFO - Running pre-action listener: _resource_record_pre_action 15:39:02 INFO - Running main action method: download_and_extract 15:39:02 INFO - mkdir: /builds/slave/test/build/tests 15:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:02 INFO - https://queue.taskcluster.net/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:39:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:39:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:39:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:39:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:39:05 INFO - Downloaded 1361 bytes. 15:39:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:39:05 INFO - Using the following test package requirements: 15:39:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:39:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:39:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:39:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:05 INFO - u'jsshell-linux-x86_64.zip'], 15:39:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:39:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:39:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:39:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:39:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:39:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:39:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:05 INFO - https://queue.taskcluster.net/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:39:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:39:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:39:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:39:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:39:06 INFO - Downloaded 22704157 bytes. 15:39:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:39:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:39:07 INFO - Return code: 0 15:39:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:39: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')]} 15:39:07 INFO - https://queue.taskcluster.net/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:39:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:39:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:39:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:39:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:39:19 INFO - Downloaded 22704157 bytes. 15:39:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:39:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:39:21 INFO - Return code: 0 15:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:21 INFO - https://queue.taskcluster.net/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:39:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:39:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:39:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:39:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:39:22 INFO - Downloaded 14405242 bytes. 15:39:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:39:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:39:22 INFO - Return code: 0 15:39: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')]} 15:39:22 INFO - https://queue.taskcluster.net/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:39:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:39:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:39:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:39:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:39:23 INFO - Downloaded 56460766 bytes. 15:39:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:39:23 INFO - mkdir: /builds/slave/test/properties 15:39:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:39:23 INFO - Writing to file /builds/slave/test/properties/build_url 15:39:23 INFO - Contents: 15:39:23 INFO - build_url:https://queue.taskcluster.net/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:39:24 INFO - Running post-action listener: _resource_record_post_action 15:39:24 INFO - Running post-action listener: set_extra_try_arguments 15:39:24 INFO - ##### 15:39:24 INFO - ##### Finished download-and-extract step (success) 15:39:24 INFO - ##### 15:39:24 INFO - ##### 15:39:24 INFO - ##### Running populate-webroot step. 15:39:24 INFO - ##### 15:39:24 INFO - Running pre-action listener: _resource_record_pre_action 15:39:24 INFO - Running main action method: populate_webroot 15:39:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:39:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:39:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:39:24 INFO - '--tppagecycles', 15:39:24 INFO - '7'], 15:39:24 INFO - 'tests': ['tsvgm']}}, 15:39:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:39:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:39:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:39:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:39:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['damp', 'tps']}, 15:39:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'tests': ['damp', 'tps']}, 15:39:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['dromaeo_dom']}, 15:39:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:39:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['basic_compositor_video']}, 15:39:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:39:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'other-e10s': {'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['tsvgx', 15:39:24 INFO - 'tsvgr_opacity', 15:39:24 INFO - 'tart', 15:39:24 INFO - 'tscrollx', 15:39:24 INFO - 'cart']}, 15:39:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:39:24 INFO - 'tsvgr_opacity', 15:39:24 INFO - 'tart', 15:39:24 INFO - 'tscrollx', 15:39:24 INFO - 'cart']}, 15:39:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['tp5o']}, 15:39:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'tests': ['tp5o']}, 15:39:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'talos_options': ['--disable-e10s', 15:39:24 INFO - '--xperf_path', 15:39:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:24 INFO - 'tests': ['tp5n']}, 15:39:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'talos_options': ['--xperf_path', 15:39:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:24 INFO - 'tests': ['tp5n']}}, 15:39:24 INFO - 'talos.zip': {'path': '', 15:39:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:39:24 INFO - Running post-action listener: _resource_record_post_action 15:39:24 INFO - ##### 15:39:24 INFO - ##### Finished populate-webroot step (success) 15:39:24 INFO - ##### 15:39:24 INFO - ##### 15:39:24 INFO - ##### Running create-virtualenv step. 15:39:24 INFO - ##### 15:39:24 INFO - Running pre-action listener: _resource_record_pre_action 15:39:24 INFO - Running main action method: create_virtualenv 15:39:24 INFO - Creating virtualenv /builds/slave/test/build/venv 15:39:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:39:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:39:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:39:24 INFO - Using real prefix '/usr' 15:39:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:39:25 INFO - Installing distribute.............................................................................................................................................................................................done. 15:39:27 INFO - Installing pip.................done. 15:39:27 INFO - Return code: 0 15:39:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:27 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 0x15e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a23b0>, '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 0x18a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:39:27 INFO - Using env: {'DISPLAY': ':0', 15:39:27 INFO - 'HOME': '/home/cltbld', 15:39:27 INFO - 'LANG': 'en_US.UTF-8', 15:39:27 INFO - 'LANGUAGE': 'en_US:en', 15:39:27 INFO - 'LOGNAME': 'cltbld', 15:39:27 INFO - 'MAIL': '/var/mail/cltbld', 15:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:27 INFO - 'MOZ_NO_REMOTE': '1', 15:39:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:27 INFO - 'NO_EM_RESTART': '1', 15:39:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:27 INFO - 'PWD': '/builds/slave/test', 15:39:27 INFO - 'SHELL': '/bin/bash', 15:39:27 INFO - 'SHLVL': '1', 15:39:27 INFO - 'TERM': 'linux', 15:39:27 INFO - 'TMOUT': '86400', 15:39:27 INFO - 'USER': 'cltbld', 15:39:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 15:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:27 INFO - '_': '/tools/buildbot/bin/python'} 15:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:39:27 INFO - Cleaning up... 15:39:27 INFO - Return code: 0 15:39:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:27 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 0x15e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a23b0>, '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 0x18a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:39:27 INFO - Using env: {'DISPLAY': ':0', 15:39:27 INFO - 'HOME': '/home/cltbld', 15:39:27 INFO - 'LANG': 'en_US.UTF-8', 15:39:27 INFO - 'LANGUAGE': 'en_US:en', 15:39:27 INFO - 'LOGNAME': 'cltbld', 15:39:27 INFO - 'MAIL': '/var/mail/cltbld', 15:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:27 INFO - 'MOZ_NO_REMOTE': '1', 15:39:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:27 INFO - 'NO_EM_RESTART': '1', 15:39:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:27 INFO - 'PWD': '/builds/slave/test', 15:39:27 INFO - 'SHELL': '/bin/bash', 15:39:27 INFO - 'SHLVL': '1', 15:39:27 INFO - 'TERM': 'linux', 15:39:27 INFO - 'TMOUT': '86400', 15:39:27 INFO - 'USER': 'cltbld', 15:39:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 15:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:27 INFO - '_': '/tools/buildbot/bin/python'} 15:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:27 INFO - Downloading/unpacking psutil>=3.1.1 15:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:39:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:39:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:29 INFO - Installing collected packages: psutil 15:39:29 INFO - Running setup.py install for psutil 15:39:29 INFO - building 'psutil._psutil_linux' extension 15:39:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:39:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:39:29 INFO - building 'psutil._psutil_posix' extension 15:39:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:39:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:39:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:39:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:30 INFO - Successfully installed psutil 15:39:30 INFO - Cleaning up... 15:39:30 INFO - Return code: 0 15:39:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:30 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 0x15e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a23b0>, '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 0x18a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:39:30 INFO - Using env: {'DISPLAY': ':0', 15:39:30 INFO - 'HOME': '/home/cltbld', 15:39:30 INFO - 'LANG': 'en_US.UTF-8', 15:39:30 INFO - 'LANGUAGE': 'en_US:en', 15:39:30 INFO - 'LOGNAME': 'cltbld', 15:39:30 INFO - 'MAIL': '/var/mail/cltbld', 15:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:30 INFO - 'MOZ_NO_REMOTE': '1', 15:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:30 INFO - 'NO_EM_RESTART': '1', 15:39:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:30 INFO - 'PWD': '/builds/slave/test', 15:39:30 INFO - 'SHELL': '/bin/bash', 15:39:30 INFO - 'SHLVL': '1', 15:39:30 INFO - 'TERM': 'linux', 15:39:30 INFO - 'TMOUT': '86400', 15:39:30 INFO - 'USER': 'cltbld', 15:39:30 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 15:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:30 INFO - '_': '/tools/buildbot/bin/python'} 15:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:39:32 INFO - Installing collected packages: mozsystemmonitor 15:39:32 INFO - Running setup.py install for mozsystemmonitor 15:39:32 INFO - Successfully installed mozsystemmonitor 15:39:32 INFO - Cleaning up... 15:39:32 INFO - Return code: 0 15:39:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a23b0>, '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 0x18a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:39:32 INFO - Using env: {'DISPLAY': ':0', 15:39:32 INFO - 'HOME': '/home/cltbld', 15:39:32 INFO - 'LANG': 'en_US.UTF-8', 15:39:32 INFO - 'LANGUAGE': 'en_US:en', 15:39:32 INFO - 'LOGNAME': 'cltbld', 15:39:32 INFO - 'MAIL': '/var/mail/cltbld', 15:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:32 INFO - 'MOZ_NO_REMOTE': '1', 15:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:32 INFO - 'NO_EM_RESTART': '1', 15:39:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:32 INFO - 'PWD': '/builds/slave/test', 15:39:32 INFO - 'SHELL': '/bin/bash', 15:39:32 INFO - 'SHLVL': '1', 15:39:32 INFO - 'TERM': 'linux', 15:39:32 INFO - 'TMOUT': '86400', 15:39:32 INFO - 'USER': 'cltbld', 15:39:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 15:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:32 INFO - '_': '/tools/buildbot/bin/python'} 15:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:32 INFO - Downloading/unpacking jsonschema==2.5.1 15:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:39:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:34 INFO - Downloading functools32-3.2.3-2.tar.gz 15:39:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:39:34 INFO - warning: no files found matching '*.txt' 15:39:34 INFO - no previously-included directories found matching 'build' 15:39:34 INFO - no previously-included directories found matching 'dist' 15:39:34 INFO - no previously-included directories found matching '.git*' 15:39:34 INFO - Installing collected packages: jsonschema, functools32 15:39:34 INFO - Running setup.py install for functools32 15:39:34 INFO - warning: no files found matching '*.txt' 15:39:34 INFO - no previously-included directories found matching 'build' 15:39:34 INFO - no previously-included directories found matching 'dist' 15:39:34 INFO - no previously-included directories found matching '.git*' 15:39:34 INFO - Successfully installed jsonschema functools32 15:39:34 INFO - Cleaning up... 15:39:35 INFO - Return code: 0 15:39:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a23b0>, '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 0x18a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:39:35 INFO - Using env: {'DISPLAY': ':0', 15:39:35 INFO - 'HOME': '/home/cltbld', 15:39:35 INFO - 'LANG': 'en_US.UTF-8', 15:39:35 INFO - 'LANGUAGE': 'en_US:en', 15:39:35 INFO - 'LOGNAME': 'cltbld', 15:39:35 INFO - 'MAIL': '/var/mail/cltbld', 15:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:35 INFO - 'MOZ_NO_REMOTE': '1', 15:39:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:35 INFO - 'NO_EM_RESTART': '1', 15:39:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:35 INFO - 'PWD': '/builds/slave/test', 15:39:35 INFO - 'SHELL': '/bin/bash', 15:39:35 INFO - 'SHLVL': '1', 15:39:35 INFO - 'TERM': 'linux', 15:39:35 INFO - 'TMOUT': '86400', 15:39:35 INFO - 'USER': 'cltbld', 15:39:35 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 15:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:35 INFO - '_': '/tools/buildbot/bin/python'} 15:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:35 INFO - Downloading/unpacking blobuploader==1.2.4 15:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:37 INFO - Downloading blobuploader-1.2.4.tar.gz 15:39:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:39:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:39:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:37 INFO - Downloading docopt-0.6.1.tar.gz 15:39:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:39:37 INFO - Installing collected packages: blobuploader, requests, docopt 15:39:37 INFO - Running setup.py install for blobuploader 15:39:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:39:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:39:37 INFO - Running setup.py install for requests 15:39:38 INFO - Running setup.py install for docopt 15:39:38 INFO - Successfully installed blobuploader requests docopt 15:39:38 INFO - Cleaning up... 15:39:38 INFO - Return code: 0 15:39:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:38 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 0x15e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a23b0>, '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 0x18a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:39:38 INFO - Using env: {'DISPLAY': ':0', 15:39:38 INFO - 'HOME': '/home/cltbld', 15:39:38 INFO - 'LANG': 'en_US.UTF-8', 15:39:38 INFO - 'LANGUAGE': 'en_US:en', 15:39:38 INFO - 'LOGNAME': 'cltbld', 15:39:38 INFO - 'MAIL': '/var/mail/cltbld', 15:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:38 INFO - 'MOZ_NO_REMOTE': '1', 15:39:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:38 INFO - 'NO_EM_RESTART': '1', 15:39:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:38 INFO - 'PWD': '/builds/slave/test', 15:39:38 INFO - 'SHELL': '/bin/bash', 15:39:38 INFO - 'SHLVL': '1', 15:39:38 INFO - 'TERM': 'linux', 15:39:38 INFO - 'TMOUT': '86400', 15:39:38 INFO - 'USER': 'cltbld', 15:39:38 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 15:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:38 INFO - '_': '/tools/buildbot/bin/python'} 15:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:39:38 INFO - Running setup.py (path:/tmp/pip-j9kQaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:39:38 INFO - Running setup.py (path:/tmp/pip-wsvPn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:39:38 INFO - Running setup.py (path:/tmp/pip-tZ1bOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:39:38 INFO - Running setup.py (path:/tmp/pip-YIjXiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:39:39 INFO - Running setup.py (path:/tmp/pip-Zz4etu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:39:39 INFO - Running setup.py (path:/tmp/pip-i0EFh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:39:39 INFO - Running setup.py (path:/tmp/pip-mKGymc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:39:39 INFO - Running setup.py (path:/tmp/pip-zQ01YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:39:39 INFO - Running setup.py (path:/tmp/pip-Wj1ShO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:39:39 INFO - Running setup.py (path:/tmp/pip-FaasbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:39:39 INFO - Running setup.py (path:/tmp/pip-H0iL2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:39:39 INFO - Running setup.py (path:/tmp/pip-P6vzmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:39:39 INFO - Running setup.py (path:/tmp/pip-ZCh75T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:39:39 INFO - Running setup.py (path:/tmp/pip-GUMYNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:39 INFO - Running setup.py (path:/tmp/pip-Nv0j4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:39:39 INFO - Running setup.py (path:/tmp/pip-w9pjUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:39:39 INFO - Running setup.py (path:/tmp/pip-fQ_NRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:39:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:39:39 INFO - Running setup.py install for manifestparser 15:39:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:39:40 INFO - Running setup.py install for mozcrash 15:39:40 INFO - Running setup.py install for mozdebug 15:39:40 INFO - Running setup.py install for mozdevice 15:39:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:39:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:39:40 INFO - Running setup.py install for mozfile 15:39:40 INFO - Running setup.py install for mozhttpd 15:39:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:39:40 INFO - Running setup.py install for mozinfo 15:39:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:39:40 INFO - Running setup.py install for mozInstall 15:39:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:39:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:39:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:39:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:39:40 INFO - Running setup.py install for mozleak 15:39:40 INFO - Running setup.py install for mozlog 15:39:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:39:41 INFO - Running setup.py install for moznetwork 15:39:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:39:41 INFO - Running setup.py install for mozprocess 15:39:41 INFO - Running setup.py install for mozprofile 15:39:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:39:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:39:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:39:41 INFO - Running setup.py install for mozrunner 15:39:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:39:41 INFO - Running setup.py install for mozscreenshot 15:39:41 INFO - Running setup.py install for moztest 15:39:41 INFO - Running setup.py install for mozversion 15:39:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:39:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:39:41 INFO - Cleaning up... 15:39:41 INFO - Return code: 0 15:39:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:41 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 0x15e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a23b0>, '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 0x18a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:39:41 INFO - Using env: {'DISPLAY': ':0', 15:39:41 INFO - 'HOME': '/home/cltbld', 15:39:41 INFO - 'LANG': 'en_US.UTF-8', 15:39:41 INFO - 'LANGUAGE': 'en_US:en', 15:39:41 INFO - 'LOGNAME': 'cltbld', 15:39:41 INFO - 'MAIL': '/var/mail/cltbld', 15:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:41 INFO - 'MOZ_NO_REMOTE': '1', 15:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:41 INFO - 'NO_EM_RESTART': '1', 15:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:41 INFO - 'PWD': '/builds/slave/test', 15:39:41 INFO - 'SHELL': '/bin/bash', 15:39:41 INFO - 'SHLVL': '1', 15:39:41 INFO - 'TERM': 'linux', 15:39:41 INFO - 'TMOUT': '86400', 15:39:41 INFO - 'USER': 'cltbld', 15:39:41 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 15:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:41 INFO - '_': '/tools/buildbot/bin/python'} 15:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:39:42 INFO - Running setup.py (path:/tmp/pip-suPLHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:39:42 INFO - Running setup.py (path:/tmp/pip-rS9Ej8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:39:42 INFO - Running setup.py (path:/tmp/pip-RApv8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:39:42 INFO - Running setup.py (path:/tmp/pip-GCXRLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:39:42 INFO - Running setup.py (path:/tmp/pip-YLEEj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:39:42 INFO - Running setup.py (path:/tmp/pip-SwgBLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:39:42 INFO - Running setup.py (path:/tmp/pip-gKVUFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:39:42 INFO - Running setup.py (path:/tmp/pip-ddKI0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:39:42 INFO - Running setup.py (path:/tmp/pip-7ST4eH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:39:42 INFO - Running setup.py (path:/tmp/pip-EkRCXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:39:42 INFO - Running setup.py (path:/tmp/pip-j1d65k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:39:42 INFO - Running setup.py (path:/tmp/pip-GnWSmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:39:42 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)) 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:39:42 INFO - Running setup.py (path:/tmp/pip-j6O1WT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:39:42 INFO - Running setup.py (path:/tmp/pip-FXbJTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:39:43 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)) 15:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:43 INFO - Running setup.py (path:/tmp/pip-NF9Cgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:39:43 INFO - Running setup.py (path:/tmp/pip-pCSDL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:39:43 INFO - Running setup.py (path:/tmp/pip-plRi0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:39:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:45 INFO - Downloading blessings-1.6.tar.gz 15:39:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:39:45 INFO - Installing collected packages: blessings 15:39:45 INFO - Running setup.py install for blessings 15:39:45 INFO - Successfully installed blessings 15:39:45 INFO - Cleaning up... 15:39:45 INFO - Return code: 0 15:39:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:39:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:39:45 INFO - Reading from file tmpfile_stdout 15:39:45 INFO - Current package versions: 15:39:45 INFO - argparse == 1.2.1 15:39:45 INFO - blessings == 1.6 15:39:45 INFO - blobuploader == 1.2.4 15:39:45 INFO - docopt == 0.6.1 15:39:45 INFO - functools32 == 3.2.3-2 15:39:45 INFO - jsonschema == 2.5.1 15:39:45 INFO - manifestparser == 1.1 15:39:45 INFO - mozInstall == 1.12 15:39:45 INFO - mozcrash == 0.17 15:39:45 INFO - mozdebug == 0.1 15:39:45 INFO - mozdevice == 0.48 15:39:45 INFO - mozfile == 1.2 15:39:45 INFO - mozhttpd == 0.7 15:39:45 INFO - mozinfo == 0.9 15:39:45 INFO - mozleak == 0.1 15:39:45 INFO - mozlog == 3.2 15:39:45 INFO - moznetwork == 0.27 15:39:45 INFO - mozprocess == 0.22 15:39:45 INFO - mozprofile == 0.28 15:39:45 INFO - mozrunner == 6.11 15:39:45 INFO - mozscreenshot == 0.1 15:39:45 INFO - mozsystemmonitor == 0.3 15:39:45 INFO - moztest == 0.7 15:39:45 INFO - mozversion == 1.4 15:39:45 INFO - psutil == 3.1.1 15:39:45 INFO - requests == 1.2.3 15:39:45 INFO - wsgiref == 0.1.2 15:39:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:45 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 0x15e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a23b0>, '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 0x18a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:39:45 INFO - Using env: {'DISPLAY': ':0', 15:39:45 INFO - 'HOME': '/home/cltbld', 15:39:45 INFO - 'LANG': 'en_US.UTF-8', 15:39:45 INFO - 'LANGUAGE': 'en_US:en', 15:39:45 INFO - 'LOGNAME': 'cltbld', 15:39:45 INFO - 'MAIL': '/var/mail/cltbld', 15:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:45 INFO - 'MOZ_NO_REMOTE': '1', 15:39:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:45 INFO - 'NO_EM_RESTART': '1', 15:39:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:45 INFO - 'PWD': '/builds/slave/test', 15:39:45 INFO - 'SHELL': '/bin/bash', 15:39:45 INFO - 'SHLVL': '1', 15:39:45 INFO - 'TERM': 'linux', 15:39:45 INFO - 'TMOUT': '86400', 15:39:45 INFO - 'USER': 'cltbld', 15:39:45 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 15:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:45 INFO - '_': '/tools/buildbot/bin/python'} 15:39:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:39:45 INFO - Cleaning up... 15:39:45 INFO - Return code: 0 15:39:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:45 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 0x15e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a23b0>, '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 0x18a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:39:45 INFO - Using env: {'DISPLAY': ':0', 15:39:45 INFO - 'HOME': '/home/cltbld', 15:39:45 INFO - 'LANG': 'en_US.UTF-8', 15:39:45 INFO - 'LANGUAGE': 'en_US:en', 15:39:45 INFO - 'LOGNAME': 'cltbld', 15:39:45 INFO - 'MAIL': '/var/mail/cltbld', 15:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:45 INFO - 'MOZ_NO_REMOTE': '1', 15:39:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:45 INFO - 'NO_EM_RESTART': '1', 15:39:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:45 INFO - 'PWD': '/builds/slave/test', 15:39:45 INFO - 'SHELL': '/bin/bash', 15:39:45 INFO - 'SHLVL': '1', 15:39:45 INFO - 'TERM': 'linux', 15:39:45 INFO - 'TMOUT': '86400', 15:39:45 INFO - 'USER': 'cltbld', 15:39:45 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 15:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:45 INFO - '_': '/tools/buildbot/bin/python'} 15:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:39:46 INFO - Cleaning up... 15:39:46 INFO - Return code: 0 15:39:46 INFO - Running post-action listener: _resource_record_post_action 15:39:46 INFO - Running post-action listener: _start_resource_monitoring 15:39:46 INFO - Starting resource monitoring. 15:39:46 INFO - ##### 15:39:46 INFO - ##### Finished create-virtualenv step (success) 15:39:46 INFO - ##### 15:39:46 INFO - ##### 15:39:46 INFO - ##### Running install step. 15:39:46 INFO - ##### 15:39:46 INFO - Running pre-action listener: _resource_record_pre_action 15:39:46 INFO - Running main action method: install 15:39:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:39:46 INFO - Reading from file tmpfile_stdout 15:39:46 INFO - Detecting whether we're running mozinstall >=1.0... 15:39:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:39:46 INFO - Reading from file tmpfile_stdout 15:39:46 INFO - Output received: 15:39:46 INFO - Usage: mozinstall [options] installer 15:39:46 INFO - Options: 15:39:46 INFO - -h, --help show this help message and exit 15:39:46 INFO - -d DEST, --destination=DEST 15:39:46 INFO - Directory to install application into. [default: 15:39:46 INFO - "/builds/slave/test"] 15:39:46 INFO - --app=APP Application being installed. [default: firefox] 15:39:46 INFO - mkdir: /builds/slave/test/build/application 15:39:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:40:02 INFO - Reading from file tmpfile_stdout 15:40:02 INFO - Output received: 15:40:02 INFO - /builds/slave/test/build/application/firefox/firefox 15:40:02 INFO - Running post-action listener: _resource_record_post_action 15:40:02 INFO - ##### 15:40:02 INFO - ##### Finished install step (success) 15:40:02 INFO - ##### 15:40:02 INFO - ##### 15:40:02 INFO - ##### Running run-tests step. 15:40:02 INFO - ##### 15:40:02 INFO - Running pre-action listener: _resource_record_pre_action 15:40:02 INFO - Running main action method: run_tests 15:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:40:02 INFO - Python 2.7.3 15:40:02 INFO - Return code: 0 15:40:02 INFO - grabbing minidump binary from tooltool 15:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:02 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 0x18a23b0>, '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 0x18a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:40:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:40:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:40:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:40:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:40:02 INFO - Return code: 0 15:40:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:40:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:40:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:40:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:40:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:40:02 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/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:40:02 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/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:40:02 INFO - Using env: {'DISPLAY': ':0', 15:40:02 INFO - 'HOME': '/home/cltbld', 15:40:02 INFO - 'LANG': 'en_US.UTF-8', 15:40:02 INFO - 'LANGUAGE': 'en_US:en', 15:40:02 INFO - 'LOGNAME': 'cltbld', 15:40:02 INFO - 'MAIL': '/var/mail/cltbld', 15:40:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:40:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:02 INFO - 'MOZ_NO_REMOTE': '1', 15:40:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:02 INFO - 'NO_EM_RESTART': '1', 15:40:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:02 INFO - 'PWD': '/builds/slave/test', 15:40:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:40:02 INFO - 'SHELL': '/bin/bash', 15:40:02 INFO - 'SHLVL': '1', 15:40:02 INFO - 'TERM': 'linux', 15:40:02 INFO - 'TMOUT': '86400', 15:40:02 INFO - 'USER': 'cltbld', 15:40:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607', 15:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:02 INFO - '_': '/tools/buildbot/bin/python'} 15:40:02 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/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:40:02 INFO - mozversion application_buildid: 20160701144623 15:40:02 INFO - mozversion application_changeset: 9b5be9da64bafc31baba3bc81c5d42785081e3d9 15:40:02 INFO - mozversion application_display_name: Nightly 15:40:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:40:02 INFO - mozversion application_name: Firefox 15:40:02 INFO - mozversion application_remotingname: firefox 15:40:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:40:02 INFO - mozversion application_vendor: Mozilla 15:40:02 INFO - mozversion application_version: 50.0a1 15:40:02 INFO - mozversion platform_buildid: 20160701144623 15:40:02 INFO - mozversion platform_changeset: 9b5be9da64bafc31baba3bc81c5d42785081e3d9 15:40:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:40:02 INFO - mozversion platform_version: 50.0a1 15:40:02 INFO - using testdate: 1467412802 15:40:02 INFO - actual date: 1467412802 15:40:02 INFO - starting webserver on 'localhost:52693' 15:40:02 INFO - SUITE-START | Running 2 tests 15:40:02 INFO - TEST-START | dromaeo_css 15:40:02 INFO - operating with platform_type : linux_ 15:40:02 INFO - Initialising browser for dromaeo_css test... 15:40:02 INFO - TEST-INFO | started process 21866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBVdfIa/profile http://localhost:52693/getInfo.html) 15:40:07 INFO - PROCESS | 21866 | __metrics Screen width/height:1600/1200 15:40:07 INFO - PROCESS | 21866 | colorDepth:24 15:40:07 INFO - PROCESS | 21866 | Browser inner width/height: 1024/697 15:40:07 INFO - PROCESS | 21866 | __metrics 15:40:08 INFO - PROCESS | 21866 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:40:09 INFO - TEST-INFO | 21866: exit 0 15:40:09 INFO - Browser initialized. 15:40:09 INFO - Running cycle 1/1 for dromaeo_css test... 15:40:09 INFO - TEST-INFO | started process 21950 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBVdfIa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:40:21 INFO - PROCESS | 21950 | RSS: Main: 159748096 15:40:21 INFO - PROCESS | 21950 | 15:41:13 INFO - PROCESS | 21950 | 1467412873373 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:43:25 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:52693/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52693/tests/dromaeo/cssquery-ext.html) 15:43:26 INFO - PROCESS | 21950 | RSS: Main: 272343040 15:43:26 INFO - PROCESS | 21950 | 15:46:29 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:52693/tests/dromaeo/cssquery-ext.html (next: http://localhost:52693/tests/dromaeo/cssquery-jquery.html) 15:46:29 INFO - PROCESS | 21950 | RSS: Main: 242184192 15:46:29 INFO - PROCESS | 21950 | 15:49:32 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:52693/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52693/tests/dromaeo/cssquery-mootools.html) 15:49:32 INFO - PROCESS | 21950 | RSS: Main: 240275456 15:49:32 INFO - PROCESS | 21950 | 15:52:35 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:52693/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52693/tests/dromaeo/cssquery-prototype.html) 15:52:35 INFO - PROCESS | 21950 | RSS: Main: 242798592 15:52:35 INFO - PROCESS | 21950 | 15:55:38 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:52693/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52693/tests/dromaeo/cssquery-yui.html) 15:55:39 INFO - PROCESS | 21950 | RSS: Main: 225357824 15:55:39 INFO - PROCESS | 21950 | 15:58:42 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:52693/tests/dromaeo/cssquery-yui.html (next: http://localhost:52693/tests/dromaeo/cssquery-dojo.html) 15:58:42 INFO - PROCESS | 21950 | RSS: Main: 294064128 15:58:42 INFO - PROCESS | 21950 | 15:58:42 INFO - PROCESS | 21950 | __start_tp_report 15:58:42 INFO - PROCESS | 21950 | _x_x_mozilla_page_load 15:58:42 INFO - PROCESS | 21950 | _x_x_mozilla_page_load_details 15:58:42 INFO - PROCESS | 21950 | |i|pagename|runs| 15:58:42 INFO - PROCESS | 21950 | |0;dojo.html;2609.073778808523;2653.3764565327133;2688.7714544263745;2697.271736631111;2697.9325516862077;4792.113459010076;4848.296996935446;4890.8043678252825;4906.1168989581865;4941.407031156262;4881.585065269447;4886.462489126202;4910.435299940508;4927.581155601769;4971.701697898128;4424.756638384888;4441.578050085237;4469.7988590513505;4512.63898888089;4608.631309495232;4515.142122996636;4531.4109165808395;4559.430071241095;4587.564181402778;4590.173768721629;4415.2935530315;4491.191585514606;4528.660350473711;4528.773561321921;4542.591166794988;4422.292433210703;4427.40230068943;4462.977685111586;4464.6874718769695;4476.55234476553;4395.1868904252815;4460.286354183315;4472.619827314682;4476.194285028693;4522.773861306921;4722.268048452495;4912.877178070541;4927.408710954673;4934.876628084291;4948.777305021246;5165.586753059746;5223.425423203445;5265.578753699695;5323.920141197885;5327.893442131136;5276.894462110775;5316.6544174628525;5318.494742999409;5351.919721204185;5352.197170424429;4748.501407352247;4789.592884604847;4880.82917097907;4916.1888288432365;4954.975225123923;5374;5431.8098866539485;5443.618946673774;5454.699991500426;5469.097598896137;5183.50756678115;5228.895422091537;5232.215167724872;5233.031889100528;5236.266922630834;5130.410002849645;5233.816816411408;5282.735863206901;5330.200469929541;5332.986732520809;5214.739263036833;5258.71077090756;5259.105951988171;5264.631475796734;5319.654222475527;5223.112070947948;5231.958762886583;5232.843014709565;5243.239730239094;5275.20871869215;4382.386465894777;4428.269335559661;4447.599716025573;4519.7740112994215;4521.525239849834;3872.0707030313088;3885.261800257942;3897.0452239201577;3902.687784977195;3946.2304850553865;4465.307877278962;4473.932891006638;4489.214387482178;4499.482559505699;4529.6376289896725;5105.132127538327;5175.275461435402;5175.948240517547;5276.1030624793875;5314.256004159421;4448.310511870665;4451.77741112943;4470.798814053375;4509.6843220974215;4516.909661806745;4725.716457012591;4735.715857048588;4738.715677059387;4738.786754596052;4783.880402989953;4786.928196076992;4854.5873600744335;4900.044491324157;4911.4106307243355;4950.282209079735;5298.947010529845;5318.787248510016;5325.121354976541;5325.334333208349;5364.919526207188;4957.7273249971595;4968;4968.527989840959;4969.776360063878;5017.623678224075;5044.344235249394;5157.510036546522;5170.560502357342;5231;5231.189165679326;5240.842774716764;5270.7101109439345;5276.841694749163;5290.920636190383;5324.414314425333;5161.948380516147;5171.663841850268;5173.1722924331925;5183.663061900965;5216.765245563883;4988.251762235694;5057.165567681439;5081.644284900021;5096.592272618256;5103.974480127576;5066.898662026812;5068.239764035424;5079.949200507947;5114.820981265638;5120.257562653469;5004.449510553909;5142.1258386073705;5148.9742551287;5150.768215430239;5156.510131537498;4871.171900776947;4936.284238785428;4965.900681986268;5000.424951130666;5010.423801262756 15:58:42 INFO - PROCESS | 21950 | |1;ext.html;566.710977401525;577.0737965565265;577.8179873339898;585.1047896718023;587.8383444552748;27291;39623;40926.59073409265;41061.794691026575;45224.0955180897;42632.57367426325;42993.57006429935;43035.13929721404;43055.78472107643;43056.569434305646;7929.722459713926;8067.273945344918;8070.71752488663;8072.313853322475;8072.878906816402;7994.360451163893;8066.991626046744;8097.0688370837515;8098.595070246493;8101.594920253993;8088.191180881894;8125.59372031399;8131.7560473185895;8132.715354962577;8137.674493020272;8047.758567242963;8082.232187942107;8095.069067057246;8095.473794203358;8101.756947291591;7893.092294386104;7989.241022102891;7994.5203287802915;7996.920030799675;8021;39333.80333098345;39449;39548.20903581941;39623.20753584941;39707.8014609928;3162.604674415698;3236.0453666168537;3282.8522716477814;3394.3169322778513;3459.135216195951;28811.135665930055;29268.707312927025;29451.263718406997;29549.261268468246;30084.097477075506;3354.3794398036443;3420.1449637590604;3457.28303835687;3478.7912725236315;3540.929181416357;200004;200066;200466.99999999854;200476;200516;32605.347893042006;55074.44925550773;55231.72384138134;55646;55667.721661391435;32510.67489325124;34659.653403466145;34691.30617387638;34741.305173896886;34751.65248347535;12458.190217635825;12583.93708031454;12608.306543140032;12611.936940315423;12625;10554.841677374845;10619.946900265604;10632.46837658114;10635.096016838655;10656.573737050587;7952.32405245549;8024.879626805603;8026.558539280396;8034.317083048007;8092.514449133071;3142.8742850285735;3153.7950033247766;3194.281286710518;3201.774766537281;3209.7111259986714;918.7611221082567;932.2402242172608;976.82417164911;978.1685567267765;978.4178413843752;28029.71970280312;28437;28605.856970715013;29259.56110658342;29414.705852941624;947.8862536495665;991.2961797123978;1019.5717798524637;1038.5015192707542;1071.7588542578014;15200.695986080216;15287.464938727313;15340.309686064154;15386.615334616501;15413.768793468107;410381;411818;412663;414256;416947;48852.267215991786;50009.749951250014;50272.74863625658;50283.24575131303;50304;1083.1389045708681;1124.7637996020765;1164.778692048508;1169.7952858249942;1190.226352870641;26446;28705.856470717514;29483.705162948096;29484.969749653963;29889;42991.785041074596;43278;43414;43475.56524434715;43505;297781;300455;300540;300818;301017;20213.19147234153;20258.59482810306;26495;27166.592501112103;27180.592291115252;41365.793171033954;41453.79273103615;41479.79260103801;42355.576444236394;42418.57581424146;36247;36460;37212.81393593123;37285.81357093197;39633.80183099066;37010.259794803416;37586.3086161118;37689.81155094207;37983.24033519259;38419.42370864495;35836.28327433489;36270.63729362673;36448.27103457969;36818;36867.63132368642;32738.34523309473;34138.65861341355;34277;34374.312513749086;34467.827660861534;25486.745132548436;26031.479370412864;26223.868880655475;26284;26377.472450551264 15:58:42 INFO - PROCESS | 21950 | |2;jquery.html;346.94448888177897;361.63294256329823;367.75728019507113;370.2373111390536;378.9597554712315;13239.271840048794;16644.08457534835;16865.66268674626;17636.64726705465;18647.906760466212;16592.83407165928;17228.13859307036;17344.306227750876;17345.653086938284;17347.82652173478;5161.17421212606;5417.972910135444;5676.943230567683;5715.657060576379;5791.681457519835;3466.0814884055744;3628.6371362863765;5695.715214239292;5943.138244954479;6263.780767673133;6272.937270627303;6279.120923070774;6305.274893387274;6309.495240380758;6312.147860038882;5615.213870058195;5735.827925162252;5739.081746920473;5740.052891272935;5746.051901436258;3374.4600863861665;5186.299849520305;5483.75323110461;5526.171074338841;5532.197831314437;12308.876911230953;12668.619941401772;16744.16279186036;20966.266180683757;21335.359939201848;1875.268645228362;2023.9696404553943;2027;2086.499240182345;2187.8796666183352;9123.224525915306;9166.724998250063;9527;9692.563834627459;11450.942745286304;1749.912504374776;1783;1792.7848658160974;1824.5712257619448;1873.3724202392216;69350;72124.27875721228;72716.27283727148;74256;74944.25055749428;8663.393562450568;9278.814423711488;9957.80084398308;10196;10225.59097636101;12547.93726031364;13419.597412077457;13419.725126113004;13877.791833122512;13928.58214253574;6832.487563432763;6897.3447522485285;6979.651017449107;7169.354758071799;7257.201707812136;6495.058216558573;6874.587524748531;6884.311568843075;6955.652217389212;7063.89404158938;4386.934195987063;4404.889877753018;4407.647388208936;4444.066745983379;4473.2842745160615;1809.8914065156132;1835.4034938644993;1837.6784062788959;1876.7466392037172;1912.1586501939103;867.7787164273196;871.5250188647076;883.9425437346551;907.4509921497531;942.8632848236967;16236.675266494603;17231.05229212405;17302.307907683804;17355.13224338778;17863.374781882572;795.323974621567;845.471580262336;847.7075408983891;865.0959747064207;930.5858892792643;9301.209397201179;9632.073585282971;9775.169110625535;9777.631131641576;9937.354071985297;430361;435594;435777;436854;447473;79235.60382198052;85703.57148214219;90131.54934225418;90717;91559;846.9703560375357;856.2293935458013;888.9199972002551;890.9866352004725;891.0955380289012;15463.613409664847;15760.842391575938;15773.842261577238;16011.439599613957;16275.104869232306;27514.44971100607;31117.53323700101;35141.82429087838;36624.45063324105;39786.60213397829;52330;53794;54260.186097209364;54543.45456545384;55830;7583.696652134074;7781;7795.727149549739;7803.297703206738;7864.72473463426;11053.226274161054;11808.645740627795;12009.099317551394;12011.339376334385;12079.27524348542;10123.645672401724;10148.644797432054;10272.178225741773;10638.627648032281;10687.25189236746;9851.211903047595;10067.84898226542;10409.739756506147;10447.68656940293;10510.842337364793;10237.23220758461;10447.634332798316;10860.131189504978;10917.781644367227;11066.446677666245;6673.8998915015345;6940.236573976959;6998.790036298919;7125.1093613298335;7860.292573668397;7640;9610.66362677303;10432.113270372103;10479.895201047892;10733.677989660322 15:58:42 INFO - PROCESS | 21950 | |3;mootools.html;1310.7313000834827;1389.465055953458;1422.3386125451668;1660;1701.4045084220525;7488.625568721563;7891.4081443891655;7949.76150715478;7962.243586859254;7968.760937171887;6915.585064896097;7128.215896251409;7151.392131668801;7293.963530182355;7847.176046515119;1960.127743154297;2160.7083043789044;2232.6316157834017;2234.3632064861517;2244.887755612221;2175.6410192318326;2217.4567231028423;2226.1318085946496;2239.608068587999;2240.6526988316837;1909.7326374307538;2148.3984484344332;2151.6880052392394;2158.557495713375;2159.265849611132;2204.206485665159;2229.6399196490047;2233.129079658934;2234.631285837851;2235.1394713035434;2182.858114222586;2196.2642514757576;2212.4690074382033;2215.711957445522;2216.047099747108;8130.674773009073;8185.485685148266;8187.181281871765;8189.467684600541;8192.672293108268;4531.728096314198;4608.723476591382;4671;4678.578927896471;4685.086408150412;2947.8083924544835;3000.819950802959;3045.482268014443;3051.115176598784;3051.130427828058;977.6675930183701;981.219930155521;991.1674193677273;1008.1632245236436;1016.7204018894863;10878.129749620011;10927.726806829813;10935.343879367263;10940.671779846618;10969.616063437741;4125.711200215956;4217.831286748557;4387.429634147604;4412.646988240933;4423.778811059434;9114.544272786467;9214.677486287948;9236.676716314896;9248.491332976617;9259.768505787275;4652.418447694038;4659.95340046602;4669.112868554964;4669.673122881366;4671.719696818202;3529.047466837159;4222.134462435193;4244.448221731217;4250.53244143144;4254.893627659271;3218.629857566363;3708.4808126862263;3737.551493820759;3753.5495740511315;3756.7933763643264;1137.027257707876;1177.7408970026581;1178.4107946026986;1184.5498710489958;1184.7512022475205;762.4434163060996;811.8457493076297;815;854.850401179791;855.5978690015683;5064.898702026013;5261.684298942076;5414.431484694129;5499.670019798745;5617.354004289559;870.9564521773885;885.7475619448426;894.6019021535354;910.4764760262743;927.2720914082413;3637.7635453695425;3832.6742226911024;3843.365844635604;3848.5766565677754;3874.4188371744463;9834.213262938947;9995;10040.9959004099;10180.032896874785;10190.031946965026;9648.662296819577;10014.3490673106;10015.949920250352;10025.147862431775;10114.342567733074;7509.474336796481;7569.470137090461;7577.242275772489;7648.961755191189;7651.961740191264;5235.083860324352;5385.2191432241325;5468.097763868917;5480.616356854982;5547.278853748987;9140.314476414429;9193.540322983958;9241.676541321021;9328.813423731352;9421.81156376855;9443.33896627257;9517.714468565953;9561.378510396802;9564.33049686543;9626.711198664052;5988.101784732325;6346.270178929482;6521.739130434729;6526.184226971629;6568.6058836469965;7779.72770953014;7795.298423141944;7823.06123265189;7849.293563579306;7859.096203936392;6890.483213758888;7003.929960700328;7057.400120989773;7125;7189.784306470814;6959.164900212007;6980.7207711693;6995.300469952964;7141.714331426685;7147.785566433015;6474.967625161844;6597.80206593803;6636.336366363325;6637.535372523877;6638.369354911276;4706.129366067288;4807.759612019455;4814.614830813456;4833.782479788489;4926.8768280793265;4729.5034021427255;4774.1883879739835;4777.570018698195;4807.4471435783935;4846.466888642317 15:58:42 INFO - PROCESS | 21950 | |4;prototype.html;283.19290023433217;287.11854606358486;300.1056850585256;307.68308642098646;308.9911439151171;4890.951090489094;4913.1893237615795;4923.71983284346;4938;4944.110060189165;4620.2838560023165;4705.200115980283;4756.143894099061;4758.2164433806265;4867.951320486794;3733.5252575232767;3765.491658626078;3778.754380965235;3891.3384724596885;3942.743721658083;3841.5966323536045;3882.068303607128;3896.629820167094;3899.9220015599813;3923.293807114718;3627.2382799612114;3806.6764325032404;3811.6950643948558;3816.2176753765552;3817.141143242776;3821.5987321331136;3829.7702137871815;3834.654881060718;3837.846486140551;3839.1170030892913;3339.248669049469;3350.3969285528597;3353.111425472252;3361.61341445732;3366.9899030290817;4809.278608208797;4826.662133650646;4856.927146092811;4869.464358920516;4872.317875497433;4142.565030671766;4357.6078152966065;4366.257736184824;4393.450818647637;4426.8007939642475;5106.514881086291;5120.795168193268;5147.974260128675;5159.174532074888;5160.690358578498;3611.530501034849;3630.183208778004;3635.8727444539577;3636.418173092319;3660.5058317127114;5207.615050217351;5393.865153371119;5408.540274076709;5429.267048948381;5461.126219804852;3709.6104908984707;3727.1241258304276;3728.366177749789;3733.962660373416;3740.4763333133383;3774.2828862516035;3778.471014058034;3792.981035094862;3795.070207799107;3798.6581207691443;4323.567643235651;4362.192994296065;4368.912621747547;4376.474823021194;4383.978080109579;4949.480304567968;5165.631107756448;5175.663581867167;5182.32629758129;5184.0927837629015;1222.6698791326291;1287.2662582327982;1311.6524121107914;1312.2979206124678;1313.4614807928704;873.8601823708176;885.6368888755579;895.6148855991855;896.7309807057857;898.7618281155499;4546.886327841764;4551.271796512542;4554.817807287672;4558.8632341029825;4561.270196768567;5278.155495120839;5301.284326615934;5343.70609616467;5350.635587925054;5359.169328754049;4419.469663640384;4527.162474942146;4531.161735079021;4532.342810292489;4548.681592288574;2808.36811717362;2818.224988128281;2826.265171055499;2828.363618185892;2835.7447829695016;4916.754162291871;4921.384826896638;4925.359703238628;4943.653944223942;4947.65366424354;5214.452482489284;5311.8406447805855;5331.413544510101;5337.62636615441;5342.412334643186;4869.224542011019;4913.828016019422;4915.655904086751;4945.381827271591;4946.901061978812;5218.373795144607;5241.554467870274;5248.973755131353;5276.417074877598;5291.3385826771655;4992.550670439678;5287.365516138088;5289.576833853205;5292.655977361459;5299.920501192408;5019.422766381766;5032.597392208688;5036.017976494549;5041.1430056889685;5044.4198917125;3753.174301653632;3778.487305941518;3785.242951409784;3790.5261842269715;3809.4857194279525;5152.6650767699975;5293.650119219575;5312.920306195488;5317.1226747586215;5367.436419176087;5192.688438693539;5205.401378841481;5212.739363031909;5215.634905556574;5222.005166048052;5023.447420783637;5192.091384007708;5199.168133098686;5206;5215.348081489814;4889.608831293417;5015.297858299914;5110.386753589593;5141.768620412166;5145;5262.8947421052135;5284.603654725834;5286.81496147633;5290.629655924048;5294.735263236746;5131.563817075441;5132.076226279306;5137.6660517066275;5139.743012849417;5153.510416510426 15:58:42 INFO - PROCESS | 21950 | |5;yui.html;668.3483603486601;679.1442782094565;703.033329172388;758.4766511107335;784.1178673991759;12647.241165530064;13357.265350405723;13388.330583470824;13418.798718019225;15051.397944082251;14774.704505909875;15310.311036003379;15388.153651549188;15405.69188616227;15424.922875385635;798.1738900238255;799.6761311668783;802.0936341933636;802.3300544045729;806.5443024691031;640.3500447046251;661.3221448015775;775.437807589496;806.04483686831;811.3184924663282;838.0404436919723;840.9327253819711;843.0684094076018;843.6625349860075;843.8185790055137;670.9597424154566;833.1335411172435;834.3408707121397;834.5910503853129;835.1314632781899;594.4827999640297;616.1404840247874;618.709206672863;619.2259675405743;619.6406084471041;14093.85906140946;14121.223332716696;14142.50501232452;14156.150630962175;14177.929110354486;12321.383930803513;12775.680607984781;12970.610881673565;13029.348532573333;13324.866751332556;11734.706632334175;11741.706457338549;11818.586349477813;11978.64064078079;11994.760104797942;3322.6178989416285;3328.4674452087793;3378.983105084483;3384.3908096542614;3445.2592692571216;58932.82134357332;59294.11058834121;59473;59718.40281597172;60217.397826022054;9227.630894764134;9556.474393908262;10112.747181320527;10427.478626068818;10472.633457828939;17280.913595431943;17349.479515614552;17360.045197514257;17368.65262694739;17459.388921387945;6568.211814582281;6802.829929251809;6805.353491418307;6843.281455447206;6856.485763567753;3736.775793452347;3778.6410291022307;3845.250176215667;3858.4212368145004;3878.6897048236074;2858.185417156142;2948.9705102948697;2962.792604517663;2978.300099476621;2981.4633365993895;516.7442116152454;530.1094161808122;536.2492510485351;541.8157826338985;542.1001138110718;479.59234650546756;491.39803740418415;493.59127458005423;499.7251511668568;535.1170568561904;7785.766427007199;7836.294733474015;8132.390070744717;8160.224778646019;9786.1192492676;484.46224690593414;488.6896820518996;512.2528702540901;554.6505701408167;624.4941597306106;3989.940150897739;4256.851010214627;4344.174606824693;4413.8234470621455;4415.183191109655;90043;90499.54750226207;93234;93843;93981.53009235047;47051.294230586565;47570.5242947573;47969.76015119902;74201.25798742051;76024;44492.77753611211;60031.39968600345;70166;71100.64449677718;72223;8229.12867755407;8241.83516329682;8337.624806883827;8475.703350382708;8483.83032339362;41857.581424185366;42192;42511.362329564465;42634.360484592136;43955.120897581226;60828.78342433215;61129.694351527956;61331.693341533006;62153.37846621476;63130.36869631245;11491;11580.254270957623;11869.762604747684;11919.284842909454;12159.756804863677;12624.431900564681;12630.3684815757;12725.490980361052;13050.15174013686;13440.327983600977;12502.062345324319;12540;12725.55460558876;13216.14095083855;13316.800247996482;12042.21725587834;12265.877341226831;12479.812802808146;12850.036663429804;12925.676858078623;12228.816567751313;12284.324362160167;12583.245005299712;12931.547395841477;13001.804972925604;10383.428911409945;10901.618443354444;10921.177587844508;10937.476604261674;11189.608363707232;9803.313768036169;9904.672401985672;10337.793244135226;10381.377117372982;10765.623203187852 15:58:42 INFO - PROCESS | 21950 | __end_tp_report 15:58:42 INFO - PROCESS | 21950 | __start_cc_report 15:58:42 INFO - PROCESS | 21950 | _x_x_mozilla_cycle_collect,1075 15:58:42 INFO - PROCESS | 21950 | __end_cc_report 15:58:42 INFO - PROCESS | 21950 | __startTimestamp1467413922366__endTimestamp 15:58:42 INFO - PROCESS | 21950 | 15:58:42 INFO - PROCESS | 21950 | ------- Summary: start ------- 15:58:42 INFO - PROCESS | 21950 | Number of tests: 6 15:58:42 INFO - PROCESS | 21950 | 15:58:42 INFO - PROCESS | 21950 | [#0] dojo.html Cycles:165 Average:4848.89 Median:4965.90 stddev:527.61 (10.6%) stddev-sans-first:499.12 15:58:42 INFO - PROCESS | 21950 | Values: 2609.1 2653.4 2688.8 2697.3 2697.9 4792.1 4848.3 4890.8 4906.1 4941.4 4881.6 4886.5 4910.4 4927.6 4971.7 4424.8 4441.6 4469.8 4512.6 4608.6 4515.1 4531.4 4559.4 4587.6 4590.2 4415.3 4491.2 4528.7 4528.8 4542.6 4422.3 4427.4 4463.0 4464.7 4476.6 4395.2 4460.3 4472.6 4476.2 4522.8 4722.3 4912.9 4927.4 4934.9 4948.8 5165.6 5223.4 5265.6 5323.9 5327.9 5276.9 5316.7 5318.5 5351.9 5352.2 4748.5 4789.6 4880.8 4916.2 4955.0 5374.0 5431.8 5443.6 5454.7 5469.1 5183.5 5228.9 5232.2 5233.0 5236.3 5130.4 5233.8 5282.7 5330.2 5333.0 5214.7 5258.7 5259.1 5264.6 5319.7 5223.1 5232.0 5232.8 5243.2 5275.2 4382.4 4428.3 4447.6 4519.8 4521.5 3872.1 3885.3 3897.0 3902.7 3946.2 4465.3 4473.9 4489.2 4499.5 4529.6 5105.1 5175.3 5175.9 5276.1 5314.3 4448.3 4451.8 4470.8 4509.7 4516.9 4725.7 4735.7 4738.7 4738.8 4783.9 4786.9 4854.6 4900.0 4911.4 4950.3 5298.9 5318.8 5325.1 5325.3 5364.9 4957.7 4968.0 4968.5 4969.8 5017.6 5044.3 5157.5 5170.6 5231.0 5231.2 5240.8 5270.7 5276.8 5290.9 5324.4 5161.9 5171.7 5173.2 5183.7 5216.8 4988.3 5057.2 5081.6 5096.6 5104.0 5066.9 5068.2 5079.9 5114.8 5120.3 5004.4 5142.1 5149.0 5150.8 5156.5 4871.2 4936.3 4965.9 5000.4 5010.4 15:58:42 INFO - PROCESS | 21950 | 15:58:42 INFO - PROCESS | 21950 | [#1] ext.html Cycles:180 Average:45514.61 Median:36842.82 stddev:83787.86 (227.4%) stddev-sans-first:83954.94 15:58:42 INFO - PROCESS | 21950 | Values: 566.7 577.1 577.8 585.1 587.8 27291.0 39623.0 40926.6 41061.8 45224.1 42632.6 42993.6 43035.1 43055.8 43056.6 7929.7 8067.3 8070.7 8072.3 8072.9 7994.4 8067.0 8097.1 8098.6 8101.6 8088.2 8125.6 8131.8 8132.7 8137.7 8047.8 8082.2 8095.1 8095.5 8101.8 7893.1 7989.2 7994.5 7996.9 8021.0 39333.8 39449.0 39548.2 39623.2 39707.8 3162.6 3236.0 3282.9 3394.3 3459.1 28811.1 29268.7 29451.3 29549.3 30084.1 3354.4 3420.1 3457.3 3478.8 3540.9 200004.0 200066.0 200467.0 200476.0 200516.0 32605.3 55074.4 55231.7 55646.0 55667.7 32510.7 34659.7 34691.3 34741.3 34751.7 12458.2 12583.9 12608.3 12611.9 12625.0 10554.8 10619.9 10632.5 10635.1 10656.6 7952.3 8024.9 8026.6 8034.3 8092.5 3142.9 3153.8 3194.3 3201.8 3209.7 918.8 932.2 976.8 978.2 978.4 28029.7 28437.0 28605.9 29259.6 29414.7 947.9 991.3 1019.6 1038.5 1071.8 15200.7 15287.5 15340.3 15386.6 15413.8 410381.0 411818.0 412663.0 414256.0 416947.0 48852.3 50009.7 50272.7 50283.2 50304.0 1083.1 1124.8 1164.8 1169.8 1190.2 26446.0 28705.9 29483.7 29485.0 29889.0 42991.8 43278.0 43414.0 43475.6 43505.0 297781.0 300455.0 300540.0 300818.0 301017.0 20213.2 20258.6 26495.0 27166.6 27180.6 41365.8 41453.8 41479.8 42355.6 42418.6 36247.0 36460.0 37212.8 37285.8 39633.8 37010.3 37586.3 37689.8 37983.2 38419.4 35836.3 36270.6 36448.3 36818.0 36867.6 32738.3 34138.7 34277.0 34374.3 34467.8 25486.7 26031.5 26223.9 26284.0 26377.5 15:58:42 INFO - PROCESS | 21950 | 15:58:42 INFO - PROCESS | 21950 | [#2] jquery.html Cycles:180 Average:25948.32 Median:4458.68 stddev:72246.20 (1620.4%) stddev-sans-first:72423.30 15:58:42 INFO - PROCESS | 21950 | Values: 346.9 361.6 367.8 370.2 379.0 13239.3 16644.1 16865.7 17636.6 18647.9 16592.8 17228.1 17344.3 17345.7 17347.8 5161.2 5418.0 5676.9 5715.7 5791.7 3466.1 3628.6 5695.7 5943.1 6263.8 6272.9 6279.1 6305.3 6309.5 6312.1 5615.2 5735.8 5739.1 5740.1 5746.1 3374.5 5186.3 5483.8 5526.2 5532.2 12308.9 12668.6 16744.2 20966.3 21335.4 1875.3 2024.0 2027.0 2086.5 2187.9 9123.2 9166.7 9527.0 9692.6 11450.9 1749.9 1783.0 1792.8 1824.6 1873.4 69350.0 72124.3 72716.3 74256.0 74944.3 8663.4 9278.8 9957.8 10196.0 10225.6 12547.9 13419.6 13419.7 13877.8 13928.6 6832.5 6897.3 6979.7 7169.4 7257.2 6495.1 6874.6 6884.3 6955.7 7063.9 4386.9 4404.9 4407.6 4444.1 4473.3 1809.9 1835.4 1837.7 1876.7 1912.2 867.8 871.5 883.9 907.5 942.9 16236.7 17231.1 17302.3 17355.1 17863.4 795.3 845.5 847.7 865.1 930.6 9301.2 9632.1 9775.2 9777.6 9937.4 430361.0 435594.0 435777.0 436854.0 447473.0 79235.6 85703.6 90131.5 90717.0 91559.0 847.0 856.2 888.9 891.0 891.1 15463.6 15760.8 15773.8 16011.4 16275.1 27514.4 31117.5 35141.8 36624.5 39786.6 52330.0 53794.0 54260.2 54543.5 55830.0 7583.7 7781.0 7795.7 7803.3 7864.7 11053.2 11808.6 12009.1 12011.3 12079.3 10123.6 10148.6 10272.2 10638.6 10687.3 9851.2 10067.8 10409.7 10447.7 10510.8 10237.2 10447.6 10860.1 10917.8 11066.4 6673.9 6940.2 6998.8 7125.1 7860.3 7640.0 9610.7 10432.1 10479.9 10733.7 15:58:42 INFO - PROCESS | 21950 | 15:58:42 INFO - PROCESS | 21950 | [#3] mootools.html Cycles:180 Average:5267.78 Median:4824.20 stddev:2974.65 (61.7%) stddev-sans-first:2968.13 15:58:42 INFO - PROCESS | 21950 | Values: 1310.7 1389.5 1422.3 1660.0 1701.4 7488.6 7891.4 7949.8 7962.2 7968.8 6915.6 7128.2 7151.4 7294.0 7847.2 1960.1 2160.7 2232.6 2234.4 2244.9 2175.6 2217.5 2226.1 2239.6 2240.7 1909.7 2148.4 2151.7 2158.6 2159.3 2204.2 2229.6 2233.1 2234.6 2235.1 2182.9 2196.3 2212.5 2215.7 2216.0 8130.7 8185.5 8187.2 8189.5 8192.7 4531.7 4608.7 4671.0 4678.6 4685.1 2947.8 3000.8 3045.5 3051.1 3051.1 977.7 981.2 991.2 1008.2 1016.7 10878.1 10927.7 10935.3 10940.7 10969.6 4125.7 4217.8 4387.4 4412.6 4423.8 9114.5 9214.7 9236.7 9248.5 9259.8 4652.4 4660.0 4669.1 4669.7 4671.7 3529.0 4222.1 4244.4 4250.5 4254.9 3218.6 3708.5 3737.6 3753.5 3756.8 1137.0 1177.7 1178.4 1184.5 1184.8 762.4 811.8 815.0 854.9 855.6 5064.9 5261.7 5414.4 5499.7 5617.4 871.0 885.7 894.6 910.5 927.3 3637.8 3832.7 3843.4 3848.6 3874.4 9834.2 9995.0 10041.0 10180.0 10190.0 9648.7 10014.3 10015.9 10025.1 10114.3 7509.5 7569.5 7577.2 7649.0 7652.0 5235.1 5385.2 5468.1 5480.6 5547.3 9140.3 9193.5 9241.7 9328.8 9421.8 9443.3 9517.7 9561.4 9564.3 9626.7 5988.1 6346.3 6521.7 6526.2 6568.6 7779.7 7795.3 7823.1 7849.3 7859.1 6890.5 7003.9 7057.4 7125.0 7189.8 6959.2 6980.7 6995.3 7141.7 7147.8 6475.0 6597.8 6636.3 6637.5 6638.4 4706.1 4807.8 4814.6 4833.8 4926.9 4729.5 4774.2 4777.6 4807.4 4846.5 15:58:42 INFO - PROCESS | 21950 | 15:58:42 INFO - PROCESS | 21950 | [#4] prototype.html Cycles:180 Average:4277.52 Median:4880.96 stddev:1246.06 (25.5%) stddev-sans-first:1212.95 15:58:42 INFO - PROCESS | 21950 | Values: 283.2 287.1 300.1 307.7 309.0 4891.0 4913.2 4923.7 4938.0 4944.1 4620.3 4705.2 4756.1 4758.2 4868.0 3733.5 3765.5 3778.8 3891.3 3942.7 3841.6 3882.1 3896.6 3899.9 3923.3 3627.2 3806.7 3811.7 3816.2 3817.1 3821.6 3829.8 3834.7 3837.8 3839.1 3339.2 3350.4 3353.1 3361.6 3367.0 4809.3 4826.7 4856.9 4869.5 4872.3 4142.6 4357.6 4366.3 4393.5 4426.8 5106.5 5120.8 5148.0 5159.2 5160.7 3611.5 3630.2 3635.9 3636.4 3660.5 5207.6 5393.9 5408.5 5429.3 5461.1 3709.6 3727.1 3728.4 3734.0 3740.5 3774.3 3778.5 3793.0 3795.1 3798.7 4323.6 4362.2 4368.9 4376.5 4384.0 4949.5 5165.6 5175.7 5182.3 5184.1 1222.7 1287.3 1311.7 1312.3 1313.5 873.9 885.6 895.6 896.7 898.8 4546.9 4551.3 4554.8 4558.9 4561.3 5278.2 5301.3 5343.7 5350.6 5359.2 4419.5 4527.2 4531.2 4532.3 4548.7 2808.4 2818.2 2826.3 2828.4 2835.7 4916.8 4921.4 4925.4 4943.7 4947.7 5214.5 5311.8 5331.4 5337.6 5342.4 4869.2 4913.8 4915.7 4945.4 4946.9 5218.4 5241.6 5249.0 5276.4 5291.3 4992.6 5287.4 5289.6 5292.7 5299.9 5019.4 5032.6 5036.0 5041.1 5044.4 3753.2 3778.5 3785.2 3790.5 3809.5 5152.7 5293.7 5312.9 5317.1 5367.4 5192.7 5205.4 5212.7 5215.6 5222.0 5023.4 5192.1 5199.2 5206.0 5215.3 4889.6 5015.3 5110.4 5141.8 5145.0 5262.9 5284.6 5286.8 5290.6 5294.7 5131.6 5132.1 5137.7 5139.7 5153.5 15:58:42 INFO - PROCESS | 21950 | 15:58:42 INFO - PROCESS | 21950 | [#5] yui.html Cycles:180 Average:16698.51 Median:24453.98 stddev:22426.33 (91.7%) stddev-sans-first:22456.94 15:58:42 INFO - PROCESS | 21950 | Values: 668.3 679.1 703.0 758.5 784.1 12647.2 13357.3 13388.3 13418.8 15051.4 14774.7 15310.3 15388.2 15405.7 15424.9 798.2 799.7 802.1 802.3 806.5 640.4 661.3 775.4 806.0 811.3 838.0 840.9 843.1 843.7 843.8 671.0 833.1 834.3 834.6 835.1 594.5 616.1 618.7 619.2 619.6 14093.9 14121.2 14142.5 14156.2 14177.9 12321.4 12775.7 12970.6 13029.3 13324.9 11734.7 11741.7 11818.6 11978.6 11994.8 3322.6 3328.5 3379.0 3384.4 3445.3 58932.8 59294.1 59473.0 59718.4 60217.4 9227.6 9556.5 10112.7 10427.5 10472.6 17280.9 17349.5 17360.0 17368.7 17459.4 6568.2 6802.8 6805.4 6843.3 6856.5 3736.8 3778.6 3845.3 3858.4 3878.7 2858.2 2949.0 2962.8 2978.3 2981.5 516.7 530.1 536.2 541.8 542.1 479.6 491.4 493.6 499.7 535.1 7785.8 7836.3 8132.4 8160.2 9786.1 484.5 488.7 512.3 554.7 624.5 3989.9 4256.9 4344.2 4413.8 4415.2 90043.0 90499.5 93234.0 93843.0 93981.5 47051.3 47570.5 47969.8 74201.3 76024.0 44492.8 60031.4 70166.0 71100.6 72223.0 8229.1 8241.8 8337.6 8475.7 8483.8 41857.6 42192.0 42511.4 42634.4 43955.1 60828.8 61129.7 61331.7 62153.4 63130.4 11491.0 11580.3 11869.8 11919.3 12159.8 12624.4 12630.4 12725.5 13050.2 13440.3 12502.1 12540.0 12725.6 13216.1 13316.8 12042.2 12265.9 12479.8 12850.0 12925.7 12228.8 12284.3 12583.2 12931.5 13001.8 10383.4 10901.6 10921.2 10937.5 11189.6 9803.3 9904.7 10337.8 10381.4 10765.6 15:58:42 INFO - PROCESS | 21950 | -------- Summary: end -------- 15:58:42 INFO - PROCESS | 21950 | 15:58:43 INFO - TEST-INFO | 21950: exit 0 15:58:43 INFO - TEST-OK | dromaeo_css | took 1120315ms 15:58:43 INFO - TEST-START | kraken 15:58:43 INFO - operating with platform_type : linux_ 15:58:43 INFO - Initialising browser for kraken test... 15:58:43 INFO - TEST-INFO | started process 22139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAtr2kl/profile http://localhost:52693/getInfo.html) 15:58:47 INFO - PROCESS | 22139 | __metrics Screen width/height:1600/1200 15:58:47 INFO - PROCESS | 22139 | colorDepth:24 15:58:47 INFO - PROCESS | 22139 | Browser inner width/height: 1024/697 15:58:47 INFO - PROCESS | 22139 | __metrics 15:58:48 INFO - PROCESS | 22139 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:58:49 INFO - TEST-INFO | 22139: exit 0 15:58:49 INFO - Browser initialized. 15:58:49 INFO - Running cycle 1/1 for kraken test... 15:58:49 INFO - TEST-INFO | started process 22219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAtr2kl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:01 INFO - PROCESS | 22219 | RSS: Main: 159162368 15:59:01 INFO - PROCESS | 22219 | 15:59:03 INFO - PROCESS | 22219 | Cycle 1(1): loaded http://localhost:52693/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52693/tests/kraken/driver.html?testName=audio-beat-detection) 15:59:04 INFO - PROCESS | 22219 | RSS: Main: 216494080 15:59:04 INFO - PROCESS | 22219 | 15:59:07 INFO - PROCESS | 22219 | Cycle 1(1): loaded http://localhost:52693/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52693/tests/kraken/driver.html?testName=audio-dft) 15:59:08 INFO - PROCESS | 22219 | RSS: Main: 204107776 15:59:08 INFO - PROCESS | 22219 | 15:59:11 INFO - PROCESS | 22219 | Cycle 1(1): loaded http://localhost:52693/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52693/tests/kraken/driver.html?testName=audio-fft) 15:59:12 INFO - PROCESS | 22219 | RSS: Main: 270958592 15:59:12 INFO - PROCESS | 22219 | 15:59:14 INFO - PROCESS | 22219 | Cycle 1(1): loaded http://localhost:52693/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52693/tests/kraken/driver.html?testName=audio-oscillator) 15:59:14 INFO - PROCESS | 22219 | RSS: Main: 181940224 15:59:14 INFO - PROCESS | 22219 | 15:59:17 INFO - PROCESS | 22219 | Cycle 1(1): loaded http://localhost:52693/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52693/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:59:17 INFO - PROCESS | 22219 | RSS: Main: 185491456 15:59:17 INFO - PROCESS | 22219 | 15:59:20 INFO - PROCESS | 22219 | Cycle 1(1): loaded http://localhost:52693/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52693/tests/kraken/driver.html?testName=imaging-darkroom) 15:59:21 INFO - PROCESS | 22219 | RSS: Main: 221704192 15:59:21 INFO - PROCESS | 22219 | 15:59:24 INFO - PROCESS | 22219 | Cycle 1(1): loaded http://localhost:52693/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52693/tests/kraken/driver.html?testName=imaging-desaturate) 15:59:25 INFO - PROCESS | 22219 | RSS: Main: 221958144 15:59:25 INFO - PROCESS | 22219 | 15:59:28 INFO - PROCESS | 22219 | Cycle 1(1): loaded http://localhost:52693/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52693/tests/kraken/driver.html?testName=json-parse-financial) 15:59:29 INFO - PROCESS | 22219 | RSS: Main: 222355456 15:59:29 INFO - PROCESS | 22219 | 15:59:30 INFO - PROCESS | 22219 | Cycle 1(1): loaded http://localhost:52693/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52693/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:59:31 INFO - PROCESS | 22219 | RSS: Main: 211591168 15:59:31 INFO - PROCESS | 22219 | 15:59:33 INFO - PROCESS | 22219 | Cycle 1(1): loaded http://localhost:52693/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52693/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:59:33 INFO - PROCESS | 22219 | RSS: Main: 216174592 15:59:33 INFO - PROCESS | 22219 | 15:59:35 INFO - PROCESS | 22219 | Cycle 1(1): loaded http://localhost:52693/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52693/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:59:36 INFO - PROCESS | 22219 | RSS: Main: 213004288 15:59:36 INFO - PROCESS | 22219 | 15:59:39 INFO - PROCESS | 22219 | Cycle 1(1): loaded http://localhost:52693/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52693/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:59:40 INFO - PROCESS | 22219 | RSS: Main: 224825344 15:59:40 INFO - PROCESS | 22219 | 15:59:42 INFO - PROCESS | 22219 | Cycle 1(1): loaded http://localhost:52693/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52693/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:59:43 INFO - PROCESS | 22219 | RSS: Main: 224776192 15:59:43 INFO - PROCESS | 22219 | 15:59:45 INFO - PROCESS | 22219 | Cycle 1(1): loaded http://localhost:52693/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52693/tests/kraken/driver.html?testName=ai-astar) 15:59:45 INFO - PROCESS | 22219 | RSS: Main: 267866112 15:59:45 INFO - PROCESS | 22219 | 15:59:45 INFO - PROCESS | 22219 | __start_tp_report 15:59:45 INFO - PROCESS | 22219 | _x_x_mozilla_page_load 15:59:45 INFO - PROCESS | 22219 | _x_x_mozilla_page_load_details 15:59:45 INFO - PROCESS | 22219 | |i|pagename|runs| 15:59:45 INFO - PROCESS | 22219 | |0;ai-astar;104;113;113;115;113;113;112;112;113;112 15:59:45 INFO - PROCESS | 22219 | |1;audio-beat-detection;160;121;125;176;123;126;151;123;175;122 15:59:45 INFO - PROCESS | 22219 | |2;audio-dft;160;161;161;161;161;161;162;162;163;161 15:59:45 INFO - PROCESS | 22219 | |3;audio-fft;75;75;76;120;76;77;76;75;104;75 15:59:45 INFO - PROCESS | 22219 | |4;audio-oscillator;86;86;123;84;90;85;117;86;86;115 15:59:45 INFO - PROCESS | 22219 | |5;imaging-gaussian-blur;116;116;116;117;117;118;117;117;117;117 15:59:45 INFO - PROCESS | 22219 | |6;imaging-darkroom;145;147;147;146;145;146;147;146;146;146 15:59:45 INFO - PROCESS | 22219 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 15:59:45 INFO - PROCESS | 22219 | |8;json-parse-financial;67;64;65;64;66;64;65;64;65;65 15:59:45 INFO - PROCESS | 22219 | |9;json-stringify-tinderbox;65;64;64;64;64;63;64;66;65;64 15:59:45 INFO - PROCESS | 22219 | |10;stanford-crypto-aes;88;87;81;79;79;80;78;85;78;83 15:59:45 INFO - PROCESS | 22219 | |11;stanford-crypto-ccm;130;129;139;132;137;129;129;138;181;130 15:59:45 INFO - PROCESS | 22219 | |12;stanford-crypto-pbkdf2;168;165;167;168;162;163;164;168;165;163 15:59:45 INFO - PROCESS | 22219 | |13;stanford-crypto-sha256-iterative;67;67;67;65;66;70;66;67;66;67 15:59:45 INFO - PROCESS | 22219 | __end_tp_report 15:59:45 INFO - PROCESS | 22219 | __start_cc_report 15:59:45 INFO - PROCESS | 22219 | _x_x_mozilla_cycle_collect,1904 15:59:45 INFO - PROCESS | 22219 | __end_cc_report 15:59:45 INFO - PROCESS | 22219 | __startTimestamp1467413985522__endTimestamp 15:59:45 INFO - PROCESS | 22219 | 15:59:45 INFO - PROCESS | 22219 | ------- Summary: start ------- 15:59:45 INFO - PROCESS | 22219 | Number of tests: 14 15:59:45 INFO - PROCESS | 22219 | 15:59:45 INFO - PROCESS | 22219 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.94 (2.6%) stddev-sans-first:0.93 15:59:45 INFO - PROCESS | 22219 | Values: 104.0 113.0 113.0 115.0 113.0 113.0 112.0 112.0 113.0 112.0 15:59:45 INFO - PROCESS | 22219 | 15:59:45 INFO - PROCESS | 22219 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:138.50 stddev:22.91 (16.5%) stddev-sans-first:23.16 15:59:45 INFO - PROCESS | 22219 | Values: 160.0 121.0 125.0 176.0 123.0 126.0 151.0 123.0 175.0 122.0 15:59:45 INFO - PROCESS | 22219 | 15:59:45 INFO - PROCESS | 22219 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.73 15:59:45 INFO - PROCESS | 22219 | Values: 160.0 161.0 161.0 161.0 161.0 161.0 162.0 162.0 163.0 161.0 15:59:45 INFO - PROCESS | 22219 | 15:59:45 INFO - PROCESS | 22219 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.50 stddev:15.81 (20.9%) stddev-sans-first:16.51 15:59:45 INFO - PROCESS | 22219 | Values: 75.0 75.0 76.0 120.0 76.0 77.0 76.0 75.0 104.0 75.0 15:59:45 INFO - PROCESS | 22219 | 15:59:45 INFO - PROCESS | 22219 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:86.00 stddev:15.75 (18.3%) stddev-sans-first:16.30 15:59:45 INFO - PROCESS | 22219 | Values: 86.0 86.0 123.0 84.0 90.0 85.0 117.0 86.0 86.0 115.0 15:59:45 INFO - PROCESS | 22219 | 15:59:45 INFO - PROCESS | 22219 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 15:59:45 INFO - PROCESS | 22219 | Values: 116.0 116.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 15:59:45 INFO - PROCESS | 22219 | 15:59:45 INFO - PROCESS | 22219 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 15:59:45 INFO - PROCESS | 22219 | Values: 145.0 147.0 147.0 146.0 145.0 146.0 147.0 146.0 146.0 146.0 15:59:45 INFO - PROCESS | 22219 | 15:59:45 INFO - PROCESS | 22219 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 15:59:45 INFO - PROCESS | 22219 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 15:59:45 INFO - PROCESS | 22219 | 15:59:45 INFO - PROCESS | 22219 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.99 (1.5%) stddev-sans-first:0.71 15:59:45 INFO - PROCESS | 22219 | Values: 67.0 64.0 65.0 64.0 66.0 64.0 65.0 64.0 65.0 65.0 15:59:45 INFO - PROCESS | 22219 | 15:59:45 INFO - PROCESS | 22219 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 15:59:45 INFO - PROCESS | 22219 | Values: 65.0 64.0 64.0 64.0 64.0 63.0 64.0 66.0 65.0 64.0 15:59:45 INFO - PROCESS | 22219 | 15:59:45 INFO - PROCESS | 22219 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:3.74 (4.6%) stddev-sans-first:3.22 15:59:45 INFO - PROCESS | 22219 | Values: 88.0 87.0 81.0 79.0 79.0 80.0 78.0 85.0 78.0 83.0 15:59:45 INFO - PROCESS | 22219 | 15:59:45 INFO - PROCESS | 22219 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:134.50 stddev:15.83 (11.8%) stddev-sans-first:16.56 15:59:45 INFO - PROCESS | 22219 | Values: 130.0 129.0 139.0 132.0 137.0 129.0 129.0 138.0 181.0 130.0 15:59:45 INFO - PROCESS | 22219 | 15:59:45 INFO - PROCESS | 22219 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:166.00 stddev:2.31 (1.4%) stddev-sans-first:2.24 15:59:45 INFO - PROCESS | 22219 | Values: 168.0 165.0 167.0 168.0 162.0 163.0 164.0 168.0 165.0 163.0 15:59:45 INFO - PROCESS | 22219 | 15:59:45 INFO - PROCESS | 22219 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.32 (2.0%) stddev-sans-first:1.39 15:59:45 INFO - PROCESS | 22219 | Values: 67.0 67.0 67.0 65.0 66.0 70.0 66.0 67.0 66.0 67.0 15:59:45 INFO - PROCESS | 22219 | -------- Summary: end -------- 15:59:45 INFO - PROCESS | 22219 | 15:59:46 INFO - TEST-INFO | 22219: exit 0 15:59:46 INFO - TEST-OK | kraken | took 63378ms 15:59:46 INFO - SUITE-END | took 1183s 15:59:46 INFO - Completed test suite (00:19:43) 15:59:46 INFO - javascript benchmark 15:59:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.073778808523, 2653.3764565327133, 2688.7714544263745, 2697.271736631111, 2697.9325516862077, 4792.113459010076, 4848.296996935446, 4890.8043678252825, 4906.1168989581865, 4941.407031156262, 4881.585065269447, 4886.462489126202, 4910.435299940508, 4927.581155601769, 4971.701697898128, 4424.756638384888, 4441.578050085237, 4469.7988590513505, 4512.63898888089, 4608.631309495232, 4515.142122996636, 4531.4109165808395, 4559.430071241095, 4587.564181402778, 4590.173768721629, 4415.2935530315, 4491.191585514606, 4528.660350473711, 4528.773561321921, 4542.591166794988, 4422.292433210703, 4427.40230068943, 4462.977685111586, 4464.6874718769695, 4476.55234476553, 4395.1868904252815, 4460.286354183315, 4472.619827314682, 4476.194285028693, 4522.773861306921, 4722.268048452495, 4912.877178070541, 4927.408710954673, 4934.876628084291, 4948.777305021246, 5165.586753059746, 5223.425423203445, 5265.578753699695, 5323.920141197885, 5327.893442131136, 5276.894462110775, 5316.6544174628525, 5318.494742999409, 5351.919721204185, 5352.197170424429, 4748.501407352247, 4789.592884604847, 4880.82917097907, 4916.1888288432365, 4954.975225123923, 5374.0, 5431.8098866539485, 5443.618946673774, 5454.699991500426, 5469.097598896137, 5183.50756678115, 5228.895422091537, 5232.215167724872, 5233.031889100528, 5236.266922630834, 5130.410002849645, 5233.816816411408, 5282.735863206901, 5330.200469929541, 5332.986732520809, 5214.739263036833, 5258.71077090756, 5259.105951988171, 5264.631475796734, 5319.654222475527, 5223.112070947948, 5231.958762886583, 5232.843014709565, 5243.239730239094, 5275.20871869215, 4382.386465894777, 4428.269335559661, 4447.599716025573, 4519.7740112994215, 4521.525239849834, 3872.0707030313088, 3885.261800257942, 3897.0452239201577, 3902.687784977195, 3946.2304850553865, 4465.307877278962, 4473.932891006638, 4489.214387482178, 4499.482559505699, 4529.6376289896725, 5105.132127538327, 5175.275461435402, 5175.948240517547, 5276.1030624793875, 5314.256004159421, 4448.310511870665, 4451.77741112943, 4470.798814053375, 4509.6843220974215, 4516.909661806745, 4725.716457012591, 4735.715857048588, 4738.715677059387, 4738.786754596052, 4783.880402989953, 4786.928196076992, 4854.5873600744335, 4900.044491324157, 4911.4106307243355, 4950.282209079735, 5298.947010529845, 5318.787248510016, 5325.121354976541, 5325.334333208349, 5364.919526207188, 4957.7273249971595, 4968.0, 4968.527989840959, 4969.776360063878, 5017.623678224075, 5044.344235249394, 5157.510036546522, 5170.560502357342, 5231.0, 5231.189165679326, 5240.842774716764, 5270.7101109439345, 5276.841694749163, 5290.920636190383, 5324.414314425333, 5161.948380516147, 5171.663841850268, 5173.1722924331925, 5183.663061900965, 5216.765245563883, 4988.251762235694, 5057.165567681439, 5081.644284900021, 5096.592272618256, 5103.974480127576, 5066.898662026812, 5068.239764035424, 5079.949200507947, 5114.820981265638, 5120.257562653469, 5004.449510553909, 5142.1258386073705, 5148.9742551287, 5150.768215430239, 5156.510131537498, 4871.171900776947, 4936.284238785428, 4965.900681986268, 5000.424951130666, 5010.423801262756], "value": 4813.684514864695, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.710977401525, 577.0737965565265, 577.8179873339898, 585.1047896718023, 587.8383444552748, 27291.0, 39623.0, 40926.59073409265, 41061.794691026575, 45224.0955180897, 42632.57367426325, 42993.57006429935, 43035.13929721404, 43055.78472107643, 43056.569434305646, 7929.722459713926, 8067.273945344918, 8070.71752488663, 8072.313853322475, 8072.878906816402, 7994.360451163893, 8066.991626046744, 8097.0688370837515, 8098.595070246493, 8101.594920253993, 8088.191180881894, 8125.59372031399, 8131.7560473185895, 8132.715354962577, 8137.674493020272, 8047.758567242963, 8082.232187942107, 8095.069067057246, 8095.473794203358, 8101.756947291591, 7893.092294386104, 7989.241022102891, 7994.5203287802915, 7996.920030799675, 8021.0, 39333.80333098345, 39449.0, 39548.20903581941, 39623.20753584941, 39707.8014609928, 3162.604674415698, 3236.0453666168537, 3282.8522716477814, 3394.3169322778513, 3459.135216195951, 28811.135665930055, 29268.707312927025, 29451.263718406997, 29549.261268468246, 30084.097477075506, 3354.3794398036443, 3420.1449637590604, 3457.28303835687, 3478.7912725236315, 3540.929181416357, 200004.0, 200066.0, 200466.99999999854, 200476.0, 200516.0, 32605.347893042006, 55074.44925550773, 55231.72384138134, 55646.0, 55667.721661391435, 32510.67489325124, 34659.653403466145, 34691.30617387638, 34741.305173896886, 34751.65248347535, 12458.190217635825, 12583.93708031454, 12608.306543140032, 12611.936940315423, 12625.0, 10554.841677374845, 10619.946900265604, 10632.46837658114, 10635.096016838655, 10656.573737050587, 7952.32405245549, 8024.879626805603, 8026.558539280396, 8034.317083048007, 8092.514449133071, 3142.8742850285735, 3153.7950033247766, 3194.281286710518, 3201.774766537281, 3209.7111259986714, 918.7611221082567, 932.2402242172608, 976.82417164911, 978.1685567267765, 978.4178413843752, 28029.71970280312, 28437.0, 28605.856970715013, 29259.56110658342, 29414.705852941624, 947.8862536495665, 991.2961797123978, 1019.5717798524637, 1038.5015192707542, 1071.7588542578014, 15200.695986080216, 15287.464938727313, 15340.309686064154, 15386.615334616501, 15413.768793468107, 410381.0, 411818.0, 412663.0, 414256.0, 416947.0, 48852.267215991786, 50009.749951250014, 50272.74863625658, 50283.24575131303, 50304.0, 1083.1389045708681, 1124.7637996020765, 1164.778692048508, 1169.7952858249942, 1190.226352870641, 26446.0, 28705.856470717514, 29483.705162948096, 29484.969749653963, 29889.0, 42991.785041074596, 43278.0, 43414.0, 43475.56524434715, 43505.0, 297781.0, 300455.0, 300540.0, 300818.0, 301017.0, 20213.19147234153, 20258.59482810306, 26495.0, 27166.592501112103, 27180.592291115252, 41365.793171033954, 41453.79273103615, 41479.79260103801, 42355.576444236394, 42418.57581424146, 36247.0, 36460.0, 37212.81393593123, 37285.81357093197, 39633.80183099066, 37010.259794803416, 37586.3086161118, 37689.81155094207, 37983.24033519259, 38419.42370864495, 35836.28327433489, 36270.63729362673, 36448.27103457969, 36818.0, 36867.63132368642, 32738.34523309473, 34138.65861341355, 34277.0, 34374.312513749086, 34467.827660861534, 25486.745132548436, 26031.479370412864, 26223.868880655475, 26284.0, 26377.472450551264], "value": 16639.063023433504, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.94448888177897, 361.63294256329823, 367.75728019507113, 370.2373111390536, 378.9597554712315, 13239.271840048794, 16644.08457534835, 16865.66268674626, 17636.64726705465, 18647.906760466212, 16592.83407165928, 17228.13859307036, 17344.306227750876, 17345.653086938284, 17347.82652173478, 5161.17421212606, 5417.972910135444, 5676.943230567683, 5715.657060576379, 5791.681457519835, 3466.0814884055744, 3628.6371362863765, 5695.715214239292, 5943.138244954479, 6263.780767673133, 6272.937270627303, 6279.120923070774, 6305.274893387274, 6309.495240380758, 6312.147860038882, 5615.213870058195, 5735.827925162252, 5739.081746920473, 5740.052891272935, 5746.051901436258, 3374.4600863861665, 5186.299849520305, 5483.75323110461, 5526.171074338841, 5532.197831314437, 12308.876911230953, 12668.619941401772, 16744.16279186036, 20966.266180683757, 21335.359939201848, 1875.268645228362, 2023.9696404553943, 2027.0, 2086.499240182345, 2187.8796666183352, 9123.224525915306, 9166.724998250063, 9527.0, 9692.563834627459, 11450.942745286304, 1749.912504374776, 1783.0, 1792.7848658160974, 1824.5712257619448, 1873.3724202392216, 69350.0, 72124.27875721228, 72716.27283727148, 74256.0, 74944.25055749428, 8663.393562450568, 9278.814423711488, 9957.80084398308, 10196.0, 10225.59097636101, 12547.93726031364, 13419.597412077457, 13419.725126113004, 13877.791833122512, 13928.58214253574, 6832.487563432763, 6897.3447522485285, 6979.651017449107, 7169.354758071799, 7257.201707812136, 6495.058216558573, 6874.587524748531, 6884.311568843075, 6955.652217389212, 7063.89404158938, 4386.934195987063, 4404.889877753018, 4407.647388208936, 4444.066745983379, 4473.2842745160615, 1809.8914065156132, 1835.4034938644993, 1837.6784062788959, 1876.7466392037172, 1912.1586501939103, 867.7787164273196, 871.5250188647076, 883.9425437346551, 907.4509921497531, 942.8632848236967, 16236.675266494603, 17231.05229212405, 17302.307907683804, 17355.13224338778, 17863.374781882572, 795.323974621567, 845.471580262336, 847.7075408983891, 865.0959747064207, 930.5858892792643, 9301.209397201179, 9632.073585282971, 9775.169110625535, 9777.631131641576, 9937.354071985297, 430361.0, 435594.0, 435777.0, 436854.0, 447473.0, 79235.60382198052, 85703.57148214219, 90131.54934225418, 90717.0, 91559.0, 846.9703560375357, 856.2293935458013, 888.9199972002551, 890.9866352004725, 891.0955380289012, 15463.613409664847, 15760.842391575938, 15773.842261577238, 16011.439599613957, 16275.104869232306, 27514.44971100607, 31117.53323700101, 35141.82429087838, 36624.45063324105, 39786.60213397829, 52330.0, 53794.0, 54260.186097209364, 54543.45456545384, 55830.0, 7583.696652134074, 7781.0, 7795.727149549739, 7803.297703206738, 7864.72473463426, 11053.226274161054, 11808.645740627795, 12009.099317551394, 12011.339376334385, 12079.27524348542, 10123.645672401724, 10148.644797432054, 10272.178225741773, 10638.627648032281, 10687.25189236746, 9851.211903047595, 10067.84898226542, 10409.739756506147, 10447.68656940293, 10510.842337364793, 10237.23220758461, 10447.634332798316, 10860.131189504978, 10917.781644367227, 11066.446677666245, 6673.8998915015345, 6940.236573976959, 6998.790036298919, 7125.1093613298335, 7860.292573668397, 7640.0, 9610.66362677303, 10432.113270372103, 10479.895201047892, 10733.677989660322], "value": 8271.010592246994, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.7313000834827, 1389.465055953458, 1422.3386125451668, 1660.0, 1701.4045084220525, 7488.625568721563, 7891.4081443891655, 7949.76150715478, 7962.243586859254, 7968.760937171887, 6915.585064896097, 7128.215896251409, 7151.392131668801, 7293.963530182355, 7847.176046515119, 1960.127743154297, 2160.7083043789044, 2232.6316157834017, 2234.3632064861517, 2244.887755612221, 2175.6410192318326, 2217.4567231028423, 2226.1318085946496, 2239.608068587999, 2240.6526988316837, 1909.7326374307538, 2148.3984484344332, 2151.6880052392394, 2158.557495713375, 2159.265849611132, 2204.206485665159, 2229.6399196490047, 2233.129079658934, 2234.631285837851, 2235.1394713035434, 2182.858114222586, 2196.2642514757576, 2212.4690074382033, 2215.711957445522, 2216.047099747108, 8130.674773009073, 8185.485685148266, 8187.181281871765, 8189.467684600541, 8192.672293108268, 4531.728096314198, 4608.723476591382, 4671.0, 4678.578927896471, 4685.086408150412, 2947.8083924544835, 3000.819950802959, 3045.482268014443, 3051.115176598784, 3051.130427828058, 977.6675930183701, 981.219930155521, 991.1674193677273, 1008.1632245236436, 1016.7204018894863, 10878.129749620011, 10927.726806829813, 10935.343879367263, 10940.671779846618, 10969.616063437741, 4125.711200215956, 4217.831286748557, 4387.429634147604, 4412.646988240933, 4423.778811059434, 9114.544272786467, 9214.677486287948, 9236.676716314896, 9248.491332976617, 9259.768505787275, 4652.418447694038, 4659.95340046602, 4669.112868554964, 4669.673122881366, 4671.719696818202, 3529.047466837159, 4222.134462435193, 4244.448221731217, 4250.53244143144, 4254.893627659271, 3218.629857566363, 3708.4808126862263, 3737.551493820759, 3753.5495740511315, 3756.7933763643264, 1137.027257707876, 1177.7408970026581, 1178.4107946026986, 1184.5498710489958, 1184.7512022475205, 762.4434163060996, 811.8457493076297, 815.0, 854.850401179791, 855.5978690015683, 5064.898702026013, 5261.684298942076, 5414.431484694129, 5499.670019798745, 5617.354004289559, 870.9564521773885, 885.7475619448426, 894.6019021535354, 910.4764760262743, 927.2720914082413, 3637.7635453695425, 3832.6742226911024, 3843.365844635604, 3848.5766565677754, 3874.4188371744463, 9834.213262938947, 9995.0, 10040.9959004099, 10180.032896874785, 10190.031946965026, 9648.662296819577, 10014.3490673106, 10015.949920250352, 10025.147862431775, 10114.342567733074, 7509.474336796481, 7569.470137090461, 7577.242275772489, 7648.961755191189, 7651.961740191264, 5235.083860324352, 5385.2191432241325, 5468.097763868917, 5480.616356854982, 5547.278853748987, 9140.314476414429, 9193.540322983958, 9241.676541321021, 9328.813423731352, 9421.81156376855, 9443.33896627257, 9517.714468565953, 9561.378510396802, 9564.33049686543, 9626.711198664052, 5988.101784732325, 6346.270178929482, 6521.739130434729, 6526.184226971629, 6568.6058836469965, 7779.72770953014, 7795.298423141944, 7823.06123265189, 7849.293563579306, 7859.096203936392, 6890.483213758888, 7003.929960700328, 7057.400120989773, 7125.0, 7189.784306470814, 6959.164900212007, 6980.7207711693, 6995.300469952964, 7141.714331426685, 7147.785566433015, 6474.967625161844, 6597.80206593803, 6636.336366363325, 6637.535372523877, 6638.369354911276, 4706.129366067288, 4807.759612019455, 4814.614830813456, 4833.782479788489, 4926.8768280793265, 4729.5034021427255, 4774.1883879739835, 4777.570018698195, 4807.4471435783935, 4846.466888642317], "value": 4230.913929546398, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.19290023433217, 287.11854606358486, 300.1056850585256, 307.68308642098646, 308.9911439151171, 4890.951090489094, 4913.1893237615795, 4923.71983284346, 4938.0, 4944.110060189165, 4620.2838560023165, 4705.200115980283, 4756.143894099061, 4758.2164433806265, 4867.951320486794, 3733.5252575232767, 3765.491658626078, 3778.754380965235, 3891.3384724596885, 3942.743721658083, 3841.5966323536045, 3882.068303607128, 3896.629820167094, 3899.9220015599813, 3923.293807114718, 3627.2382799612114, 3806.6764325032404, 3811.6950643948558, 3816.2176753765552, 3817.141143242776, 3821.5987321331136, 3829.7702137871815, 3834.654881060718, 3837.846486140551, 3839.1170030892913, 3339.248669049469, 3350.3969285528597, 3353.111425472252, 3361.61341445732, 3366.9899030290817, 4809.278608208797, 4826.662133650646, 4856.927146092811, 4869.464358920516, 4872.317875497433, 4142.565030671766, 4357.6078152966065, 4366.257736184824, 4393.450818647637, 4426.8007939642475, 5106.514881086291, 5120.795168193268, 5147.974260128675, 5159.174532074888, 5160.690358578498, 3611.530501034849, 3630.183208778004, 3635.8727444539577, 3636.418173092319, 3660.5058317127114, 5207.615050217351, 5393.865153371119, 5408.540274076709, 5429.267048948381, 5461.126219804852, 3709.6104908984707, 3727.1241258304276, 3728.366177749789, 3733.962660373416, 3740.4763333133383, 3774.2828862516035, 3778.471014058034, 3792.981035094862, 3795.070207799107, 3798.6581207691443, 4323.567643235651, 4362.192994296065, 4368.912621747547, 4376.474823021194, 4383.978080109579, 4949.480304567968, 5165.631107756448, 5175.663581867167, 5182.32629758129, 5184.0927837629015, 1222.6698791326291, 1287.2662582327982, 1311.6524121107914, 1312.2979206124678, 1313.4614807928704, 873.8601823708176, 885.6368888755579, 895.6148855991855, 896.7309807057857, 898.7618281155499, 4546.886327841764, 4551.271796512542, 4554.817807287672, 4558.8632341029825, 4561.270196768567, 5278.155495120839, 5301.284326615934, 5343.70609616467, 5350.635587925054, 5359.169328754049, 4419.469663640384, 4527.162474942146, 4531.161735079021, 4532.342810292489, 4548.681592288574, 2808.36811717362, 2818.224988128281, 2826.265171055499, 2828.363618185892, 2835.7447829695016, 4916.754162291871, 4921.384826896638, 4925.359703238628, 4943.653944223942, 4947.65366424354, 5214.452482489284, 5311.8406447805855, 5331.413544510101, 5337.62636615441, 5342.412334643186, 4869.224542011019, 4913.828016019422, 4915.655904086751, 4945.381827271591, 4946.901061978812, 5218.373795144607, 5241.554467870274, 5248.973755131353, 5276.417074877598, 5291.3385826771655, 4992.550670439678, 5287.365516138088, 5289.576833853205, 5292.655977361459, 5299.920501192408, 5019.422766381766, 5032.597392208688, 5036.017976494549, 5041.1430056889685, 5044.4198917125, 3753.174301653632, 3778.487305941518, 3785.242951409784, 3790.5261842269715, 3809.4857194279525, 5152.6650767699975, 5293.650119219575, 5312.920306195488, 5317.1226747586215, 5367.436419176087, 5192.688438693539, 5205.401378841481, 5212.739363031909, 5215.634905556574, 5222.005166048052, 5023.447420783637, 5192.091384007708, 5199.168133098686, 5206.0, 5215.348081489814, 4889.608831293417, 5015.297858299914, 5110.386753589593, 5141.768620412166, 5145.0, 5262.8947421052135, 5284.603654725834, 5286.81496147633, 5290.629655924048, 5294.735263236746, 5131.563817075441, 5132.076226279306, 5137.6660517066275, 5139.743012849417, 5153.510416510426], "value": 3879.5116307753133, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.3483603486601, 679.1442782094565, 703.033329172388, 758.4766511107335, 784.1178673991759, 12647.241165530064, 13357.265350405723, 13388.330583470824, 13418.798718019225, 15051.397944082251, 14774.704505909875, 15310.311036003379, 15388.153651549188, 15405.69188616227, 15424.922875385635, 798.1738900238255, 799.6761311668783, 802.0936341933636, 802.3300544045729, 806.5443024691031, 640.3500447046251, 661.3221448015775, 775.437807589496, 806.04483686831, 811.3184924663282, 838.0404436919723, 840.9327253819711, 843.0684094076018, 843.6625349860075, 843.8185790055137, 670.9597424154566, 833.1335411172435, 834.3408707121397, 834.5910503853129, 835.1314632781899, 594.4827999640297, 616.1404840247874, 618.709206672863, 619.2259675405743, 619.6406084471041, 14093.85906140946, 14121.223332716696, 14142.50501232452, 14156.150630962175, 14177.929110354486, 12321.383930803513, 12775.680607984781, 12970.610881673565, 13029.348532573333, 13324.866751332556, 11734.706632334175, 11741.706457338549, 11818.586349477813, 11978.64064078079, 11994.760104797942, 3322.6178989416285, 3328.4674452087793, 3378.983105084483, 3384.3908096542614, 3445.2592692571216, 58932.82134357332, 59294.11058834121, 59473.0, 59718.40281597172, 60217.397826022054, 9227.630894764134, 9556.474393908262, 10112.747181320527, 10427.478626068818, 10472.633457828939, 17280.913595431943, 17349.479515614552, 17360.045197514257, 17368.65262694739, 17459.388921387945, 6568.211814582281, 6802.829929251809, 6805.353491418307, 6843.281455447206, 6856.485763567753, 3736.775793452347, 3778.6410291022307, 3845.250176215667, 3858.4212368145004, 3878.6897048236074, 2858.185417156142, 2948.9705102948697, 2962.792604517663, 2978.300099476621, 2981.4633365993895, 516.7442116152454, 530.1094161808122, 536.2492510485351, 541.8157826338985, 542.1001138110718, 479.59234650546756, 491.39803740418415, 493.59127458005423, 499.7251511668568, 535.1170568561904, 7785.766427007199, 7836.294733474015, 8132.390070744717, 8160.224778646019, 9786.1192492676, 484.46224690593414, 488.6896820518996, 512.2528702540901, 554.6505701408167, 624.4941597306106, 3989.940150897739, 4256.851010214627, 4344.174606824693, 4413.8234470621455, 4415.183191109655, 90043.0, 90499.54750226207, 93234.0, 93843.0, 93981.53009235047, 47051.294230586565, 47570.5242947573, 47969.76015119902, 74201.25798742051, 76024.0, 44492.77753611211, 60031.39968600345, 70166.0, 71100.64449677718, 72223.0, 8229.12867755407, 8241.83516329682, 8337.624806883827, 8475.703350382708, 8483.83032339362, 41857.581424185366, 42192.0, 42511.362329564465, 42634.360484592136, 43955.120897581226, 60828.78342433215, 61129.694351527956, 61331.693341533006, 62153.37846621476, 63130.36869631245, 11491.0, 11580.254270957623, 11869.762604747684, 11919.284842909454, 12159.756804863677, 12624.431900564681, 12630.3684815757, 12725.490980361052, 13050.15174013686, 13440.327983600977, 12502.062345324319, 12540.0, 12725.55460558876, 13216.14095083855, 13316.800247996482, 12042.21725587834, 12265.877341226831, 12479.812802808146, 12850.036663429804, 12925.676858078623, 12228.816567751313, 12284.324362160167, 12583.245005299712, 12931.547395841477, 13001.804972925604, 10383.428911409945, 10901.618443354444, 10921.177587844508, 10937.476604261674, 11189.608363707232, 9803.313768036169, 9904.672401985672, 10337.793244135226, 10381.377117372982, 10765.623203187852], "value": 6574.972820983144, "unit": "score"}], "name": "dromaeo_css", "value": 6442.472086805938, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 113.0, 115.0, 113.0, 113.0, 112.0, 112.0, 113.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 121.0, 125.0, 176.0, 123.0, 126.0, 151.0, 123.0, 175.0, 122.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 162.0, 163.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 120.0, 76.0, 77.0, 76.0, 75.0, 104.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 123.0, 84.0, 90.0, 85.0, 117.0, 86.0, 86.0, 115.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.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": [67.0, 64.0, 65.0, 64.0, 66.0, 64.0, 65.0, 64.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 66.0, 65.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 81.0, 79.0, 79.0, 80.0, 78.0, 85.0, 78.0, 83.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 139.0, 132.0, 137.0, 129.0, 129.0, 138.0, 181.0, 130.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 167.0, 168.0, 162.0, 163.0, 164.0, 168.0, 165.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 65.0, 66.0, 70.0, 66.0, 67.0, 66.0, 67.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1530.6, "alertThreshold": 2.0}]} 15:59:46 INFO - Return code: 0 15:59:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:59:46 INFO - # TBPL SUCCESS # 15:59:46 INFO - Running post-action listener: _resource_record_post_action 15:59:46 INFO - ##### 15:59:46 INFO - ##### Finished run-tests step (success) 15:59:46 INFO - ##### 15:59:46 INFO - Running post-run listener: _resource_record_post_run 15:59:46 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 20480; Write bytes: 534683648; Read time: 388; Write time: 507716 15:59:46 INFO - TinderboxPrint: CPU usage
13.0% 15:59:46 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 388 15:59:46 INFO - TinderboxPrint: I/O write bytes / time
534,683,648 / 507,716 15:59:46 INFO - TinderboxPrint: CPU idle
8,336.1 (87.0%) 15:59:46 INFO - TinderboxPrint: CPU user
1,199.5 (12.5%) 15:59:46 INFO - TinderboxPrint: Swap in / out
0 / 0 15:59:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 245608448; Read time: 112; Write time: 316152 15:59:46 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 12288; Write bytes: 288538624; Read time: 264; Write time: 191564 15:59:47 INFO - Running post-run listener: _upload_blobber_files 15:59:47 INFO - Blob upload gear active. 15:59:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:59:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:59:47 INFO - (blobuploader) - INFO - Open directory for files ... 15:59:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:59:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:59:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:59:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:59:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:59:48 INFO - (blobuploader) - INFO - Done attempting. 15:59:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:59:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:59:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:59:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:59:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:59:49 INFO - (blobuploader) - INFO - Done attempting. 15:59:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:59:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:59:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:59:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:59:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:59:52 INFO - (blobuploader) - INFO - Done attempting. 15:59:52 INFO - (blobuploader) - INFO - Iteration through files over. 15:59:52 INFO - Return code: 0 15:59:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:59:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:59:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/34b8061f868f2396eda0ff4d01a55763d88845903d20ebc54d12ebefceea94f98d3e9cfe1fc571082a05d0aadd711fad863ced05097699d6ff8cacb9a3a4c479", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f73f9c8020f2ecd2cd0b6c2cd4137d82a95e9eee6e7edb1c1b037ec16ec0a8545f253736cbc2385f021bcd77832f8d16eefd1cf78698d0df8af5e3618d3db451", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/950edb83716a18af9eefb9d5de0b364b894aa6b36b6522d31a862273a9c9c410c5b694c2cfc472e08655acd160003da1f78a6e995fba83b149349829ba06ba73"} 15:59:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:59:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:59:52 INFO - Contents: 15:59:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/34b8061f868f2396eda0ff4d01a55763d88845903d20ebc54d12ebefceea94f98d3e9cfe1fc571082a05d0aadd711fad863ced05097699d6ff8cacb9a3a4c479", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f73f9c8020f2ecd2cd0b6c2cd4137d82a95e9eee6e7edb1c1b037ec16ec0a8545f253736cbc2385f021bcd77832f8d16eefd1cf78698d0df8af5e3618d3db451", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/950edb83716a18af9eefb9d5de0b364b894aa6b36b6522d31a862273a9c9c410c5b694c2cfc472e08655acd160003da1f78a6e995fba83b149349829ba06ba73"} 15:59:52 INFO - Running post-run listener: copy_logs_to_upload_dir 15:59:52 INFO - Copying logs to upload dir... 15:59:52 INFO - mkdir: /builds/slave/test/build/upload/logs 15:59:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.201262 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-01 15:59:52.856700) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 15:59:52.860062) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607 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/34b8061f868f2396eda0ff4d01a55763d88845903d20ebc54d12ebefceea94f98d3e9cfe1fc571082a05d0aadd711fad863ced05097699d6ff8cacb9a3a4c479", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f73f9c8020f2ecd2cd0b6c2cd4137d82a95e9eee6e7edb1c1b037ec16ec0a8545f253736cbc2385f021bcd77832f8d16eefd1cf78698d0df8af5e3618d3db451", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/950edb83716a18af9eefb9d5de0b364b894aa6b36b6522d31a862273a9c9c410c5b694c2cfc472e08655acd160003da1f78a6e995fba83b149349829ba06ba73"} build_url:https://queue.taskcluster.net/v1/task/a9Znv5UQSh6x_v-OitxMfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/a9Znv5UQSh6x_v-OitxMfw/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/34b8061f868f2396eda0ff4d01a55763d88845903d20ebc54d12ebefceea94f98d3e9cfe1fc571082a05d0aadd711fad863ced05097699d6ff8cacb9a3a4c479", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f73f9c8020f2ecd2cd0b6c2cd4137d82a95e9eee6e7edb1c1b037ec16ec0a8545f253736cbc2385f021bcd77832f8d16eefd1cf78698d0df8af5e3618d3db451", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/950edb83716a18af9eefb9d5de0b364b894aa6b36b6522d31a862273a9c9c410c5b694c2cfc472e08655acd160003da1f78a6e995fba83b149349829ba06ba73"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 15:59:52.886900) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:59:52.887288) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1467412444.782992-720146607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:59:52.969867) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 15:59:52.970243) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 15:59:52.970607) ========= ========= Total master_lag: 0.16 =========