builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1467919140.55 results: success (0) buildid: 20160707115622 builduid: 4a32c8d1d7e444948c0baf00fbd26581 revision: e1007823c2e7b6000c400e2b73036aab3cb7f17a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 12:19:00.546448) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 12:19:00.546854) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 12:19:00.547216) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 12:19:00.562944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 12:19:00.563286) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 12:19:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-07-07 12:19:00 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085631 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 12:19:00.665172) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 12:19:00.665477) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017268 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 12:19:00.722907) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 12:19:00.723240) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e1007823c2e7b6000c400e2b73036aab3cb7f17a --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 e1007823c2e7b6000c400e2b73036aab3cb7f17a --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=9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 12:19:00,801 truncating revision to first 12 chars 2016-07-07 12:19:00,801 Setting DEBUG logging. 2016-07-07 12:19:00,801 attempt 1/10 2016-07-07 12:19:00,801 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e1007823c2e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 12:19:01,437 unpacking tar archive at: fx-team-e1007823c2e7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.973046 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 12:19:01.710850) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 12:19:01.711159) ========= script_repo_revision: e1007823c2e7b6000c400e2b73036aab3cb7f17a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 12:19:01.711586) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 12:19:01.711866) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 12:19:01.721030) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-07-07 12:19:01.721376) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:19:01 INFO - MultiFileLogger online at 20160707 12:19:01 in /builds/slave/test 12:19: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 12:19:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:19:01 INFO - {'append_to_log': False, 12:19:01 INFO - 'base_work_dir': '/builds/slave/test', 12:19:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:19:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:19:01 INFO - 'branch': 'Fx-Team-Non-PGO', 12:19:01 INFO - 'buildbot_json_path': 'buildprops.json', 12:19:01 INFO - 'config_files': ('talos/linux_config.py',), 12:19:01 INFO - 'default_actions': ('clobber', 12:19:01 INFO - 'read-buildbot-config', 12:19:01 INFO - 'download-and-extract', 12:19:01 INFO - 'populate-webroot', 12:19:01 INFO - 'create-virtualenv', 12:19:01 INFO - 'install', 12:19:01 INFO - 'run-tests'), 12:19:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:19:01 INFO - 'download_minidump_stackwalk': True, 12:19:01 INFO - 'download_symbols': 'ondemand', 12:19:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:19:01 INFO - 'tooltool.py': '/tools/tooltool.py', 12:19:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:19:01 INFO - '/tools/misc-python/virtualenv.py')}, 12:19:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:19:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:19:01 INFO - 'installer_path': 'installer.exe', 12:19:01 INFO - 'log_level': 'info', 12:19:01 INFO - 'log_name': 'talos', 12:19:01 INFO - 'log_to_console': True, 12:19:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:19:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:19:01 INFO - 'opt_config_files': (), 12:19:01 INFO - 'pip_index': False, 12:19:01 INFO - 'sps_profile': False, 12:19:01 INFO - 'sps_profile_interval': 0, 12:19:01 INFO - 'suite': 'dromaeojs', 12:19:01 INFO - 'system_bits': '32', 12:19:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:19:01 INFO - 'title': 'talos-linux64-ix-013', 12:19:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:19:01 INFO - 'use_talos_json': True, 12:19:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:19:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:19:01 INFO - 'work_dir': 'build'} 12:19:01 INFO - ##### 12:19:01 INFO - ##### Running clobber step. 12:19:01 INFO - ##### 12:19:01 INFO - Running pre-action listener: _resource_record_pre_action 12:19:01 INFO - Running main action method: clobber 12:19:01 INFO - rmtree: /builds/slave/test/build 12:19:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:19:02 INFO - Running post-action listener: _resource_record_post_action 12:19:02 INFO - ##### 12:19:02 INFO - ##### Finished clobber step (success) 12:19:02 INFO - ##### 12:19:02 INFO - ##### 12:19:02 INFO - ##### Running read-buildbot-config step. 12:19:02 INFO - ##### 12:19:02 INFO - Running pre-action listener: _resource_record_pre_action 12:19:02 INFO - Running main action method: read_buildbot_config 12:19:02 INFO - Using buildbot properties: 12:19:02 INFO - { 12:19:02 INFO - "project": "", 12:19:02 INFO - "product": "firefox", 12:19:02 INFO - "script_repo_revision": "production", 12:19:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:19:02 INFO - "repository": "", 12:19:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:19:02 INFO - "buildid": "20160707115622", 12:19:02 INFO - "pgo_build": "False", 12:19:02 INFO - "basedir": "/builds/slave/test", 12:19:02 INFO - "buildnumber": 1944, 12:19:02 INFO - "slavename": "talos-linux64-ix-013", 12:19:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:19:02 INFO - "platform": "ubuntu64_hw", 12:19:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:19:02 INFO - "branch": "fx-team", 12:19:02 INFO - "repo_path": "integration/fx-team", 12:19:02 INFO - "revision": "e1007823c2e7b6000c400e2b73036aab3cb7f17a", 12:19:02 INFO - "stage_platform": "linux64", 12:19:02 INFO - "builduid": "4a32c8d1d7e444948c0baf00fbd26581", 12:19:02 INFO - "slavebuilddir": "test" 12:19:02 INFO - } 12:19:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:19:02 INFO - Running post-action listener: _resource_record_post_action 12:19:02 INFO - ##### 12:19:02 INFO - ##### Finished read-buildbot-config step (success) 12:19:02 INFO - ##### 12:19:02 INFO - ##### 12:19:02 INFO - ##### Running download-and-extract step. 12:19:02 INFO - ##### 12:19:02 INFO - Running pre-action listener: _resource_record_pre_action 12:19:02 INFO - Running main action method: download_and_extract 12:19:02 INFO - mkdir: /builds/slave/test/build/tests 12:19: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')]} 12:19:02 INFO - https://queue.taskcluster.net/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:19:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:19:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:19:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/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 12:19:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/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 12:19:06 INFO - Downloaded 1361 bytes. 12:19:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:19:06 INFO - Using the following test package requirements: 12:19:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:19:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:19:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:19:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:06 INFO - u'jsshell-linux-x86_64.zip'], 12:19:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:19:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:19:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:19:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:19:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:19:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:19:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:06 INFO - https://queue.taskcluster.net/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:19:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:19:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:19:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/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 12:19:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/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 12:19:08 INFO - Downloaded 22735068 bytes. 12:19:08 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'] 12:19:08 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 12:19:09 INFO - Return code: 0 12:19:09 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 12:19:09 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')]} 12:19:09 INFO - https://queue.taskcluster.net/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:19:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:19:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:19:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/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 12:19:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/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 12:19:13 INFO - Downloaded 22735068 bytes. 12:19:13 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'] 12:19:13 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 12:19:15 INFO - Return code: 0 12:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:15 INFO - https://queue.taskcluster.net/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:19:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:19:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:19:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/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 12:19:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/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 12:19:16 INFO - Downloaded 14403333 bytes. 12:19:16 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'] 12:19:16 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 12:19:16 INFO - Return code: 0 12:19:16 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')]} 12:19:16 INFO - https://queue.taskcluster.net/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:19:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:19:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:19:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/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 12:19:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeZ2R27XSqugoF_vCS1kyQ/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 12:19:41 INFO - Downloaded 56645137 bytes. 12:19:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:19:41 INFO - mkdir: /builds/slave/test/properties 12:19:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:19:41 INFO - Writing to file /builds/slave/test/properties/build_url 12:19:41 INFO - Contents: 12:19:41 INFO - build_url:https://queue.taskcluster.net/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:19:42 INFO - Running post-action listener: _resource_record_post_action 12:19:42 INFO - Running post-action listener: set_extra_try_arguments 12:19:42 INFO - ##### 12:19:42 INFO - ##### Finished download-and-extract step (success) 12:19:42 INFO - ##### 12:19:42 INFO - ##### 12:19:42 INFO - ##### Running populate-webroot step. 12:19:42 INFO - ##### 12:19:42 INFO - Running pre-action listener: _resource_record_pre_action 12:19:42 INFO - Running main action method: populate_webroot 12:19:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:19:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:19:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:19:42 INFO - '--tppagecycles', 12:19:42 INFO - '7'], 12:19:42 INFO - 'tests': ['tsvgm']}}, 12:19:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:19:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:19:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:19:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:19:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:19:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:19:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:42 INFO - 'talos_options': ['--disable-e10s'], 12:19:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:42 INFO - 'talos_options': ['--disable-e10s'], 12:19:42 INFO - 'tests': ['damp', 'tps']}, 12:19:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:42 INFO - 'tests': ['damp', 'tps']}, 12:19:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:19:42 INFO - 'tests': ['dromaeo_dom']}, 12:19:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:19:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:19:42 INFO - 'tests': ['basic_compositor_video']}, 12:19:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:19:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:19:42 INFO - 'tests': ['a11yr', 12:19:42 INFO - 'ts_paint', 12:19:42 INFO - 'tpaint', 12:19:42 INFO - 'sessionrestore', 12:19:42 INFO - 'sessionrestore_no_auto_restore', 12:19:42 INFO - 'tabpaint']}, 12:19:42 INFO - 'other-e10s': {'tests': ['a11yr', 12:19:42 INFO - 'ts_paint', 12:19:42 INFO - 'tpaint', 12:19:42 INFO - 'sessionrestore', 12:19:42 INFO - 'sessionrestore_no_auto_restore', 12:19:42 INFO - 'tabpaint']}, 12:19:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:19:42 INFO - 'ts_paint', 12:19:42 INFO - 'tpaint', 12:19:42 INFO - 'sessionrestore', 12:19:42 INFO - 'sessionrestore_no_auto_restore', 12:19:42 INFO - 'tabpaint']}, 12:19:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:19:42 INFO - 'ts_paint', 12:19:42 INFO - 'tpaint', 12:19:42 INFO - 'sessionrestore', 12:19:42 INFO - 'sessionrestore_no_auto_restore', 12:19:42 INFO - 'tabpaint']}, 12:19:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:19:42 INFO - 'tests': ['a11yr', 12:19:42 INFO - 'ts_paint', 12:19:42 INFO - 'tpaint', 12:19:42 INFO - 'sessionrestore', 12:19:42 INFO - 'sessionrestore_no_auto_restore', 12:19:42 INFO - 'tabpaint']}, 12:19:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:19:42 INFO - 'tests': ['a11yr', 12:19:42 INFO - 'ts_paint', 12:19:42 INFO - 'tpaint', 12:19:42 INFO - 'sessionrestore', 12:19:42 INFO - 'sessionrestore_no_auto_restore', 12:19:42 INFO - 'tabpaint']}, 12:19:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:19:42 INFO - 'tests': ['tsvgx', 12:19:42 INFO - 'tsvgr_opacity', 12:19:42 INFO - 'tart', 12:19:42 INFO - 'tscrollx', 12:19:42 INFO - 'cart']}, 12:19:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:19:42 INFO - 'tsvgr_opacity', 12:19:42 INFO - 'tart', 12:19:42 INFO - 'tscrollx', 12:19:42 INFO - 'cart']}, 12:19:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:42 INFO - 'talos_options': ['--disable-e10s'], 12:19:42 INFO - 'tests': ['tp5o']}, 12:19:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:42 INFO - 'tests': ['tp5o']}, 12:19:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:42 INFO - 'talos_options': ['--disable-e10s', 12:19:42 INFO - '--xperf_path', 12:19:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:42 INFO - 'tests': ['tp5n']}, 12:19:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:42 INFO - 'talos_options': ['--xperf_path', 12:19:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:42 INFO - 'tests': ['tp5n']}}, 12:19:42 INFO - 'talos.zip': {'path': '', 12:19:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:19:42 INFO - Running post-action listener: _resource_record_post_action 12:19:42 INFO - ##### 12:19:42 INFO - ##### Finished populate-webroot step (success) 12:19:42 INFO - ##### 12:19:42 INFO - ##### 12:19:42 INFO - ##### Running create-virtualenv step. 12:19:42 INFO - ##### 12:19:42 INFO - Running pre-action listener: _resource_record_pre_action 12:19:42 INFO - Running main action method: create_virtualenv 12:19:42 INFO - Creating virtualenv /builds/slave/test/build/venv 12:19:42 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 12:19:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:19:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:19:42 INFO - Using real prefix '/usr' 12:19:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:19:42 INFO - Installing distribute.............................................................................................................................................................................................done. 12:19:44 INFO - Installing pip.................done. 12:19:44 INFO - Return code: 0 12:19:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d93b0>, '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 0x22da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', '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 12:19:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:19:44 INFO - Using env: {'DISPLAY': ':0', 12:19:44 INFO - 'HOME': '/home/cltbld', 12:19:44 INFO - 'LANG': 'en_US.UTF-8', 12:19:44 INFO - 'LANGUAGE': 'en_US:en', 12:19:44 INFO - 'LOGNAME': 'cltbld', 12:19:44 INFO - 'MAIL': '/var/mail/cltbld', 12:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:44 INFO - 'MOZ_NO_REMOTE': '1', 12:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:44 INFO - 'NO_EM_RESTART': '1', 12:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:44 INFO - 'PWD': '/builds/slave/test', 12:19:44 INFO - 'SHELL': '/bin/bash', 12:19:44 INFO - 'SHLVL': '1', 12:19:44 INFO - 'TERM': 'linux', 12:19:44 INFO - 'TMOUT': '86400', 12:19:44 INFO - 'USER': 'cltbld', 12:19:44 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', 12:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:44 INFO - '_': '/tools/buildbot/bin/python'} 12:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:45 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 12:19:45 INFO - Cleaning up... 12:19:45 INFO - Return code: 0 12:19:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:19: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')]} 12:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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')]} 12:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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', '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 0x201a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d93b0>, '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 0x22da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', '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 12:19: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:19: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 psutil>=3.1.1 12:19:45 INFO - Using env: {'DISPLAY': ':0', 12:19:45 INFO - 'HOME': '/home/cltbld', 12:19:45 INFO - 'LANG': 'en_US.UTF-8', 12:19:45 INFO - 'LANGUAGE': 'en_US:en', 12:19:45 INFO - 'LOGNAME': 'cltbld', 12:19:45 INFO - 'MAIL': '/var/mail/cltbld', 12:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:45 INFO - 'MOZ_NO_REMOTE': '1', 12:19:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:45 INFO - 'NO_EM_RESTART': '1', 12:19:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:45 INFO - 'PWD': '/builds/slave/test', 12:19:45 INFO - 'SHELL': '/bin/bash', 12:19:45 INFO - 'SHLVL': '1', 12:19:45 INFO - 'TERM': 'linux', 12:19:45 INFO - 'TMOUT': '86400', 12:19:45 INFO - 'USER': 'cltbld', 12:19:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', 12:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:45 INFO - '_': '/tools/buildbot/bin/python'} 12:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:45 INFO - Downloading/unpacking psutil>=3.1.1 12:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:19:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:19:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:19:47 INFO - Installing collected packages: psutil 12:19:47 INFO - Running setup.py install for psutil 12:19:47 INFO - building 'psutil._psutil_linux' extension 12:19:47 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 12:19:47 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 12:19:47 INFO - building 'psutil._psutil_posix' extension 12:19:47 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 12:19:47 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 12:19:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:19:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:19:47 INFO - Successfully installed psutil 12:19:47 INFO - Cleaning up... 12:19:47 INFO - Return code: 0 12:19:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:47 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 0x201a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d93b0>, '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 0x22da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', '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 12:19:47 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 12:19:47 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 12:19:47 INFO - Using env: {'DISPLAY': ':0', 12:19:47 INFO - 'HOME': '/home/cltbld', 12:19:47 INFO - 'LANG': 'en_US.UTF-8', 12:19:47 INFO - 'LANGUAGE': 'en_US:en', 12:19:47 INFO - 'LOGNAME': 'cltbld', 12:19:47 INFO - 'MAIL': '/var/mail/cltbld', 12:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:47 INFO - 'MOZ_NO_REMOTE': '1', 12:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:47 INFO - 'NO_EM_RESTART': '1', 12:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:47 INFO - 'PWD': '/builds/slave/test', 12:19:47 INFO - 'SHELL': '/bin/bash', 12:19:47 INFO - 'SHLVL': '1', 12:19:47 INFO - 'TERM': 'linux', 12:19:47 INFO - 'TMOUT': '86400', 12:19:47 INFO - 'USER': 'cltbld', 12:19:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', 12:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:47 INFO - '_': '/tools/buildbot/bin/python'} 12:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:19:48 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 12:19:48 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 12:19:48 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 12:19:48 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 12:19:48 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 12:19:48 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 12:19:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:19:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:19:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:19:50 INFO - Installing collected packages: mozsystemmonitor 12:19:50 INFO - Running setup.py install for mozsystemmonitor 12:19:50 INFO - Successfully installed mozsystemmonitor 12:19:50 INFO - Cleaning up... 12:19:51 INFO - Return code: 0 12:19:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d93b0>, '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 0x22da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', '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 12:19:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:19:51 INFO - Using env: {'DISPLAY': ':0', 12:19:51 INFO - 'HOME': '/home/cltbld', 12:19:51 INFO - 'LANG': 'en_US.UTF-8', 12:19:51 INFO - 'LANGUAGE': 'en_US:en', 12:19:51 INFO - 'LOGNAME': 'cltbld', 12:19:51 INFO - 'MAIL': '/var/mail/cltbld', 12:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:51 INFO - 'MOZ_NO_REMOTE': '1', 12:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:51 INFO - 'NO_EM_RESTART': '1', 12:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:51 INFO - 'PWD': '/builds/slave/test', 12:19:51 INFO - 'SHELL': '/bin/bash', 12:19:51 INFO - 'SHLVL': '1', 12:19:51 INFO - 'TERM': 'linux', 12:19:51 INFO - 'TMOUT': '86400', 12:19:51 INFO - 'USER': 'cltbld', 12:19:51 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', 12:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:51 INFO - '_': '/tools/buildbot/bin/python'} 12:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:51 INFO - Downloading/unpacking jsonschema==2.5.1 12:19:51 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 12:19:51 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 12:19:51 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 12:19:51 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 12:19:51 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 12:19:51 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 12:19:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:19:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:19:53 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 12:19:53 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 12:19:53 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 12:19:53 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 12:19:53 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 12:19:53 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 12:19:53 INFO - Downloading functools32-3.2.3-2.tar.gz 12:19:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:19:53 INFO - warning: no files found matching '*.txt' 12:19:53 INFO - no previously-included directories found matching 'build' 12:19:53 INFO - no previously-included directories found matching 'dist' 12:19:53 INFO - no previously-included directories found matching '.git*' 12:19:53 INFO - Installing collected packages: jsonschema, functools32 12:19:53 INFO - Running setup.py install for functools32 12:19:53 INFO - warning: no files found matching '*.txt' 12:19:53 INFO - no previously-included directories found matching 'build' 12:19:53 INFO - no previously-included directories found matching 'dist' 12:19:53 INFO - no previously-included directories found matching '.git*' 12:19:53 INFO - Successfully installed jsonschema functools32 12:19:53 INFO - Cleaning up... 12:19:53 INFO - Return code: 0 12:19:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:19:53 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')]} 12:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:53 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')]} 12:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:53 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 0x201a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d93b0>, '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 0x22da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', '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 12:19:53 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 12:19:53 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 12:19:53 INFO - Using env: {'DISPLAY': ':0', 12:19:53 INFO - 'HOME': '/home/cltbld', 12:19:53 INFO - 'LANG': 'en_US.UTF-8', 12:19:53 INFO - 'LANGUAGE': 'en_US:en', 12:19:53 INFO - 'LOGNAME': 'cltbld', 12:19:53 INFO - 'MAIL': '/var/mail/cltbld', 12:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:53 INFO - 'MOZ_NO_REMOTE': '1', 12:19:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:53 INFO - 'NO_EM_RESTART': '1', 12:19:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:53 INFO - 'PWD': '/builds/slave/test', 12:19:53 INFO - 'SHELL': '/bin/bash', 12:19:53 INFO - 'SHLVL': '1', 12:19:53 INFO - 'TERM': 'linux', 12:19:53 INFO - 'TMOUT': '86400', 12:19:53 INFO - 'USER': 'cltbld', 12:19:53 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', 12:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:53 INFO - '_': '/tools/buildbot/bin/python'} 12:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:54 INFO - Downloading/unpacking blobuploader==1.2.4 12:19:54 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 12:19:54 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 12:19:54 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 12:19:54 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 12:19:54 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 12:19:54 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 12:19:55 INFO - Downloading blobuploader-1.2.4.tar.gz 12:19:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:19:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:19:56 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 12:19:56 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 12:19:56 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 12:19:56 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 12:19:56 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 12:19:56 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 12:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:19:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:19:56 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 12:19:56 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 12:19:56 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 12:19:56 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 12:19:56 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 12:19:56 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 12:19:56 INFO - Downloading docopt-0.6.1.tar.gz 12:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:19:56 INFO - Installing collected packages: blobuploader, requests, docopt 12:19:56 INFO - Running setup.py install for blobuploader 12:19:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:19:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:19:56 INFO - Running setup.py install for requests 12:19:57 INFO - Running setup.py install for docopt 12:19:57 INFO - Successfully installed blobuploader requests docopt 12:19:57 INFO - Cleaning up... 12:19:57 INFO - Return code: 0 12:19:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:57 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')]} 12:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:57 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')]} 12:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:57 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 0x201a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d93b0>, '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 0x22da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', '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 12:19:57 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 12:19:57 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 12:19:57 INFO - Using env: {'DISPLAY': ':0', 12:19:57 INFO - 'HOME': '/home/cltbld', 12:19:57 INFO - 'LANG': 'en_US.UTF-8', 12:19:57 INFO - 'LANGUAGE': 'en_US:en', 12:19:57 INFO - 'LOGNAME': 'cltbld', 12:19:57 INFO - 'MAIL': '/var/mail/cltbld', 12:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:57 INFO - 'MOZ_NO_REMOTE': '1', 12:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:57 INFO - 'NO_EM_RESTART': '1', 12:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:57 INFO - 'PWD': '/builds/slave/test', 12:19:57 INFO - 'SHELL': '/bin/bash', 12:19:57 INFO - 'SHLVL': '1', 12:19:57 INFO - 'TERM': 'linux', 12:19:57 INFO - 'TMOUT': '86400', 12:19:57 INFO - 'USER': 'cltbld', 12:19:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', 12:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:57 INFO - '_': '/tools/buildbot/bin/python'} 12:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:57 INFO - Running setup.py (path:/tmp/pip-yTDH8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:57 INFO - Running setup.py (path:/tmp/pip-TCn6jL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:57 INFO - Running setup.py (path:/tmp/pip-ybG4xS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:57 INFO - Running setup.py (path:/tmp/pip-NERArH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:57 INFO - Running setup.py (path:/tmp/pip-1FB9zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:57 INFO - Running setup.py (path:/tmp/pip-5ijCo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:57 INFO - Running setup.py (path:/tmp/pip-oEEbiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:58 INFO - Running setup.py (path:/tmp/pip-3L_fq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:58 INFO - Running setup.py (path:/tmp/pip-4V6evn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:58 INFO - Running setup.py (path:/tmp/pip-2vApSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:58 INFO - Running setup.py (path:/tmp/pip-8YdrpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:58 INFO - Running setup.py (path:/tmp/pip-phFie5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:58 INFO - Running setup.py (path:/tmp/pip-V6rSkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:58 INFO - Running setup.py (path:/tmp/pip-FztaVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:58 INFO - Running setup.py (path:/tmp/pip-SVXdrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:58 INFO - Running setup.py (path:/tmp/pip-XXU5c8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:58 INFO - Running setup.py (path:/tmp/pip-p1QFOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:19:58 INFO - Running setup.py install for manifestparser 12:19:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:19:58 INFO - Running setup.py install for mozcrash 12:19:58 INFO - Running setup.py install for mozdebug 12:19:59 INFO - Running setup.py install for mozdevice 12:19:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:19:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:19:59 INFO - Running setup.py install for mozfile 12:19:59 INFO - Running setup.py install for mozhttpd 12:19:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:19:59 INFO - Running setup.py install for mozinfo 12:19:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:19:59 INFO - Running setup.py install for mozInstall 12:19:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:19:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:19:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:19:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:19:59 INFO - Running setup.py install for mozleak 12:19:59 INFO - Running setup.py install for mozlog 12:19:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:19:59 INFO - Running setup.py install for moznetwork 12:19:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:19:59 INFO - Running setup.py install for mozprocess 12:19:59 INFO - Running setup.py install for mozprofile 12:20:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:20:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:20:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:20:00 INFO - Running setup.py install for mozrunner 12:20:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:20:00 INFO - Running setup.py install for mozscreenshot 12:20:00 INFO - Running setup.py install for moztest 12:20:00 INFO - Running setup.py install for mozversion 12:20:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:20:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:20:00 INFO - Cleaning up... 12:20:00 INFO - Return code: 0 12:20:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:20:00 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')]} 12:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:00 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')]} 12:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:00 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 0x201a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d93b0>, '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 0x22da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', '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 12:20:00 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 12:20:00 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 12:20:00 INFO - Using env: {'DISPLAY': ':0', 12:20:00 INFO - 'HOME': '/home/cltbld', 12:20:00 INFO - 'LANG': 'en_US.UTF-8', 12:20:00 INFO - 'LANGUAGE': 'en_US:en', 12:20:00 INFO - 'LOGNAME': 'cltbld', 12:20:00 INFO - 'MAIL': '/var/mail/cltbld', 12:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:00 INFO - 'MOZ_NO_REMOTE': '1', 12:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:00 INFO - 'NO_EM_RESTART': '1', 12:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:00 INFO - 'PWD': '/builds/slave/test', 12:20:00 INFO - 'SHELL': '/bin/bash', 12:20:00 INFO - 'SHLVL': '1', 12:20:00 INFO - 'TERM': 'linux', 12:20:00 INFO - 'TMOUT': '86400', 12:20:00 INFO - 'USER': 'cltbld', 12:20:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', 12:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:00 INFO - '_': '/tools/buildbot/bin/python'} 12:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:20:00 INFO - Running setup.py (path:/tmp/pip-ObunEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:20:00 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)) 12:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:20:00 INFO - Running setup.py (path:/tmp/pip-1Py0oG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:20:00 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)) 12:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:20:00 INFO - Running setup.py (path:/tmp/pip-4Zmsms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:20:00 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)) 12:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:20:00 INFO - Running setup.py (path:/tmp/pip-SYi3sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:20:01 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)) 12:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:20:01 INFO - Running setup.py (path:/tmp/pip-U8XcCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:20:01 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)) 12:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:20:01 INFO - Running setup.py (path:/tmp/pip-2dYQLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:20:01 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)) 12:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:20:01 INFO - Running setup.py (path:/tmp/pip-3fZP6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:20:01 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)) 12:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:20:01 INFO - Running setup.py (path:/tmp/pip-_4Lx4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:20:01 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)) 12:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:20:01 INFO - Running setup.py (path:/tmp/pip-qFXbOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:20:01 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)) 12:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:20:01 INFO - Running setup.py (path:/tmp/pip-nUEqDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:20:01 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)) 12:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:20:01 INFO - Running setup.py (path:/tmp/pip-5uUa2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:20:01 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)) 12:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:20:01 INFO - Running setup.py (path:/tmp/pip-Akk3SR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:20:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:20:01 INFO - Running setup.py (path:/tmp/pip-HI6FTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:20:01 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)) 12:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:20:01 INFO - Running setup.py (path:/tmp/pip-aXqdVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:20:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:01 INFO - Running setup.py (path:/tmp/pip-xVZRqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:01 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)) 12:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:20:01 INFO - Running setup.py (path:/tmp/pip-8xE0N2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:20:01 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)) 12:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:20:01 INFO - Running setup.py (path:/tmp/pip-sOSgyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:20:01 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)) 12:20:01 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)) 12:20:01 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)) 12:20:01 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)) 12:20:01 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)) 12:20:01 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)) 12:20:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:20:01 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 12:20:01 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 12:20:01 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 12:20:01 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 12:20:01 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 12:20:01 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 12:20:03 INFO - Downloading blessings-1.6.tar.gz 12:20:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:20:03 INFO - Installing collected packages: blessings 12:20:03 INFO - Running setup.py install for blessings 12:20:04 INFO - Successfully installed blessings 12:20:04 INFO - Cleaning up... 12:20:04 INFO - Return code: 0 12:20:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:20:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:20:04 INFO - Reading from file tmpfile_stdout 12:20:04 INFO - Current package versions: 12:20:04 INFO - argparse == 1.2.1 12:20:04 INFO - blessings == 1.6 12:20:04 INFO - blobuploader == 1.2.4 12:20:04 INFO - docopt == 0.6.1 12:20:04 INFO - functools32 == 3.2.3-2 12:20:04 INFO - jsonschema == 2.5.1 12:20:04 INFO - manifestparser == 1.1 12:20:04 INFO - mozInstall == 1.12 12:20:04 INFO - mozcrash == 0.17 12:20:04 INFO - mozdebug == 0.1 12:20:04 INFO - mozdevice == 0.48 12:20:04 INFO - mozfile == 1.2 12:20:04 INFO - mozhttpd == 0.7 12:20:04 INFO - mozinfo == 0.9 12:20:04 INFO - mozleak == 0.1 12:20:04 INFO - mozlog == 3.2 12:20:04 INFO - moznetwork == 0.27 12:20:04 INFO - mozprocess == 0.23 12:20:04 INFO - mozprofile == 0.28 12:20:04 INFO - mozrunner == 6.12 12:20:04 INFO - mozscreenshot == 0.1 12:20:04 INFO - mozsystemmonitor == 0.3 12:20:04 INFO - moztest == 0.7 12:20:04 INFO - mozversion == 1.4 12:20:04 INFO - psutil == 3.1.1 12:20:04 INFO - requests == 1.2.3 12:20:04 INFO - wsgiref == 0.1.2 12:20:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:04 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 0x201a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d93b0>, '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 0x22da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', '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 12:20:04 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 12:20:04 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 12:20:04 INFO - Using env: {'DISPLAY': ':0', 12:20:04 INFO - 'HOME': '/home/cltbld', 12:20:04 INFO - 'LANG': 'en_US.UTF-8', 12:20:04 INFO - 'LANGUAGE': 'en_US:en', 12:20:04 INFO - 'LOGNAME': 'cltbld', 12:20:04 INFO - 'MAIL': '/var/mail/cltbld', 12:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:04 INFO - 'MOZ_NO_REMOTE': '1', 12:20:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:04 INFO - 'NO_EM_RESTART': '1', 12:20:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:04 INFO - 'PWD': '/builds/slave/test', 12:20:04 INFO - 'SHELL': '/bin/bash', 12:20:04 INFO - 'SHLVL': '1', 12:20:04 INFO - 'TERM': 'linux', 12:20:04 INFO - 'TMOUT': '86400', 12:20:04 INFO - 'USER': 'cltbld', 12:20:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', 12:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:04 INFO - '_': '/tools/buildbot/bin/python'} 12:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:04 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)) 12:20:04 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)) 12:20:04 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)) 12:20:04 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)) 12:20:04 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)) 12:20:04 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)) 12:20:04 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)) 12:20:04 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)) 12:20:04 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)) 12:20:04 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)) 12:20:04 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)) 12:20:04 INFO - Cleaning up... 12:20:04 INFO - Return code: 0 12:20:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:04 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 0x201a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d93b0>, '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 0x22da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', '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 12:20:04 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 12:20:04 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 12:20:04 INFO - Using env: {'DISPLAY': ':0', 12:20:04 INFO - 'HOME': '/home/cltbld', 12:20:04 INFO - 'LANG': 'en_US.UTF-8', 12:20:04 INFO - 'LANGUAGE': 'en_US:en', 12:20:04 INFO - 'LOGNAME': 'cltbld', 12:20:04 INFO - 'MAIL': '/var/mail/cltbld', 12:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:04 INFO - 'MOZ_NO_REMOTE': '1', 12:20:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:04 INFO - 'NO_EM_RESTART': '1', 12:20:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:04 INFO - 'PWD': '/builds/slave/test', 12:20:04 INFO - 'SHELL': '/bin/bash', 12:20:04 INFO - 'SHLVL': '1', 12:20:04 INFO - 'TERM': 'linux', 12:20:04 INFO - 'TMOUT': '86400', 12:20:04 INFO - 'USER': 'cltbld', 12:20:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', 12:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:04 INFO - '_': '/tools/buildbot/bin/python'} 12:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:20:04 INFO - Cleaning up... 12:20:04 INFO - Return code: 0 12:20:04 INFO - Running post-action listener: _resource_record_post_action 12:20:04 INFO - Running post-action listener: _start_resource_monitoring 12:20:04 INFO - Starting resource monitoring. 12:20:04 INFO - ##### 12:20:04 INFO - ##### Finished create-virtualenv step (success) 12:20:04 INFO - ##### 12:20:04 INFO - ##### 12:20:04 INFO - ##### Running install step. 12:20:04 INFO - ##### 12:20:04 INFO - Running pre-action listener: _resource_record_pre_action 12:20:04 INFO - Running main action method: install 12:20:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:20:05 INFO - Reading from file tmpfile_stdout 12:20:05 INFO - Detecting whether we're running mozinstall >=1.0... 12:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:20:05 INFO - Reading from file tmpfile_stdout 12:20:05 INFO - Output received: 12:20:05 INFO - Usage: mozinstall [options] installer 12:20:05 INFO - Options: 12:20:05 INFO - -h, --help show this help message and exit 12:20:05 INFO - -d DEST, --destination=DEST 12:20:05 INFO - Directory to install application into. [default: 12:20:05 INFO - "/builds/slave/test"] 12:20:05 INFO - --app=APP Application being installed. [default: firefox] 12:20:05 INFO - mkdir: /builds/slave/test/build/application 12:20:05 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'] 12:20:05 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 12:20:21 INFO - Reading from file tmpfile_stdout 12:20:21 INFO - Output received: 12:20:21 INFO - /builds/slave/test/build/application/firefox/firefox 12:20:21 INFO - Running post-action listener: _resource_record_post_action 12:20:21 INFO - ##### 12:20:21 INFO - ##### Finished install step (success) 12:20:21 INFO - ##### 12:20:21 INFO - ##### 12:20:21 INFO - ##### Running run-tests step. 12:20:21 INFO - ##### 12:20:21 INFO - Running pre-action listener: _resource_record_pre_action 12:20:21 INFO - Running main action method: run_tests 12:20:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:20:21 INFO - Python 2.7.3 12:20:21 INFO - Return code: 0 12:20:21 INFO - grabbing minidump binary from tooltool 12:20: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')]} 12:20:21 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 0x22d93b0>, '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 0x22da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22da740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:20:21 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 12:20:21 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 12:20:21 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 12:20:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:20:21 INFO - Return code: 0 12:20:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:20:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:20:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:20:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:20:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:20:21 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/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 12:20:21 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/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 12:20:21 INFO - Using env: {'DISPLAY': ':0', 12:20:21 INFO - 'HOME': '/home/cltbld', 12:20:21 INFO - 'LANG': 'en_US.UTF-8', 12:20:21 INFO - 'LANGUAGE': 'en_US:en', 12:20:21 INFO - 'LOGNAME': 'cltbld', 12:20:21 INFO - 'MAIL': '/var/mail/cltbld', 12:20:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:20:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:21 INFO - 'MOZ_NO_REMOTE': '1', 12:20:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:20:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:21 INFO - 'NO_EM_RESTART': '1', 12:20:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:21 INFO - 'PWD': '/builds/slave/test', 12:20:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:20:21 INFO - 'SHELL': '/bin/bash', 12:20:21 INFO - 'SHLVL': '1', 12:20:21 INFO - 'TERM': 'linux', 12:20:21 INFO - 'TMOUT': '86400', 12:20:21 INFO - 'USER': 'cltbld', 12:20:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475', 12:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:21 INFO - '_': '/tools/buildbot/bin/python'} 12:20:21 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/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 12:20:21 INFO - mozversion application_buildid: 20160707115622 12:20:21 INFO - mozversion application_changeset: e1007823c2e7b6000c400e2b73036aab3cb7f17a 12:20:21 INFO - mozversion application_display_name: Nightly 12:20:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:20:21 INFO - mozversion application_name: Firefox 12:20:21 INFO - mozversion application_remotingname: firefox 12:20:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:20:21 INFO - mozversion application_vendor: Mozilla 12:20:21 INFO - mozversion application_version: 50.0a1 12:20:21 INFO - mozversion platform_buildid: 20160707115622 12:20:21 INFO - mozversion platform_changeset: e1007823c2e7b6000c400e2b73036aab3cb7f17a 12:20:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:20:21 INFO - mozversion platform_version: 50.0a1 12:20:21 INFO - using testdate: 1467919221 12:20:21 INFO - actual date: 1467919221 12:20:21 INFO - starting webserver on 'localhost:46068' 12:20:21 INFO - SUITE-START | Running 2 tests 12:20:21 INFO - TEST-START | dromaeo_css 12:20:21 INFO - operating with platform_type : linux_ 12:20:21 INFO - Initialising browser for dromaeo_css test... 12:20:21 INFO - TEST-INFO | started process 15399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVZsoI3/profile http://localhost:46068/getInfo.html) 12:20:25 INFO - PROCESS | 15399 | __metrics Screen width/height:1600/1200 12:20:25 INFO - PROCESS | 15399 | colorDepth:24 12:20:25 INFO - PROCESS | 15399 | Browser inner width/height: 1024/697 12:20:25 INFO - PROCESS | 15399 | __metrics 12:20:26 INFO - PROCESS | 15399 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:20:28 INFO - TEST-INFO | 15399: exit 0 12:20:28 INFO - Browser initialized. 12:20:28 INFO - Running cycle 1/1 for dromaeo_css test... 12:20:28 INFO - TEST-INFO | started process 15478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVZsoI3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:20:39 INFO - PROCESS | 15478 | RSS: Main: 158916608 12:20:39 INFO - PROCESS | 15478 | 12:21:30 INFO - PROCESS | 15478 | 1467919290738 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] 12:23:43 INFO - PROCESS | 15478 | Cycle 1(1): loaded http://localhost:46068/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46068/tests/dromaeo/cssquery-ext.html) 12:23:44 INFO - PROCESS | 15478 | RSS: Main: 271568896 12:23:44 INFO - PROCESS | 15478 | 12:26:47 INFO - PROCESS | 15478 | Cycle 1(1): loaded http://localhost:46068/tests/dromaeo/cssquery-ext.html (next: http://localhost:46068/tests/dromaeo/cssquery-jquery.html) 12:26:48 INFO - PROCESS | 15478 | RSS: Main: 239345664 12:26:48 INFO - PROCESS | 15478 | 12:29:50 INFO - PROCESS | 15478 | Cycle 1(1): loaded http://localhost:46068/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46068/tests/dromaeo/cssquery-mootools.html) 12:29:51 INFO - PROCESS | 15478 | RSS: Main: 234889216 12:29:51 INFO - PROCESS | 15478 | 12:32:53 INFO - PROCESS | 15478 | Cycle 1(1): loaded http://localhost:46068/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46068/tests/dromaeo/cssquery-prototype.html) 12:32:53 INFO - PROCESS | 15478 | RSS: Main: 236871680 12:32:53 INFO - PROCESS | 15478 | 12:35:57 INFO - PROCESS | 15478 | Cycle 1(1): loaded http://localhost:46068/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46068/tests/dromaeo/cssquery-yui.html) 12:35:57 INFO - PROCESS | 15478 | RSS: Main: 214278144 12:35:57 INFO - PROCESS | 15478 | 12:39:00 INFO - PROCESS | 15478 | Cycle 1(1): loaded http://localhost:46068/tests/dromaeo/cssquery-yui.html (next: http://localhost:46068/tests/dromaeo/cssquery-dojo.html) 12:39:00 INFO - PROCESS | 15478 | RSS: Main: 276602880 12:39:00 INFO - PROCESS | 15478 | 12:39:00 INFO - PROCESS | 15478 | __start_tp_report 12:39:00 INFO - PROCESS | 15478 | _x_x_mozilla_page_load 12:39:00 INFO - PROCESS | 15478 | _x_x_mozilla_page_load_details 12:39:00 INFO - PROCESS | 15478 | |i|pagename|runs| 12:39:00 INFO - PROCESS | 15478 | |0;dojo.html;2609.791216702664;2611.4124322027546;2648.9867550662243;2653.1244689252535;2665.346989987452;4653.581177694007;4704.2238030724975;4776.379070720805;4817.831375901844;4884.706917584943;4687.8359257426;4717.69334993226;4728.598069164125;4778.331033655291;4800.279958006301;4291.463567054118;4335.393044973706;4370.344448332744;4398.626116780078;4550.317452382136;4450.354698568705;4489.079738653568;4515.61617262533;4524.864254072383;4532.728036317815;4302.56974302572;4342.956570434287;4368.672349573794;4369.541198174178;4370.300751879716;4366.039471316305;4366.519682834885;4379.386885835986;4418;4418.160549495586;4387.1445068211715;4397.494288156871;4401.427814384142;4443.777811109431;4446.710963787344;4646.395968524104;4712.151812673717;4770.856874293777;4786.305985632099;4791.928121078186;5110.540051395392;5151.665141765773;5173.17229243323;5174.637775355726;5177.37871455424;5169.689818610857;5195.558377537914;5196.558292545138;5199.6360254782185;5204.76578553966;4710.175719249152;4734.857954261378;4788.712677239377;4799.736014519165;4848.442429120626;5272.05103081449;5312.04383211018;5347.0909945309395;5347.3048503695045;5347.705876176848;4843.709377437365;5051.090803655377;5057.241413787888;5095.923561146586;5098.796048158032;5030.597552195815;5087.135187018216;5090.10923088458;5098.515641014098;5162.045021671003;5046.772895219724;5049;5061.72160531167;5061.72160531167;5116.641835071509;4967.602591792648;5023.673461225008;5030.170021946338;5036.445990940993;5039.420466646309;4337.067530480962;4357.9564204358185;4370.038591509863;4382.671299652538;4421.911561768747;3852.6725228355904;3856.402257650069;3865.9806700966315;3901.3367727486398;3905.5313362396696;4390.670699697535;4396.956030439655;4398.142362239397;4426.579474949875;4442.844500442469;4998.550130488201;5094.617903657167;5128.230765385148;5166.870828229325;5232.2674825524455;4304.720193187432;4316.43886294786;4317.654587633045;4323.524412314643;4365.476142862877;4596.264597664358;4627.490975992638;4635.23518619424;4643.257078867365;4678.625709943264;4306.354046892991;4666.160091183619;4780.976095119502;4800.591949684316;4844.297576851407;5167.1474206755465;5173.844784656466;5181.35233095863;5184.688918664892;5233.162693968947;4630.282306242538;4773.331733557236;4774.069056533943;4785.162596545661;4825.276208568743;4944.28307895346;5016.046951079284;5024.145895197898;5038.47096054909;5057.46896575869;5137.640365174402;5147.794088236428;5153.587712983027;5156.04613146569;5209.661372010807;4883.780229889735;4995.575376092927;4998.550130488274;5006.048850718352;5014.874628134326;5025.120603894231;5032.647714659939;5040.36995375578;5072.264521644414;5091.949080509147;4956.529129732814;4972.825951091694;4977.9502204978935;5024.899502010013;5028.220625803006;4870.172070747911;4936.654434189572;4978.004399120263;5088.669236499616;5124.256982737407;4878.853634390974;4902.607791376753;4903.155496111331;4910.852674419773;4941.50584941503 12:39:00 INFO - PROCESS | 15478 | |1;ext.html;537.7877749147723;568.1477783325009;575.9654420734754;594.7680404642189;602.7137109872809;27678.308042298926;39727.40408893865;40589.79705101474;40687;40855.79572102135;42668;43020.139597208035;43034.35448468268;43044.354334685006;43164.784176079156;7592.316691497764;7842.568658723768;7968.9601551992155;7990.840183196333;10035.448050357227;9917.454540000297;10270.845937310947;10280.383177009366;10280.897191028107;10281.53733082013;10396.272260941738;10445.216608754336;10451.895481045207;10455.529501172465;10459.163266938665;7639.579823109727;10068.093871551522;10356.741081472986;10377.273590848643;10383.480825958672;10180.422034584652;10256.692299231036;10269.691909242734;10270.537825797857;10272.126869216125;39830.203395931916;40151.7992410039;40163;40263;40274.798626006974;2280.8859557022083;3020.758339332848;3169.2710676544525;3331.3170799985946;3368.7641865069454;28605.713942860722;28746.281342966384;29137.56293655597;31132;31432.214194645316;3510.7717998330027;3586.444101164324;3588.3361578108133;3637.654422829827;3689.815509224528;264254;271416;271490;272286.999999998;272866;49450.99999999928;56825.43174568284;57563;58331.70834145887;58367.54081148005;56602.43397566054;62072.37927620756;62187;62193;62231;14131.364088616037;14354.784678229835;14359.64100897465;14426;14429.278536073154;9256.352055356061;10438.37369757817;10457.895421045692;10534.683959481228;10914;19527.80472195288;19545.609087818164;19570.70643940342;19603.705944410845;19611.901940490206;6959.373656370951;6973.372396484341;6991.161060672752;7269.164046134656;7275.126325101555;820.3437250199817;879.7580665317089;901.9052999435096;930.7998780262141;963.797602503468;28631;28842.567361489593;29095.854520727262;29611.703882961327;29627.851860740557;985.7486340983004;1015.7663737340305;1063.4098075568133;1070.2240875365299;1076.2304951959386;14709.779353309708;15282.388704451698;15352.616184595474;15570;15638;450184;456481;456596;664483;665834;51101.23348149781;51831.740841295556;51926;51932.74033629808;51952.740236298574;1083.1605505732962;1133.1671221652243;1138.2430683595317;1222.786012447836;1227.5948936850818;19729.477611940434;30497.69502305037;31222;31370.21574460657;32092.358152836347;46175.3073703888;46647.76676116733;46972.7651361741;46977.53022469868;47076.52923470722;333167;333213;335011;335246;336866;22583.66124508101;25040.123595674064;25312.240632781046;25896.48207035811;26028.479430411666;40313;41002.38496422496;41418;41469.377959331236;41910.37134443047;35333.46999795057;36188;36676.26647467089;36805.26389472142;36856.26287474182;35160;35701.64298357087;35743.821280893426;35773.46339804957;36185.27629447449;34096;34608.30783384268;34675.65324346724;35411;35418.64581354154;30873.382532349675;32541.511877321387;33027.33945321032;33134.33731325408;33162.5025624611;24757;24946.62580061264;25397.56735522008;25553.48893022166;25626.359341016625 12:39:00 INFO - PROCESS | 15478 | |2;jquery.html;371.0630657589586;371.1908040471772;373.40814808528484;382.55050315878833;389.6493156159456;16820.831791682078;17616.559586010357;18340.08299585022;18594.16326265318;18605.162767675454;17057.488275351727;17195.140242987833;17408.39070632528;18080.4575862724;18161.002289748118;5167.250748641445;5280.735963201843;5329.333833270841;5339.893202135955;5344.893102137955;3718.6653201211884;5270.051390749663;5945.702714864261;6245.375462453764;6262;6183.319834818167;6291.276503202122;6316.084167795667;6334.873302533946;6346.365363463663;6134.2332208473945;6254.343293954137;6273.7176827042895;6274.811755647315;6288.685565721696;3437.432823584106;3619.8371073301764;3620.6560376764164;3662.853485860562;5145.176771716545;19676.50808729779;20960.5807883843;20984.5803083939;22098.558028839332;22381.10475580975;1764.356010056333;1835.9449216523526;1883.0396497786091;1993.481694759373;2382.392489915078;8892;9041.276697864221;9054;9058.456492610465;9771.267154963336;1697.8981261124372;1698.3800912666788;1711.3582406597525;1731.333436626895;1748.4404990403077;71356;71371;72875;74668.62665686745;75173;9233.445993240428;9242.815143697222;9543.952280238555;9925.851112233322;9960.302778805559;13546.796798048037;13588;13634.454621815017;13635;13680.31598420095;7271.67277472515;7295.343419092307;7355.485116041933;7456.925430745731;7478.4765066444825;7103.538270012433;7111.715531378687;7127.2160062393095;7254.383377412979;7268.345848873627;4254.255505286563;4265.97867010663;4276.12339470414;4276.593723596254;4353.760543170093;1624.6994306053418;1671.4233589411633;1743.3462451580658;1748.606563523197;1749.4926471323174;744.1851172965594;815.6248125862052;865.1348651348651;872.8341615093112;875.1161327059716;16931.492055238363;17633;17788.377406790958;17946.820531794776;18299;856.8586183279689;869.0874581689201;875.4309698695898;903.214203642835;917.179124683418;9490.810183796286;9915.900840991499;9980.500974951223;9990.700278991642;10082.59669613222;357596;363659;366264;366377;367397;46896.5310346899;79429.60285198652;82827.58586207031;83283;83526.582367089;875.4922145155922;880.0627331891515;894.8120894612074;896.4845214001975;902.0393281155548;14901.92549037248;15518.301676424362;15664.608384790472;15822.287997040392;16087.597810054374;35563.644363556035;36272.637273626926;36613.81693091518;37387;37930.0517487065;50871.74564127304;52008;52718.73640631772;52851.207231892324;53026.73486632542;7085.6811443486195;7126.322999315057;7149.571025738473;7325.963370183115;7356.668949897375;9630.47032413224;10408.531616077446;10602.46987650599;11134.610288639858;11255.718607034889;9542.856857147288;9568.665096721581;9684;9715.562799674173;9869.555869985725;9149.085091490797;9287.303452241244;9328.160465558132;9359.204467620057;9641.180499657326;8867.778305542413;9615.326927115035;9745.220382369534;9917.65288214909;10002.699919002442;6457.967710161419;6655.933440665725;6734.696938637871;6915.273896241023;7037.7184912602925;9687.66093186735;9996;10027.44849033281;10169.745756356151;10486.318389304672 12:39:00 INFO - PROCESS | 15478 | |3;mootools.html;1365.18771331058;1392.554382597569;1501.8948673592854;1679;1704.7613334133232;7463.66413511392;7900.209979002097;7949.880751788721;7950.64222110005;7952.324052455541;6606.537542372036;7482.925170748291;7735.226477352276;7749.535027898316;7942.285194332523;2205.162038425396;2223.5775202711516;2231.843770936035;2233.218373569254;2234.4078819112947;1850.4448665400325;2096.4863608415885;2159.9892000539976;2187.387531491185;2230.096810791632;2210.126999835064;2250.1674380479244;2250.8199344052437;2252.1892118837204;2253.402848245208;2136.359092272312;2137.4122116417952;2189.386971647941;2190.0582749417745;2190.0692205812625;2146.8389870759597;2155.170259450123;2155.956880862374;2157.9784202157934;2186.0709198590694;7697.230276972258;7818.960905195438;7829.060512738451;7833.216678332178;7833.725819596287;4515.2324104902245;4651.697639653446;4660.99788545461;4663.51033141522;4669.859904202845;2787.818791778528;2830.561263004238;2881.150060732089;2885.8845646174127;2889.3643398452305;918.678462538113;931.1386967055514;952.0099096939175;958.7986522830214;969;10045.54795034218;10398.06417422428;10413.219008574311;10646.78706425875;10718.249722519427;4020.2160578686876;4038.212548553004;4134.400511925754;4143.854965076268;4172.895677608023;8245.257926786499;8276.08963014068;8278.793030174294;8331.54176520285;8339.8332033359;4592.7933243004145;4611.584957353854;4615.723056616614;4616.192166370872;4617.168909596305;4232.238197124486;4269;4269.743815371087;4277.059047009653;4293.527711951683;3365.764396492222;3400.914977125542;3437.0719905625842;3467.809270490097;3468.0982944434627;966.3042609321277;1050.3435352904435;1054.857594224785;1068.6526878764278;1094.3871431997948;733.1129333506517;763.744145711193;767.6353731977266;771.3366504805863;810.5987536169633;4889.828855990023;4968.105740966661;5059.848204553869;5068.898622027539;5181.06740786662;828.1180542721982;829.655692887457;834.486790623762;920.1074957291416;969.1229437359201;3194.4409728297455;3359.5632567766033;3384.2892992471366;3413.9317213655586;3532.752707310515;9554.092361225812;9773.267004974656;9807.06832850878;9859.753506162404;9864.605415783288;9737.221022318197;9748.902510974942;9757.170640495637;9760.902390976;9773.21814254858;6752.3922846944015;6884.208316043719;6976.7209311627985;6990.545614535141;7004.754833580801;5122.487751224997;5135.563477104339;5228.869278268074;5245.659032162897;5332.33345831771;8872.556372181236;8999.64001439935;9074.546272686472;9111.498867562083;9114.407563508616;8947.552622368725;9042.864357034781;9113.681021164228;9274.95362523183;9283.071692830663;7452;7578.280063393969;7583.127940286938;7589.241075892367;7595.240475952582;7469.066366704162;7527.962360188164;7530.322270995636;7537.585432801248;7539.246075392417;6659.467242620675;6921.89617155733;6929.064576282138;6955.930440695528;7030.578165310098;6766.086578311865;6835.179778426621;6929.411000065051;6955.617441040589;7004.0544526488275;5786.479216870502;5909.261342332208;5957.582969192288;5968.253968253968;5988.850278743066;4224.4930608327195;4264.232438161161;4414.205443020287;4431.0694754102;4464.754438505784;4336.219480493542;4350.760708161081;4440.156370289635;4495.955040449554;4542.727436353697 12:39:00 INFO - PROCESS | 15478 | |4;prototype.html;301.2649136107897;302.75023105937606;307.97998130121533;309.1143872804416;311.05129355465823;4990.426100998387;4995.5762607656825;5017.9498205017935;5028.245763135532;5039.798408063678;4952.331435256239;4955.380577427822;4975.383000524835;4989.476105008967;4998.950010499894;3694.20574576466;3762.2851658184995;3799.3731034379293;3829.6744776694013;3843.0968722350226;3795.3737633290475;3817.8854634361014;3829.7893615851117;3834.923301533968;3840.231953609289;3810.618938106181;3811.5997820228754;3812.5234345706785;3813.2564149990762;3822.73240873139;3626;3732.514773079496;3846.365349717293;3860.4209368594657;3875.341191997339;3425.2978139481347;3428.194374322032;3432.502287168347;3434.4333185024443;3447.207142357272;4839.467658557556;4841.49164337743;4877.414710234759;4880.41435027799;4893.510648935114;4179.373094035888;4402.8679139625865;4405.074934263808;4449.17690227309;4458.5318541553315;5166.43169251382;5196.58427325813;5198.454162312941;5207.4011488678525;5209.817656382046;3664.743467957244;3664.8350824212976;3673.522442082539;3674.52231209941;3686.299603075434;5158.638895277332;5414.377346605152;5427.3215848019;5471.316085489314;5495.53287970523;3696.1129328960856;3718.4608231806237;3719.497867787868;3721.981390093032;3736.8505259789304;3798.25933942884;3798.9240215196096;3799.35410980134;3802.334591446486;3803.866864659779;4354.760488173118;4366.148601022834;4379.364992076131;4379.634997101593;4380.824767009348;5061.468545802712;5156.767945442464;5160.406553246425;5162.561182299547;5162.9415969726115;1278.7762141625178;1290.5741105435184;1294.1587967820992;1295.8185853980451;1296.293520031585;830.8296799156159;841.7811369044092;845.5053793530731;869.3957699398984;876.4916348517844;4420.602145806893;4425.734455932655;4427.114577084531;4427.424434823517;4428.092241090569;5160.664556803796;5173.973225662954;5216.791328346823;5233.267342572043;5259.368875734936;4295.098029413795;4428.800703968329;4435.135148646047;4444.1112527176465;4448.799804008828;2811.8049828823077;2819.971800282012;2832.872520736572;2834.886604535837;2836.4894319022774;4880.82917097907;4881.170201065827;4884.511548845087;4884.755762211947;4892.926606100911;5246.554042906319;5361.597880159004;5379.731013449312;5397.2443857859935;5409.862279877661;4846.442659094249;4852.636052296092;4854.660173787872;4871.756412179306;4874.926876096862;5178;5221.895562088813;5238.607104467104;5241.554467870121;5242.97378513105;4957.504249575158;5109.697027258026;5118.616103792156;5141.38303403594;5151.793928242828;4837.37114175155;4859.514048595112;4870.951290487192;4872.610191184767;4874.4409185178065;3731.1418373774727;3733.346664333785;3733.477313176103;3733.477313176103;3752.6434988676033;4960.206366981266;5195.7142357169205;5226.477352264743;5252.65857719247;5305.734713264398;5027.170516864822;5032.949670503248;5053.84838454847;5056.949430505795;5059.316992206005;4986.925196121989;5071.594272458268;5079.517445842639;5083.364579427572;5085.288059671723;4815.783289752039;4961;4976.825811096594;4978.502149784992;4997.150484417731;4949.950500494949;4985.202367621163;5152.510511501401;5198.844034678966;5201.505856943584;5050.9747451263975;5054.620903432331;5066.189409694432;5082.593392528663;5084.872878178076 12:39:00 INFO - PROCESS | 15478 | |5;yui.html;726.4116065986551;733.3949491669371;740.3891789273847;775.5966897213445;776.0415886380321;14292.857071429282;14721.41114355427;14959.925200373997;14967.25163741814;14998.250087495622;14290.642733931656;14379.209143497104;14421.63945901353;14505.927470362634;14513.709725805504;627.7332133843121;762.0969151555424;782.2451334462257;802.9558374289412;804.7263930263709;804.6419343392192;809.1463506001166;811.5982588618613;811.7402431222012;812.0174588747623;835.9791005224857;836.3142223376833;836.5273620404482;836.7615229659548;837.4347315562002;654.8362909272682;808.4744915804715;826.6156237349661;827.3009307135461;829.3779665251062;609.5550248318708;609.8963176260046;610.0239616613383;610.124471383566;610.5115907274163;13323.26722030288;13338.466461341535;13355.465781368734;13363.866361336457;13367.665808354772;12638.684032899158;12965.805512917314;13048.412821423059;13163;13500.594982150551;10104.89895101047;10349.9482502587;10476.895231047669;10528.578856845794;10628.574857005711;3228.370467758788;3242.5946756655417;3249.23642943908;3271.7219036381935;3316.535685004101;67418.66290668564;68141.65929170372;68775;69949.65025174893;69968.30031699668;10635.46822658864;10671.466426678635;10734.409607471507;10746.570137194582;10818.188635852342;19146;19322.130504127348;19332.71000934987;19345.51636209106;19415.708764368545;6654.800355989328;6860.759873404407;6924.619145947021;6931.826704332432;7003.614801185984;3492.476128580733;3613.385724426854;3662.487251784752;3712.5916149223563;3738.5513738351574;3050.3746731919905;3083.1675447629013;3153.3220357623222;3158.3367492826305;3160.683931606821;499.5578912662247;499.9525045120708;508.659198337115;521.413409913847;523.3614989712545;462.2188501432568;507.860338406941;548.2872266054113;586.9054213891062;595.9731812068468;8032;8232.17678232172;8389.496630202208;8413.621387037598;8436.325093992466;499.78509241026705;501.1605560685837;505.6612069913167;563.7153237614979;600.393602461517;3752.212035472581;4002.139539998856;4032.2137183248983;4111.301078816608;4228.9788551057045;77114.61442692751;80400.19599803927;81063.5946820274;93344;99360.503197485;46107.30839037417;73978.26021739822;80073.59963200147;83697;84866;46043.30935035977;51957.74021129946;65624.67187664127;79999.60000199961;81710.59144704239;8590.14098590136;8764.430312029697;8903.821923561363;8912.197902188835;9039;43449;44006.779966099966;44305.55694443014;44608;44665.55334446614;62328.376716232255;62434.68782656058;62435.687821560605;62500.68749656223;62753.68623156855;12019.939900300442;12082.697932551757;12671.513311629891;12854.164479308814;13028.934855325662;12791.936040319739;13278.468861245441;13367.06430549891;13442.731145377233;13542.864571354161;7419.925800741924;11284.717882052686;11864.525418983145;12294.20087694297;12410.317432541297;12502.937485312515;12743.299118548568;12749.617511474671;13095.541656042375;13478;10970.451477426257;11028.834567481656;11166.106711463226;11319.773604527698;11429.714257143638;9935.552900119657;10419.635312764018;10666.36001839892;10705.929407059231;10954.342739435659;9775.21798256152;9996.650452188862;10160;10163.695089147337;10163.7459063524 12:39:00 INFO - PROCESS | 15478 | __end_tp_report 12:39:00 INFO - PROCESS | 15478 | __start_cc_report 12:39:00 INFO - PROCESS | 15478 | _x_x_mozilla_cycle_collect,1127 12:39:00 INFO - PROCESS | 15478 | __end_cc_report 12:39:00 INFO - PROCESS | 15478 | __startTimestamp1467920340703__endTimestamp 12:39:00 INFO - PROCESS | 15478 | 12:39:00 INFO - PROCESS | 15478 | ------- Summary: start ------- 12:39:00 INFO - PROCESS | 15478 | Number of tests: 6 12:39:00 INFO - PROCESS | 15478 | 12:39:00 INFO - PROCESS | 15478 | [#0] dojo.html Cycles:165 Average:4729.68 Median:4843.71 stddev:502.73 (10.4%) stddev-sans-first:475.97 12:39:00 INFO - PROCESS | 15478 | Values: 2609.8 2611.4 2649.0 2653.1 2665.3 4653.6 4704.2 4776.4 4817.8 4884.7 4687.8 4717.7 4728.6 4778.3 4800.3 4291.5 4335.4 4370.3 4398.6 4550.3 4450.4 4489.1 4515.6 4524.9 4532.7 4302.6 4343.0 4368.7 4369.5 4370.3 4366.0 4366.5 4379.4 4418.0 4418.2 4387.1 4397.5 4401.4 4443.8 4446.7 4646.4 4712.2 4770.9 4786.3 4791.9 5110.5 5151.7 5173.2 5174.6 5177.4 5169.7 5195.6 5196.6 5199.6 5204.8 4710.2 4734.9 4788.7 4799.7 4848.4 5272.1 5312.0 5347.1 5347.3 5347.7 4843.7 5051.1 5057.2 5095.9 5098.8 5030.6 5087.1 5090.1 5098.5 5162.0 5046.8 5049.0 5061.7 5061.7 5116.6 4967.6 5023.7 5030.2 5036.4 5039.4 4337.1 4358.0 4370.0 4382.7 4421.9 3852.7 3856.4 3866.0 3901.3 3905.5 4390.7 4397.0 4398.1 4426.6 4442.8 4998.6 5094.6 5128.2 5166.9 5232.3 4304.7 4316.4 4317.7 4323.5 4365.5 4596.3 4627.5 4635.2 4643.3 4678.6 4306.4 4666.2 4781.0 4800.6 4844.3 5167.1 5173.8 5181.4 5184.7 5233.2 4630.3 4773.3 4774.1 4785.2 4825.3 4944.3 5016.0 5024.1 5038.5 5057.5 5137.6 5147.8 5153.6 5156.0 5209.7 4883.8 4995.6 4998.6 5006.0 5014.9 5025.1 5032.6 5040.4 5072.3 5091.9 4956.5 4972.8 4978.0 5024.9 5028.2 4870.2 4936.7 4978.0 5088.7 5124.3 4878.9 4902.6 4903.2 4910.9 4941.5 12:39:00 INFO - PROCESS | 15478 | 12:39:00 INFO - PROCESS | 15478 | [#1] ext.html Cycles:180 Average:53482.62 Median:169307.38 stddev:107238.03 (63.3%) stddev-sans-first:107465.18 12:39:00 INFO - PROCESS | 15478 | Values: 537.8 568.1 576.0 594.8 602.7 27678.3 39727.4 40589.8 40687.0 40855.8 42668.0 43020.1 43034.4 43044.4 43164.8 7592.3 7842.6 7969.0 7990.8 10035.4 9917.5 10270.8 10280.4 10280.9 10281.5 10396.3 10445.2 10451.9 10455.5 10459.2 7639.6 10068.1 10356.7 10377.3 10383.5 10180.4 10256.7 10269.7 10270.5 10272.1 39830.2 40151.8 40163.0 40263.0 40274.8 2280.9 3020.8 3169.3 3331.3 3368.8 28605.7 28746.3 29137.6 31132.0 31432.2 3510.8 3586.4 3588.3 3637.7 3689.8 264254.0 271416.0 271490.0 272287.0 272866.0 49451.0 56825.4 57563.0 58331.7 58367.5 56602.4 62072.4 62187.0 62193.0 62231.0 14131.4 14354.8 14359.6 14426.0 14429.3 9256.4 10438.4 10457.9 10534.7 10914.0 19527.8 19545.6 19570.7 19603.7 19611.9 6959.4 6973.4 6991.2 7269.2 7275.1 820.3 879.8 901.9 930.8 963.8 28631.0 28842.6 29095.9 29611.7 29627.9 985.7 1015.8 1063.4 1070.2 1076.2 14709.8 15282.4 15352.6 15570.0 15638.0 450184.0 456481.0 456596.0 664483.0 665834.0 51101.2 51831.7 51926.0 51932.7 51952.7 1083.2 1133.2 1138.2 1222.8 1227.6 19729.5 30497.7 31222.0 31370.2 32092.4 46175.3 46647.8 46972.8 46977.5 47076.5 333167.0 333213.0 335011.0 335246.0 336866.0 22583.7 25040.1 25312.2 25896.5 26028.5 40313.0 41002.4 41418.0 41469.4 41910.4 35333.5 36188.0 36676.3 36805.3 36856.3 35160.0 35701.6 35743.8 35773.5 36185.3 34096.0 34608.3 34675.7 35411.0 35418.6 30873.4 32541.5 33027.3 33134.3 33162.5 24757.0 24946.6 25397.6 25553.5 25626.4 12:39:00 INFO - PROCESS | 15478 | 12:39:00 INFO - PROCESS | 15478 | [#2] jquery.html Cycles:180 Average:23658.21 Median:5342.39 stddev:60448.20 (1131.5%) stddev-sans-first:60592.49 12:39:00 INFO - PROCESS | 15478 | Values: 371.1 371.2 373.4 382.6 389.6 16820.8 17616.6 18340.1 18594.2 18605.2 17057.5 17195.1 17408.4 18080.5 18161.0 5167.3 5280.7 5329.3 5339.9 5344.9 3718.7 5270.1 5945.7 6245.4 6262.0 6183.3 6291.3 6316.1 6334.9 6346.4 6134.2 6254.3 6273.7 6274.8 6288.7 3437.4 3619.8 3620.7 3662.9 5145.2 19676.5 20960.6 20984.6 22098.6 22381.1 1764.4 1835.9 1883.0 1993.5 2382.4 8892.0 9041.3 9054.0 9058.5 9771.3 1697.9 1698.4 1711.4 1731.3 1748.4 71356.0 71371.0 72875.0 74668.6 75173.0 9233.4 9242.8 9544.0 9925.9 9960.3 13546.8 13588.0 13634.5 13635.0 13680.3 7271.7 7295.3 7355.5 7456.9 7478.5 7103.5 7111.7 7127.2 7254.4 7268.3 4254.3 4266.0 4276.1 4276.6 4353.8 1624.7 1671.4 1743.3 1748.6 1749.5 744.2 815.6 865.1 872.8 875.1 16931.5 17633.0 17788.4 17946.8 18299.0 856.9 869.1 875.4 903.2 917.2 9490.8 9915.9 9980.5 9990.7 10082.6 357596.0 363659.0 366264.0 366377.0 367397.0 46896.5 79429.6 82827.6 83283.0 83526.6 875.5 880.1 894.8 896.5 902.0 14901.9 15518.3 15664.6 15822.3 16087.6 35563.6 36272.6 36613.8 37387.0 37930.1 50871.7 52008.0 52718.7 52851.2 53026.7 7085.7 7126.3 7149.6 7326.0 7356.7 9630.5 10408.5 10602.5 11134.6 11255.7 9542.9 9568.7 9684.0 9715.6 9869.6 9149.1 9287.3 9328.2 9359.2 9641.2 8867.8 9615.3 9745.2 9917.7 10002.7 6458.0 6655.9 6734.7 6915.3 7037.7 9687.7 9996.0 10027.4 10169.7 10486.3 12:39:00 INFO - PROCESS | 15478 | 12:39:00 INFO - PROCESS | 15478 | [#3] mootools.html Cycles:180 Average:5102.39 Median:5204.97 stddev:2880.80 (55.3%) stddev-sans-first:2875.19 12:39:00 INFO - PROCESS | 15478 | Values: 1365.2 1392.6 1501.9 1679.0 1704.8 7463.7 7900.2 7949.9 7950.6 7952.3 6606.5 7482.9 7735.2 7749.5 7942.3 2205.2 2223.6 2231.8 2233.2 2234.4 1850.4 2096.5 2160.0 2187.4 2230.1 2210.1 2250.2 2250.8 2252.2 2253.4 2136.4 2137.4 2189.4 2190.1 2190.1 2146.8 2155.2 2156.0 2158.0 2186.1 7697.2 7819.0 7829.1 7833.2 7833.7 4515.2 4651.7 4661.0 4663.5 4669.9 2787.8 2830.6 2881.2 2885.9 2889.4 918.7 931.1 952.0 958.8 969.0 10045.5 10398.1 10413.2 10646.8 10718.2 4020.2 4038.2 4134.4 4143.9 4172.9 8245.3 8276.1 8278.8 8331.5 8339.8 4592.8 4611.6 4615.7 4616.2 4617.2 4232.2 4269.0 4269.7 4277.1 4293.5 3365.8 3400.9 3437.1 3467.8 3468.1 966.3 1050.3 1054.9 1068.7 1094.4 733.1 763.7 767.6 771.3 810.6 4889.8 4968.1 5059.8 5068.9 5181.1 828.1 829.7 834.5 920.1 969.1 3194.4 3359.6 3384.3 3413.9 3532.8 9554.1 9773.3 9807.1 9859.8 9864.6 9737.2 9748.9 9757.2 9760.9 9773.2 6752.4 6884.2 6976.7 6990.5 7004.8 5122.5 5135.6 5228.9 5245.7 5332.3 8872.6 8999.6 9074.5 9111.5 9114.4 8947.6 9042.9 9113.7 9275.0 9283.1 7452.0 7578.3 7583.1 7589.2 7595.2 7469.1 7528.0 7530.3 7537.6 7539.2 6659.5 6921.9 6929.1 6955.9 7030.6 6766.1 6835.2 6929.4 6955.6 7004.1 5786.5 5909.3 5957.6 5968.3 5988.9 4224.5 4264.2 4414.2 4431.1 4464.8 4336.2 4350.8 4440.2 4496.0 4542.7 12:39:00 INFO - PROCESS | 15478 | 12:39:00 INFO - PROCESS | 15478 | [#4] prototype.html Cycles:180 Average:4247.97 Median:4873.53 stddev:1229.17 (25.2%) stddev-sans-first:1196.39 12:39:00 INFO - PROCESS | 15478 | Values: 301.3 302.8 308.0 309.1 311.1 4990.4 4995.6 5017.9 5028.2 5039.8 4952.3 4955.4 4975.4 4989.5 4999.0 3694.2 3762.3 3799.4 3829.7 3843.1 3795.4 3817.9 3829.8 3834.9 3840.2 3810.6 3811.6 3812.5 3813.3 3822.7 3626.0 3732.5 3846.4 3860.4 3875.3 3425.3 3428.2 3432.5 3434.4 3447.2 4839.5 4841.5 4877.4 4880.4 4893.5 4179.4 4402.9 4405.1 4449.2 4458.5 5166.4 5196.6 5198.5 5207.4 5209.8 3664.7 3664.8 3673.5 3674.5 3686.3 5158.6 5414.4 5427.3 5471.3 5495.5 3696.1 3718.5 3719.5 3722.0 3736.9 3798.3 3798.9 3799.4 3802.3 3803.9 4354.8 4366.1 4379.4 4379.6 4380.8 5061.5 5156.8 5160.4 5162.6 5162.9 1278.8 1290.6 1294.2 1295.8 1296.3 830.8 841.8 845.5 869.4 876.5 4420.6 4425.7 4427.1 4427.4 4428.1 5160.7 5174.0 5216.8 5233.3 5259.4 4295.1 4428.8 4435.1 4444.1 4448.8 2811.8 2820.0 2832.9 2834.9 2836.5 4880.8 4881.2 4884.5 4884.8 4892.9 5246.6 5361.6 5379.7 5397.2 5409.9 4846.4 4852.6 4854.7 4871.8 4874.9 5178.0 5221.9 5238.6 5241.6 5243.0 4957.5 5109.7 5118.6 5141.4 5151.8 4837.4 4859.5 4871.0 4872.6 4874.4 3731.1 3733.3 3733.5 3733.5 3752.6 4960.2 5195.7 5226.5 5252.7 5305.7 5027.2 5032.9 5053.8 5056.9 5059.3 4986.9 5071.6 5079.5 5083.4 5085.3 4815.8 4961.0 4976.8 4978.5 4997.2 4950.0 4985.2 5152.5 5198.8 5201.5 5051.0 5054.6 5066.2 5082.6 5084.9 12:39:00 INFO - PROCESS | 15478 | 12:39:00 INFO - PROCESS | 15478 | [#5] yui.html Cycles:180 Average:17290.39 Median:45354.43 stddev:23648.15 (52.1%) stddev-sans-first:23681.78 12:39:00 INFO - PROCESS | 15478 | Values: 726.4 733.4 740.4 775.6 776.0 14292.9 14721.4 14959.9 14967.3 14998.3 14290.6 14379.2 14421.6 14505.9 14513.7 627.7 762.1 782.2 803.0 804.7 804.6 809.1 811.6 811.7 812.0 836.0 836.3 836.5 836.8 837.4 654.8 808.5 826.6 827.3 829.4 609.6 609.9 610.0 610.1 610.5 13323.3 13338.5 13355.5 13363.9 13367.7 12638.7 12965.8 13048.4 13163.0 13500.6 10104.9 10349.9 10476.9 10528.6 10628.6 3228.4 3242.6 3249.2 3271.7 3316.5 67418.7 68141.7 68775.0 69949.7 69968.3 10635.5 10671.5 10734.4 10746.6 10818.2 19146.0 19322.1 19332.7 19345.5 19415.7 6654.8 6860.8 6924.6 6931.8 7003.6 3492.5 3613.4 3662.5 3712.6 3738.6 3050.4 3083.2 3153.3 3158.3 3160.7 499.6 500.0 508.7 521.4 523.4 462.2 507.9 548.3 586.9 596.0 8032.0 8232.2 8389.5 8413.6 8436.3 499.8 501.2 505.7 563.7 600.4 3752.2 4002.1 4032.2 4111.3 4229.0 77114.6 80400.2 81063.6 93344.0 99360.5 46107.3 73978.3 80073.6 83697.0 84866.0 46043.3 51957.7 65624.7 79999.6 81710.6 8590.1 8764.4 8903.8 8912.2 9039.0 43449.0 44006.8 44305.6 44608.0 44665.6 62328.4 62434.7 62435.7 62500.7 62753.7 12019.9 12082.7 12671.5 12854.2 13028.9 12791.9 13278.5 13367.1 13442.7 13542.9 7419.9 11284.7 11864.5 12294.2 12410.3 12502.9 12743.3 12749.6 13095.5 13478.0 10970.5 11028.8 11166.1 11319.8 11429.7 9935.6 10419.6 10666.4 10705.9 10954.3 9775.2 9996.7 10160.0 10163.7 10163.7 12:39:00 INFO - PROCESS | 15478 | -------- Summary: end -------- 12:39:00 INFO - PROCESS | 15478 | 12:39:01 INFO - TEST-INFO | 15478: exit 0 12:39:01 INFO - TEST-OK | dromaeo_css | took 1119861ms 12:39:01 INFO - TEST-START | kraken 12:39:01 INFO - operating with platform_type : linux_ 12:39:01 INFO - Initialising browser for kraken test... 12:39:01 INFO - TEST-INFO | started process 15668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6eSLHQ/profile http://localhost:46068/getInfo.html) 12:39:05 INFO - PROCESS | 15668 | __metrics Screen width/height:1600/1200 12:39:05 INFO - PROCESS | 15668 | colorDepth:24 12:39:05 INFO - PROCESS | 15668 | Browser inner width/height: 1024/697 12:39:05 INFO - PROCESS | 15668 | __metrics 12:39:07 INFO - PROCESS | 15668 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:39:07 INFO - TEST-INFO | 15668: exit 0 12:39:07 INFO - Browser initialized. 12:39:07 INFO - Running cycle 1/1 for kraken test... 12:39:07 INFO - TEST-INFO | started process 15749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6eSLHQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:39:19 INFO - PROCESS | 15749 | RSS: Main: 158441472 12:39:19 INFO - PROCESS | 15749 | 12:39:22 INFO - PROCESS | 15749 | Cycle 1(1): loaded http://localhost:46068/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46068/tests/kraken/driver.html?testName=audio-beat-detection) 12:39:23 INFO - PROCESS | 15749 | RSS: Main: 216674304 12:39:23 INFO - PROCESS | 15749 | 12:39:26 INFO - PROCESS | 15749 | Cycle 1(1): loaded http://localhost:46068/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46068/tests/kraken/driver.html?testName=audio-dft) 12:39:26 INFO - PROCESS | 15749 | RSS: Main: 204296192 12:39:26 INFO - PROCESS | 15749 | 12:39:30 INFO - PROCESS | 15749 | Cycle 1(1): loaded http://localhost:46068/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46068/tests/kraken/driver.html?testName=audio-fft) 12:39:30 INFO - PROCESS | 15749 | RSS: Main: 271122432 12:39:30 INFO - PROCESS | 15749 | 12:39:32 INFO - PROCESS | 15749 | Cycle 1(1): loaded http://localhost:46068/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46068/tests/kraken/driver.html?testName=audio-oscillator) 12:39:33 INFO - PROCESS | 15749 | RSS: Main: 181657600 12:39:33 INFO - PROCESS | 15749 | 12:39:35 INFO - PROCESS | 15749 | Cycle 1(1): loaded http://localhost:46068/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46068/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:39:36 INFO - PROCESS | 15749 | RSS: Main: 185958400 12:39:36 INFO - PROCESS | 15749 | 12:39:39 INFO - PROCESS | 15749 | Cycle 1(1): loaded http://localhost:46068/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46068/tests/kraken/driver.html?testName=imaging-darkroom) 12:39:40 INFO - PROCESS | 15749 | RSS: Main: 221933568 12:39:40 INFO - PROCESS | 15749 | 12:39:43 INFO - PROCESS | 15749 | Cycle 1(1): loaded http://localhost:46068/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46068/tests/kraken/driver.html?testName=imaging-desaturate) 12:39:44 INFO - PROCESS | 15749 | RSS: Main: 222650368 12:39:44 INFO - PROCESS | 15749 | 12:39:47 INFO - PROCESS | 15749 | Cycle 1(1): loaded http://localhost:46068/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46068/tests/kraken/driver.html?testName=json-parse-financial) 12:39:47 INFO - PROCESS | 15749 | RSS: Main: 222433280 12:39:47 INFO - PROCESS | 15749 | 12:39:49 INFO - PROCESS | 15749 | Cycle 1(1): loaded http://localhost:46068/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46068/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:39:50 INFO - PROCESS | 15749 | RSS: Main: 210247680 12:39:50 INFO - PROCESS | 15749 | 12:39:51 INFO - PROCESS | 15749 | Cycle 1(1): loaded http://localhost:46068/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46068/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:39:52 INFO - PROCESS | 15749 | RSS: Main: 214667264 12:39:52 INFO - PROCESS | 15749 | 12:39:54 INFO - PROCESS | 15749 | Cycle 1(1): loaded http://localhost:46068/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46068/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:39:55 INFO - PROCESS | 15749 | RSS: Main: 212627456 12:39:55 INFO - PROCESS | 15749 | 12:39:58 INFO - PROCESS | 15749 | Cycle 1(1): loaded http://localhost:46068/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46068/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:39:58 INFO - PROCESS | 15749 | RSS: Main: 225406976 12:39:58 INFO - PROCESS | 15749 | 12:40:01 INFO - PROCESS | 15749 | Cycle 1(1): loaded http://localhost:46068/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46068/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:40:02 INFO - PROCESS | 15749 | RSS: Main: 226201600 12:40:02 INFO - PROCESS | 15749 | 12:40:04 INFO - PROCESS | 15749 | Cycle 1(1): loaded http://localhost:46068/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46068/tests/kraken/driver.html?testName=ai-astar) 12:40:04 INFO - PROCESS | 15749 | RSS: Main: 268062720 12:40:04 INFO - PROCESS | 15749 | 12:40:04 INFO - PROCESS | 15749 | __start_tp_report 12:40:04 INFO - PROCESS | 15749 | _x_x_mozilla_page_load 12:40:04 INFO - PROCESS | 15749 | _x_x_mozilla_page_load_details 12:40:04 INFO - PROCESS | 15749 | |i|pagename|runs| 12:40:04 INFO - PROCESS | 15749 | |0;ai-astar;104;116;113;112;113;113;112;114;113;114 12:40:04 INFO - PROCESS | 15749 | |1;audio-beat-detection;145;122;128;179;125;124;150;123;156;130 12:40:04 INFO - PROCESS | 15749 | |2;audio-dft;161;159;160;160;160;162;161;161;161;159 12:40:04 INFO - PROCESS | 15749 | |3;audio-fft;75;75;77;120;77;80;76;75;106;75 12:40:04 INFO - PROCESS | 15749 | |4;audio-oscillator;85;85;121;85;85;85;119;85;85;119 12:40:04 INFO - PROCESS | 15749 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;116;117 12:40:04 INFO - PROCESS | 15749 | |6;imaging-darkroom;147;147;146;146;146;146;146;146;146;145 12:40:04 INFO - PROCESS | 15749 | |7;imaging-desaturate;94;95;95;96;95;95;95;95;95;95 12:40:04 INFO - PROCESS | 15749 | |8;json-parse-financial;64;64;64;64;66;63;63;64;64;64 12:40:04 INFO - PROCESS | 15749 | |9;json-stringify-tinderbox;64;64;64;64;65;66;65;65;65;67 12:40:04 INFO - PROCESS | 15749 | |10;stanford-crypto-aes;87;81;84;78;78;79;77;78;77;81 12:40:04 INFO - PROCESS | 15749 | |11;stanford-crypto-ccm;129;127;128;129;131;135;136;128;211;131 12:40:04 INFO - PROCESS | 15749 | |12;stanford-crypto-pbkdf2;167;167;165;168;175;168;166;169;164;167 12:40:04 INFO - PROCESS | 15749 | |13;stanford-crypto-sha256-iterative;67;68;68;67;71;66;68;66;68;68 12:40:04 INFO - PROCESS | 15749 | __end_tp_report 12:40:04 INFO - PROCESS | 15749 | __start_cc_report 12:40:04 INFO - PROCESS | 15749 | _x_x_mozilla_cycle_collect,1903 12:40:04 INFO - PROCESS | 15749 | __end_cc_report 12:40:04 INFO - PROCESS | 15749 | __startTimestamp1467920404281__endTimestamp 12:40:04 INFO - PROCESS | 15749 | 12:40:04 INFO - PROCESS | 15749 | ------- Summary: start ------- 12:40:04 INFO - PROCESS | 15749 | Number of tests: 14 12:40:04 INFO - PROCESS | 15749 | 12:40:04 INFO - PROCESS | 15749 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:3.17 (2.8%) stddev-sans-first:1.22 12:40:04 INFO - PROCESS | 15749 | Values: 104.0 116.0 113.0 112.0 113.0 113.0 112.0 114.0 113.0 114.0 12:40:04 INFO - PROCESS | 15749 | 12:40:04 INFO - PROCESS | 15749 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:137.50 stddev:18.88 (13.7%) stddev-sans-first:19.86 12:40:04 INFO - PROCESS | 15749 | Values: 145.0 122.0 128.0 179.0 125.0 124.0 150.0 123.0 156.0 130.0 12:40:04 INFO - PROCESS | 15749 | 12:40:04 INFO - PROCESS | 15749 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 12:40:04 INFO - PROCESS | 15749 | Values: 161.0 159.0 160.0 160.0 160.0 162.0 161.0 161.0 161.0 159.0 12:40:04 INFO - PROCESS | 15749 | 12:40:04 INFO - PROCESS | 15749 | [#3] audio-fft Cycles:10 Average:83.60 Median:75.50 stddev:15.92 (21.1%) stddev-sans-first:16.58 12:40:04 INFO - PROCESS | 15749 | Values: 75.0 75.0 77.0 120.0 77.0 80.0 76.0 75.0 106.0 75.0 12:40:04 INFO - PROCESS | 15749 | 12:40:04 INFO - PROCESS | 15749 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:85.00 stddev:16.75 (19.7%) stddev-sans-first:17.34 12:40:04 INFO - PROCESS | 15749 | Values: 85.0 85.0 121.0 85.0 85.0 85.0 119.0 85.0 85.0 119.0 12:40:04 INFO - PROCESS | 15749 | 12:40:04 INFO - PROCESS | 15749 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 12:40:04 INFO - PROCESS | 15749 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 12:40:04 INFO - PROCESS | 15749 | 12:40:04 INFO - PROCESS | 15749 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 12:40:04 INFO - PROCESS | 15749 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 12:40:04 INFO - PROCESS | 15749 | 12:40:04 INFO - PROCESS | 15749 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 12:40:04 INFO - PROCESS | 15749 | Values: 94.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 12:40:04 INFO - PROCESS | 15749 | 12:40:04 INFO - PROCESS | 15749 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 12:40:04 INFO - PROCESS | 15749 | Values: 64.0 64.0 64.0 64.0 66.0 63.0 63.0 64.0 64.0 64.0 12:40:04 INFO - PROCESS | 15749 | 12:40:04 INFO - PROCESS | 15749 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.99 (1.5%) stddev-sans-first:1.00 12:40:04 INFO - PROCESS | 15749 | Values: 64.0 64.0 64.0 64.0 65.0 66.0 65.0 65.0 65.0 67.0 12:40:04 INFO - PROCESS | 15749 | 12:40:04 INFO - PROCESS | 15749 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:3.30 (4.1%) stddev-sans-first:2.33 12:40:04 INFO - PROCESS | 15749 | Values: 87.0 81.0 84.0 78.0 78.0 79.0 77.0 78.0 77.0 81.0 12:40:04 INFO - PROCESS | 15749 | 12:40:04 INFO - PROCESS | 15749 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:131.00 stddev:25.65 (19.6%) stddev-sans-first:26.97 12:40:04 INFO - PROCESS | 15749 | Values: 129.0 127.0 128.0 129.0 131.0 135.0 136.0 128.0 211.0 131.0 12:40:04 INFO - PROCESS | 15749 | 12:40:04 INFO - PROCESS | 15749 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.60 Median:167.50 stddev:2.99 (1.8%) stddev-sans-first:3.16 12:40:04 INFO - PROCESS | 15749 | Values: 167.0 167.0 165.0 168.0 175.0 168.0 166.0 169.0 164.0 167.0 12:40:04 INFO - PROCESS | 15749 | 12:40:04 INFO - PROCESS | 15749 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.42 (2.1%) stddev-sans-first:1.48 12:40:04 INFO - PROCESS | 15749 | Values: 67.0 68.0 68.0 67.0 71.0 66.0 68.0 66.0 68.0 68.0 12:40:04 INFO - PROCESS | 15749 | -------- Summary: end -------- 12:40:04 INFO - PROCESS | 15749 | 12:40:05 INFO - TEST-INFO | 15749: exit 0 12:40:05 INFO - TEST-OK | kraken | took 63851ms 12:40:05 INFO - SUITE-END | took 1183s 12:40:05 INFO - Completed test suite (00:19:43) 12:40:05 INFO - javascript benchmark 12:40:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.791216702664, 2611.4124322027546, 2648.9867550662243, 2653.1244689252535, 2665.346989987452, 4653.581177694007, 4704.2238030724975, 4776.379070720805, 4817.831375901844, 4884.706917584943, 4687.8359257426, 4717.69334993226, 4728.598069164125, 4778.331033655291, 4800.279958006301, 4291.463567054118, 4335.393044973706, 4370.344448332744, 4398.626116780078, 4550.317452382136, 4450.354698568705, 4489.079738653568, 4515.61617262533, 4524.864254072383, 4532.728036317815, 4302.56974302572, 4342.956570434287, 4368.672349573794, 4369.541198174178, 4370.300751879716, 4366.039471316305, 4366.519682834885, 4379.386885835986, 4418.0, 4418.160549495586, 4387.1445068211715, 4397.494288156871, 4401.427814384142, 4443.777811109431, 4446.710963787344, 4646.395968524104, 4712.151812673717, 4770.856874293777, 4786.305985632099, 4791.928121078186, 5110.540051395392, 5151.665141765773, 5173.17229243323, 5174.637775355726, 5177.37871455424, 5169.689818610857, 5195.558377537914, 5196.558292545138, 5199.6360254782185, 5204.76578553966, 4710.175719249152, 4734.857954261378, 4788.712677239377, 4799.736014519165, 4848.442429120626, 5272.05103081449, 5312.04383211018, 5347.0909945309395, 5347.3048503695045, 5347.705876176848, 4843.709377437365, 5051.090803655377, 5057.241413787888, 5095.923561146586, 5098.796048158032, 5030.597552195815, 5087.135187018216, 5090.10923088458, 5098.515641014098, 5162.045021671003, 5046.772895219724, 5049.0, 5061.72160531167, 5061.72160531167, 5116.641835071509, 4967.602591792648, 5023.673461225008, 5030.170021946338, 5036.445990940993, 5039.420466646309, 4337.067530480962, 4357.9564204358185, 4370.038591509863, 4382.671299652538, 4421.911561768747, 3852.6725228355904, 3856.402257650069, 3865.9806700966315, 3901.3367727486398, 3905.5313362396696, 4390.670699697535, 4396.956030439655, 4398.142362239397, 4426.579474949875, 4442.844500442469, 4998.550130488201, 5094.617903657167, 5128.230765385148, 5166.870828229325, 5232.2674825524455, 4304.720193187432, 4316.43886294786, 4317.654587633045, 4323.524412314643, 4365.476142862877, 4596.264597664358, 4627.490975992638, 4635.23518619424, 4643.257078867365, 4678.625709943264, 4306.354046892991, 4666.160091183619, 4780.976095119502, 4800.591949684316, 4844.297576851407, 5167.1474206755465, 5173.844784656466, 5181.35233095863, 5184.688918664892, 5233.162693968947, 4630.282306242538, 4773.331733557236, 4774.069056533943, 4785.162596545661, 4825.276208568743, 4944.28307895346, 5016.046951079284, 5024.145895197898, 5038.47096054909, 5057.46896575869, 5137.640365174402, 5147.794088236428, 5153.587712983027, 5156.04613146569, 5209.661372010807, 4883.780229889735, 4995.575376092927, 4998.550130488274, 5006.048850718352, 5014.874628134326, 5025.120603894231, 5032.647714659939, 5040.36995375578, 5072.264521644414, 5091.949080509147, 4956.529129732814, 4972.825951091694, 4977.9502204978935, 5024.899502010013, 5028.220625803006, 4870.172070747911, 4936.654434189572, 4978.004399120263, 5088.669236499616, 5124.256982737407, 4878.853634390974, 4902.607791376753, 4903.155496111331, 4910.852674419773, 4941.50584941503], "value": 4697.19992390107, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.7877749147723, 568.1477783325009, 575.9654420734754, 594.7680404642189, 602.7137109872809, 27678.308042298926, 39727.40408893865, 40589.79705101474, 40687.0, 40855.79572102135, 42668.0, 43020.139597208035, 43034.35448468268, 43044.354334685006, 43164.784176079156, 7592.316691497764, 7842.568658723768, 7968.9601551992155, 7990.840183196333, 10035.448050357227, 9917.454540000297, 10270.845937310947, 10280.383177009366, 10280.897191028107, 10281.53733082013, 10396.272260941738, 10445.216608754336, 10451.895481045207, 10455.529501172465, 10459.163266938665, 7639.579823109727, 10068.093871551522, 10356.741081472986, 10377.273590848643, 10383.480825958672, 10180.422034584652, 10256.692299231036, 10269.691909242734, 10270.537825797857, 10272.126869216125, 39830.203395931916, 40151.7992410039, 40163.0, 40263.0, 40274.798626006974, 2280.8859557022083, 3020.758339332848, 3169.2710676544525, 3331.3170799985946, 3368.7641865069454, 28605.713942860722, 28746.281342966384, 29137.56293655597, 31132.0, 31432.214194645316, 3510.7717998330027, 3586.444101164324, 3588.3361578108133, 3637.654422829827, 3689.815509224528, 264254.0, 271416.0, 271490.0, 272286.999999998, 272866.0, 49450.99999999928, 56825.43174568284, 57563.0, 58331.70834145887, 58367.54081148005, 56602.43397566054, 62072.37927620756, 62187.0, 62193.0, 62231.0, 14131.364088616037, 14354.784678229835, 14359.64100897465, 14426.0, 14429.278536073154, 9256.352055356061, 10438.37369757817, 10457.895421045692, 10534.683959481228, 10914.0, 19527.80472195288, 19545.609087818164, 19570.70643940342, 19603.705944410845, 19611.901940490206, 6959.373656370951, 6973.372396484341, 6991.161060672752, 7269.164046134656, 7275.126325101555, 820.3437250199817, 879.7580665317089, 901.9052999435096, 930.7998780262141, 963.797602503468, 28631.0, 28842.567361489593, 29095.854520727262, 29611.703882961327, 29627.851860740557, 985.7486340983004, 1015.7663737340305, 1063.4098075568133, 1070.2240875365299, 1076.2304951959386, 14709.779353309708, 15282.388704451698, 15352.616184595474, 15570.0, 15638.0, 450184.0, 456481.0, 456596.0, 664483.0, 665834.0, 51101.23348149781, 51831.740841295556, 51926.0, 51932.74033629808, 51952.740236298574, 1083.1605505732962, 1133.1671221652243, 1138.2430683595317, 1222.786012447836, 1227.5948936850818, 19729.477611940434, 30497.69502305037, 31222.0, 31370.21574460657, 32092.358152836347, 46175.3073703888, 46647.76676116733, 46972.7651361741, 46977.53022469868, 47076.52923470722, 333167.0, 333213.0, 335011.0, 335246.0, 336866.0, 22583.66124508101, 25040.123595674064, 25312.240632781046, 25896.48207035811, 26028.479430411666, 40313.0, 41002.38496422496, 41418.0, 41469.377959331236, 41910.37134443047, 35333.46999795057, 36188.0, 36676.26647467089, 36805.26389472142, 36856.26287474182, 35160.0, 35701.64298357087, 35743.821280893426, 35773.46339804957, 36185.27629447449, 34096.0, 34608.30783384268, 34675.65324346724, 35411.0, 35418.64581354154, 30873.382532349675, 32541.511877321387, 33027.33945321032, 33134.33731325408, 33162.5025624611, 24757.0, 24946.62580061264, 25397.56735522008, 25553.48893022166, 25626.359341016625], "value": 18583.673828749343, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.0630657589586, 371.1908040471772, 373.40814808528484, 382.55050315878833, 389.6493156159456, 16820.831791682078, 17616.559586010357, 18340.08299585022, 18594.16326265318, 18605.162767675454, 17057.488275351727, 17195.140242987833, 17408.39070632528, 18080.4575862724, 18161.002289748118, 5167.250748641445, 5280.735963201843, 5329.333833270841, 5339.893202135955, 5344.893102137955, 3718.6653201211884, 5270.051390749663, 5945.702714864261, 6245.375462453764, 6262.0, 6183.319834818167, 6291.276503202122, 6316.084167795667, 6334.873302533946, 6346.365363463663, 6134.2332208473945, 6254.343293954137, 6273.7176827042895, 6274.811755647315, 6288.685565721696, 3437.432823584106, 3619.8371073301764, 3620.6560376764164, 3662.853485860562, 5145.176771716545, 19676.50808729779, 20960.5807883843, 20984.5803083939, 22098.558028839332, 22381.10475580975, 1764.356010056333, 1835.9449216523526, 1883.0396497786091, 1993.481694759373, 2382.392489915078, 8892.0, 9041.276697864221, 9054.0, 9058.456492610465, 9771.267154963336, 1697.8981261124372, 1698.3800912666788, 1711.3582406597525, 1731.333436626895, 1748.4404990403077, 71356.0, 71371.0, 72875.0, 74668.62665686745, 75173.0, 9233.445993240428, 9242.815143697222, 9543.952280238555, 9925.851112233322, 9960.302778805559, 13546.796798048037, 13588.0, 13634.454621815017, 13635.0, 13680.31598420095, 7271.67277472515, 7295.343419092307, 7355.485116041933, 7456.925430745731, 7478.4765066444825, 7103.538270012433, 7111.715531378687, 7127.2160062393095, 7254.383377412979, 7268.345848873627, 4254.255505286563, 4265.97867010663, 4276.12339470414, 4276.593723596254, 4353.760543170093, 1624.6994306053418, 1671.4233589411633, 1743.3462451580658, 1748.606563523197, 1749.4926471323174, 744.1851172965594, 815.6248125862052, 865.1348651348651, 872.8341615093112, 875.1161327059716, 16931.492055238363, 17633.0, 17788.377406790958, 17946.820531794776, 18299.0, 856.8586183279689, 869.0874581689201, 875.4309698695898, 903.214203642835, 917.179124683418, 9490.810183796286, 9915.900840991499, 9980.500974951223, 9990.700278991642, 10082.59669613222, 357596.0, 363659.0, 366264.0, 366377.0, 367397.0, 46896.5310346899, 79429.60285198652, 82827.58586207031, 83283.0, 83526.582367089, 875.4922145155922, 880.0627331891515, 894.8120894612074, 896.4845214001975, 902.0393281155548, 14901.92549037248, 15518.301676424362, 15664.608384790472, 15822.287997040392, 16087.597810054374, 35563.644363556035, 36272.637273626926, 36613.81693091518, 37387.0, 37930.0517487065, 50871.74564127304, 52008.0, 52718.73640631772, 52851.207231892324, 53026.73486632542, 7085.6811443486195, 7126.322999315057, 7149.571025738473, 7325.963370183115, 7356.668949897375, 9630.47032413224, 10408.531616077446, 10602.46987650599, 11134.610288639858, 11255.718607034889, 9542.856857147288, 9568.665096721581, 9684.0, 9715.562799674173, 9869.555869985725, 9149.085091490797, 9287.303452241244, 9328.160465558132, 9359.204467620057, 9641.180499657326, 8867.778305542413, 9615.326927115035, 9745.220382369534, 9917.65288214909, 10002.699919002442, 6457.967710161419, 6655.933440665725, 6734.696938637871, 6915.273896241023, 7037.7184912602925, 9687.66093186735, 9996.0, 10027.44849033281, 10169.745756356151, 10486.318389304672], "value": 8121.149250264709, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1365.18771331058, 1392.554382597569, 1501.8948673592854, 1679.0, 1704.7613334133232, 7463.66413511392, 7900.209979002097, 7949.880751788721, 7950.64222110005, 7952.324052455541, 6606.537542372036, 7482.925170748291, 7735.226477352276, 7749.535027898316, 7942.285194332523, 2205.162038425396, 2223.5775202711516, 2231.843770936035, 2233.218373569254, 2234.4078819112947, 1850.4448665400325, 2096.4863608415885, 2159.9892000539976, 2187.387531491185, 2230.096810791632, 2210.126999835064, 2250.1674380479244, 2250.8199344052437, 2252.1892118837204, 2253.402848245208, 2136.359092272312, 2137.4122116417952, 2189.386971647941, 2190.0582749417745, 2190.0692205812625, 2146.8389870759597, 2155.170259450123, 2155.956880862374, 2157.9784202157934, 2186.0709198590694, 7697.230276972258, 7818.960905195438, 7829.060512738451, 7833.216678332178, 7833.725819596287, 4515.2324104902245, 4651.697639653446, 4660.99788545461, 4663.51033141522, 4669.859904202845, 2787.818791778528, 2830.561263004238, 2881.150060732089, 2885.8845646174127, 2889.3643398452305, 918.678462538113, 931.1386967055514, 952.0099096939175, 958.7986522830214, 969.0, 10045.54795034218, 10398.06417422428, 10413.219008574311, 10646.78706425875, 10718.249722519427, 4020.2160578686876, 4038.212548553004, 4134.400511925754, 4143.854965076268, 4172.895677608023, 8245.257926786499, 8276.08963014068, 8278.793030174294, 8331.54176520285, 8339.8332033359, 4592.7933243004145, 4611.584957353854, 4615.723056616614, 4616.192166370872, 4617.168909596305, 4232.238197124486, 4269.0, 4269.743815371087, 4277.059047009653, 4293.527711951683, 3365.764396492222, 3400.914977125542, 3437.0719905625842, 3467.809270490097, 3468.0982944434627, 966.3042609321277, 1050.3435352904435, 1054.857594224785, 1068.6526878764278, 1094.3871431997948, 733.1129333506517, 763.744145711193, 767.6353731977266, 771.3366504805863, 810.5987536169633, 4889.828855990023, 4968.105740966661, 5059.848204553869, 5068.898622027539, 5181.06740786662, 828.1180542721982, 829.655692887457, 834.486790623762, 920.1074957291416, 969.1229437359201, 3194.4409728297455, 3359.5632567766033, 3384.2892992471366, 3413.9317213655586, 3532.752707310515, 9554.092361225812, 9773.267004974656, 9807.06832850878, 9859.753506162404, 9864.605415783288, 9737.221022318197, 9748.902510974942, 9757.170640495637, 9760.902390976, 9773.21814254858, 6752.3922846944015, 6884.208316043719, 6976.7209311627985, 6990.545614535141, 7004.754833580801, 5122.487751224997, 5135.563477104339, 5228.869278268074, 5245.659032162897, 5332.33345831771, 8872.556372181236, 8999.64001439935, 9074.546272686472, 9111.498867562083, 9114.407563508616, 8947.552622368725, 9042.864357034781, 9113.681021164228, 9274.95362523183, 9283.071692830663, 7452.0, 7578.280063393969, 7583.127940286938, 7589.241075892367, 7595.240475952582, 7469.066366704162, 7527.962360188164, 7530.322270995636, 7537.585432801248, 7539.246075392417, 6659.467242620675, 6921.89617155733, 6929.064576282138, 6955.930440695528, 7030.578165310098, 6766.086578311865, 6835.179778426621, 6929.411000065051, 6955.617441040589, 7004.0544526488275, 5786.479216870502, 5909.261342332208, 5957.582969192288, 5968.253968253968, 5988.850278743066, 4224.4930608327195, 4264.232438161161, 4414.205443020287, 4431.0694754102, 4464.754438505784, 4336.219480493542, 4350.760708161081, 4440.156370289635, 4495.955040449554, 4542.727436353697], "value": 4094.692369333543, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.2649136107897, 302.75023105937606, 307.97998130121533, 309.1143872804416, 311.05129355465823, 4990.426100998387, 4995.5762607656825, 5017.9498205017935, 5028.245763135532, 5039.798408063678, 4952.331435256239, 4955.380577427822, 4975.383000524835, 4989.476105008967, 4998.950010499894, 3694.20574576466, 3762.2851658184995, 3799.3731034379293, 3829.6744776694013, 3843.0968722350226, 3795.3737633290475, 3817.8854634361014, 3829.7893615851117, 3834.923301533968, 3840.231953609289, 3810.618938106181, 3811.5997820228754, 3812.5234345706785, 3813.2564149990762, 3822.73240873139, 3626.0, 3732.514773079496, 3846.365349717293, 3860.4209368594657, 3875.341191997339, 3425.2978139481347, 3428.194374322032, 3432.502287168347, 3434.4333185024443, 3447.207142357272, 4839.467658557556, 4841.49164337743, 4877.414710234759, 4880.41435027799, 4893.510648935114, 4179.373094035888, 4402.8679139625865, 4405.074934263808, 4449.17690227309, 4458.5318541553315, 5166.43169251382, 5196.58427325813, 5198.454162312941, 5207.4011488678525, 5209.817656382046, 3664.743467957244, 3664.8350824212976, 3673.522442082539, 3674.52231209941, 3686.299603075434, 5158.638895277332, 5414.377346605152, 5427.3215848019, 5471.316085489314, 5495.53287970523, 3696.1129328960856, 3718.4608231806237, 3719.497867787868, 3721.981390093032, 3736.8505259789304, 3798.25933942884, 3798.9240215196096, 3799.35410980134, 3802.334591446486, 3803.866864659779, 4354.760488173118, 4366.148601022834, 4379.364992076131, 4379.634997101593, 4380.824767009348, 5061.468545802712, 5156.767945442464, 5160.406553246425, 5162.561182299547, 5162.9415969726115, 1278.7762141625178, 1290.5741105435184, 1294.1587967820992, 1295.8185853980451, 1296.293520031585, 830.8296799156159, 841.7811369044092, 845.5053793530731, 869.3957699398984, 876.4916348517844, 4420.602145806893, 4425.734455932655, 4427.114577084531, 4427.424434823517, 4428.092241090569, 5160.664556803796, 5173.973225662954, 5216.791328346823, 5233.267342572043, 5259.368875734936, 4295.098029413795, 4428.800703968329, 4435.135148646047, 4444.1112527176465, 4448.799804008828, 2811.8049828823077, 2819.971800282012, 2832.872520736572, 2834.886604535837, 2836.4894319022774, 4880.82917097907, 4881.170201065827, 4884.511548845087, 4884.755762211947, 4892.926606100911, 5246.554042906319, 5361.597880159004, 5379.731013449312, 5397.2443857859935, 5409.862279877661, 4846.442659094249, 4852.636052296092, 4854.660173787872, 4871.756412179306, 4874.926876096862, 5178.0, 5221.895562088813, 5238.607104467104, 5241.554467870121, 5242.97378513105, 4957.504249575158, 5109.697027258026, 5118.616103792156, 5141.38303403594, 5151.793928242828, 4837.37114175155, 4859.514048595112, 4870.951290487192, 4872.610191184767, 4874.4409185178065, 3731.1418373774727, 3733.346664333785, 3733.477313176103, 3733.477313176103, 3752.6434988676033, 4960.206366981266, 5195.7142357169205, 5226.477352264743, 5252.65857719247, 5305.734713264398, 5027.170516864822, 5032.949670503248, 5053.84838454847, 5056.949430505795, 5059.316992206005, 4986.925196121989, 5071.594272458268, 5079.517445842639, 5083.364579427572, 5085.288059671723, 4815.783289752039, 4961.0, 4976.825811096594, 4978.502149784992, 4997.150484417731, 4949.950500494949, 4985.202367621163, 5152.510511501401, 5198.844034678966, 5201.505856943584, 5050.9747451263975, 5054.620903432331, 5066.189409694432, 5082.593392528663, 5084.872878178076], "value": 3856.3225565170674, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.4116065986551, 733.3949491669371, 740.3891789273847, 775.5966897213445, 776.0415886380321, 14292.857071429282, 14721.41114355427, 14959.925200373997, 14967.25163741814, 14998.250087495622, 14290.642733931656, 14379.209143497104, 14421.63945901353, 14505.927470362634, 14513.709725805504, 627.7332133843121, 762.0969151555424, 782.2451334462257, 802.9558374289412, 804.7263930263709, 804.6419343392192, 809.1463506001166, 811.5982588618613, 811.7402431222012, 812.0174588747623, 835.9791005224857, 836.3142223376833, 836.5273620404482, 836.7615229659548, 837.4347315562002, 654.8362909272682, 808.4744915804715, 826.6156237349661, 827.3009307135461, 829.3779665251062, 609.5550248318708, 609.8963176260046, 610.0239616613383, 610.124471383566, 610.5115907274163, 13323.26722030288, 13338.466461341535, 13355.465781368734, 13363.866361336457, 13367.665808354772, 12638.684032899158, 12965.805512917314, 13048.412821423059, 13163.0, 13500.594982150551, 10104.89895101047, 10349.9482502587, 10476.895231047669, 10528.578856845794, 10628.574857005711, 3228.370467758788, 3242.5946756655417, 3249.23642943908, 3271.7219036381935, 3316.535685004101, 67418.66290668564, 68141.65929170372, 68775.0, 69949.65025174893, 69968.30031699668, 10635.46822658864, 10671.466426678635, 10734.409607471507, 10746.570137194582, 10818.188635852342, 19146.0, 19322.130504127348, 19332.71000934987, 19345.51636209106, 19415.708764368545, 6654.800355989328, 6860.759873404407, 6924.619145947021, 6931.826704332432, 7003.614801185984, 3492.476128580733, 3613.385724426854, 3662.487251784752, 3712.5916149223563, 3738.5513738351574, 3050.3746731919905, 3083.1675447629013, 3153.3220357623222, 3158.3367492826305, 3160.683931606821, 499.5578912662247, 499.9525045120708, 508.659198337115, 521.413409913847, 523.3614989712545, 462.2188501432568, 507.860338406941, 548.2872266054113, 586.9054213891062, 595.9731812068468, 8032.0, 8232.17678232172, 8389.496630202208, 8413.621387037598, 8436.325093992466, 499.78509241026705, 501.1605560685837, 505.6612069913167, 563.7153237614979, 600.393602461517, 3752.212035472581, 4002.139539998856, 4032.2137183248983, 4111.301078816608, 4228.9788551057045, 77114.61442692751, 80400.19599803927, 81063.5946820274, 93344.0, 99360.503197485, 46107.30839037417, 73978.26021739822, 80073.59963200147, 83697.0, 84866.0, 46043.30935035977, 51957.74021129946, 65624.67187664127, 79999.60000199961, 81710.59144704239, 8590.14098590136, 8764.430312029697, 8903.821923561363, 8912.197902188835, 9039.0, 43449.0, 44006.779966099966, 44305.55694443014, 44608.0, 44665.55334446614, 62328.376716232255, 62434.68782656058, 62435.687821560605, 62500.68749656223, 62753.68623156855, 12019.939900300442, 12082.697932551757, 12671.513311629891, 12854.164479308814, 13028.934855325662, 12791.936040319739, 13278.468861245441, 13367.06430549891, 13442.731145377233, 13542.864571354161, 7419.925800741924, 11284.717882052686, 11864.525418983145, 12294.20087694297, 12410.317432541297, 12502.937485312515, 12743.299118548568, 12749.617511474671, 13095.541656042375, 13478.0, 10970.451477426257, 11028.834567481656, 11166.106711463226, 11319.773604527698, 11429.714257143638, 9935.552900119657, 10419.635312764018, 10666.36001839892, 10705.929407059231, 10954.342739435659, 9775.21798256152, 9996.650452188862, 10160.0, 10163.695089147337, 10163.7459063524], "value": 6626.961796830449, "unit": "score"}], "name": "dromaeo_css", "value": 6482.235252657113, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 113.0, 112.0, 113.0, 113.0, 112.0, 114.0, 113.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 122.0, 128.0, 179.0, 125.0, 124.0, 150.0, 123.0, 156.0, 130.0], "value": 138.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 160.0, 160.0, 162.0, 161.0, 161.0, 161.0, 159.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 120.0, 77.0, 80.0, 76.0, 75.0, 106.0, 75.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 121.0, 85.0, 85.0, 85.0, 119.0, 85.0, 85.0, 119.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 66.0, 63.0, 63.0, 64.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 66.0, 65.0, 65.0, 65.0, 67.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 81.0, 84.0, 78.0, 78.0, 79.0, 77.0, 78.0, 77.0, 81.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 128.0, 129.0, 131.0, 135.0, 136.0, 128.0, 211.0, 131.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 165.0, 168.0, 175.0, 168.0, 166.0, 169.0, 164.0, 167.0], "value": 167.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 67.0, 71.0, 66.0, 68.0, 66.0, 68.0, 68.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1530.5, "alertThreshold": 2.0}]} 12:40:05 INFO - Return code: 0 12:40:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:40:05 INFO - # TBPL SUCCESS # 12:40:05 INFO - Running post-action listener: _resource_record_post_action 12:40:05 INFO - ##### 12:40:05 INFO - ##### Finished run-tests step (success) 12:40:05 INFO - ##### 12:40:05 INFO - Running post-run listener: _resource_record_post_run 12:40:05 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 303439872; Read time: 12; Write time: 264220 12:40:05 INFO - TinderboxPrint: CPU usage
13.0% 12:40:05 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 12 12:40:05 INFO - TinderboxPrint: I/O write bytes / time
303,439,872 / 264,220 12:40:05 INFO - TinderboxPrint: CPU idle
8,335.1 (87.0%) 12:40:05 INFO - TinderboxPrint: CPU user
1,200.9 (12.5%) 12:40:05 INFO - TinderboxPrint: Swap in / out
0 / 0 12:40:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 20508672; Read time: 0; Write time: 6588 12:40:05 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282931200; Read time: 4; Write time: 257632 12:40:06 INFO - Running post-run listener: _upload_blobber_files 12:40:06 INFO - Blob upload gear active. 12:40:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:40:06 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 12:40:06 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'] 12:40:06 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 12:40:06 INFO - (blobuploader) - INFO - Open directory for files ... 12:40:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:40:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:40:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:07 INFO - (blobuploader) - INFO - Done attempting. 12:40:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:40:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:40:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:11 INFO - (blobuploader) - INFO - Done attempting. 12:40:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:40:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:40:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:12 INFO - (blobuploader) - INFO - Done attempting. 12:40:12 INFO - (blobuploader) - INFO - Iteration through files over. 12:40:12 INFO - Return code: 0 12:40:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:40:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:40:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0332ec138f1acadf64476cdf86fdae5c4218a28d21e36d53d58b51710ce094d830aba5ad75c87c35f577d514084439a5eacf80e3683abf546ea14d2dc4d58727", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/837d7e36688aa8bdd032df44abea19551927efe5c097adde9fff492d0b690620e33f7f201859cbcf597857796fdb3b24f0452e6af995e62269668c00529cac68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f0a203bed2cca842808b7ff181f2c3ee76d733810d22b0c0bb094995a1ba1e7764c11301bb1150dd5224019eb08013662f353eb9d4b67811d08becf453b46079"} 12:40:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:40:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:40:12 INFO - Contents: 12:40:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0332ec138f1acadf64476cdf86fdae5c4218a28d21e36d53d58b51710ce094d830aba5ad75c87c35f577d514084439a5eacf80e3683abf546ea14d2dc4d58727", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/837d7e36688aa8bdd032df44abea19551927efe5c097adde9fff492d0b690620e33f7f201859cbcf597857796fdb3b24f0452e6af995e62269668c00529cac68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f0a203bed2cca842808b7ff181f2c3ee76d733810d22b0c0bb094995a1ba1e7764c11301bb1150dd5224019eb08013662f353eb9d4b67811d08becf453b46079"} 12:40:12 INFO - Running post-run listener: copy_logs_to_upload_dir 12:40:12 INFO - Copying logs to upload dir... 12:40:12 INFO - mkdir: /builds/slave/test/build/upload/logs 12:40:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.712601 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-07-07 12:40:12.466014) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 12:40:12.473896) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475 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/0332ec138f1acadf64476cdf86fdae5c4218a28d21e36d53d58b51710ce094d830aba5ad75c87c35f577d514084439a5eacf80e3683abf546ea14d2dc4d58727", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/837d7e36688aa8bdd032df44abea19551927efe5c097adde9fff492d0b690620e33f7f201859cbcf597857796fdb3b24f0452e6af995e62269668c00529cac68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f0a203bed2cca842808b7ff181f2c3ee76d733810d22b0c0bb094995a1ba1e7764c11301bb1150dd5224019eb08013662f353eb9d4b67811d08becf453b46079"} build_url:https://queue.taskcluster.net/v1/task/YeZ2R27XSqugoF_vCS1kyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011362 build_url: 'https://queue.taskcluster.net/v1/task/YeZ2R27XSqugoF_vCS1kyQ/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/0332ec138f1acadf64476cdf86fdae5c4218a28d21e36d53d58b51710ce094d830aba5ad75c87c35f577d514084439a5eacf80e3683abf546ea14d2dc4d58727", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/837d7e36688aa8bdd032df44abea19551927efe5c097adde9fff492d0b690620e33f7f201859cbcf597857796fdb3b24f0452e6af995e62269668c00529cac68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f0a203bed2cca842808b7ff181f2c3ee76d733810d22b0c0bb094995a1ba1e7764c11301bb1150dd5224019eb08013662f353eb9d4b67811d08becf453b46079"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 12:40:12.500785) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 12:40:12.501101) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467919111.13672-1822249475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 12:40:12.584369) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 12:40:12.587727) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 12:40:12.588019) ========= ========= Total master_lag: 0.20 =========