builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1470960924.38 results: success (0) buildid: 20160811113001 builduid: 49ea46855e79432e99640c81f39478e5 revision: 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 17:15:24.382679) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 17:15:24.383192) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 17:15:24.383661) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 17:15:24.399840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 17:15:24.400157) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-11 17:15:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 212M=0s 2016-08-11 17:15:25 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109943 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 17:15:24.524521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 17:15:24.524857) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019570 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 17:15:24.576814) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 17:15:24.577214) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 --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 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-11 17:15:25,358 truncating revision to first 12 chars 2016-08-11 17:15:25,358 Setting DEBUG logging. 2016-08-11 17:15:25,358 attempt 1/10 2016-08-11 17:15:25,358 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9dae91a2c31d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 17:15:25,672 unpacking tar archive at: fx-team-9dae91a2c31d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628505 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 17:15:25.220087) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 17:15:25.220460) ========= script_repo_revision: 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 17:15:25.220899) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 17:15:25.221279) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 17:15:25.231805) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-08-11 17:15:25.232188) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:15:26 INFO - MultiFileLogger online at 20160811 17:15:26 in /builds/slave/test 17:15:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:15:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:15:26 INFO - {'append_to_log': False, 17:15:26 INFO - 'base_work_dir': '/builds/slave/test', 17:15:26 INFO - 'blob_upload_branch': 'Fx-Team', 17:15:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:15:26 INFO - 'branch': 'Fx-Team', 17:15:26 INFO - 'buildbot_json_path': 'buildprops.json', 17:15:26 INFO - 'config_files': ('talos/linux_config.py',), 17:15:26 INFO - 'default_actions': ('clobber', 17:15:26 INFO - 'read-buildbot-config', 17:15:26 INFO - 'download-and-extract', 17:15:26 INFO - 'populate-webroot', 17:15:26 INFO - 'create-virtualenv', 17:15:26 INFO - 'install', 17:15:26 INFO - 'run-tests'), 17:15:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:15:26 INFO - 'download_minidump_stackwalk': True, 17:15:26 INFO - 'download_symbols': 'ondemand', 17:15:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:15:26 INFO - 'tooltool.py': '/tools/tooltool.py', 17:15:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:15:26 INFO - '/tools/misc-python/virtualenv.py')}, 17:15:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:15:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:15:26 INFO - 'installer_path': 'installer.exe', 17:15:26 INFO - 'log_level': 'info', 17:15:26 INFO - 'log_name': 'talos', 17:15:26 INFO - 'log_to_console': True, 17:15:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:15:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:15:26 INFO - 'opt_config_files': (), 17:15:26 INFO - 'pip_index': False, 17:15:26 INFO - 'sps_profile': False, 17:15:26 INFO - 'sps_profile_interval': 0, 17:15:26 INFO - 'suite': 'dromaeojs-e10s', 17:15:26 INFO - 'system_bits': '32', 17:15:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:15:26 INFO - 'title': 'talos-linux64-ix-039', 17:15:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:15:26 INFO - 'use_talos_json': True, 17:15:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:15:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:15:26 INFO - 'work_dir': 'build'} 17:15:26 INFO - [mozharness: 2016-08-12 00:15:26.113230Z] Running clobber step. 17:15:26 INFO - Running pre-action listener: _resource_record_pre_action 17:15:26 INFO - Running main action method: clobber 17:15:26 INFO - rmtree: /builds/slave/test/build 17:15:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:15:26 INFO - Running post-action listener: _resource_record_post_action 17:15:26 INFO - [mozharness: 2016-08-12 00:15:26.567228Z] Finished clobber step (success) 17:15:26 INFO - [mozharness: 2016-08-12 00:15:26.567329Z] Running read-buildbot-config step. 17:15:26 INFO - Running pre-action listener: _resource_record_pre_action 17:15:26 INFO - Running main action method: read_buildbot_config 17:15:26 INFO - Using buildbot properties: 17:15:26 INFO - { 17:15:26 INFO - "project": "", 17:15:26 INFO - "product": "firefox", 17:15:26 INFO - "script_repo_revision": "production", 17:15:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:15:26 INFO - "repository": "", 17:15:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:15:26 INFO - "buildid": "20160811113001", 17:15:26 INFO - "pgo_build": "True", 17:15:26 INFO - "basedir": "/builds/slave/test", 17:15:26 INFO - "buildnumber": 667, 17:15:26 INFO - "slavename": "talos-linux64-ix-039", 17:15:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:15:26 INFO - "platform": "ubuntu64_hw", 17:15:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:15:26 INFO - "branch": "fx-team", 17:15:26 INFO - "repo_path": "integration/fx-team", 17:15:26 INFO - "revision": "9dae91a2c31d1d7ee1f426b4f61179a42e0dab64", 17:15:26 INFO - "stage_platform": "linux64-pgo", 17:15:26 INFO - "builduid": "49ea46855e79432e99640c81f39478e5", 17:15:26 INFO - "slavebuilddir": "test" 17:15:26 INFO - } 17:15:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 17:15:26 INFO - Running post-action listener: _resource_record_post_action 17:15:26 INFO - [mozharness: 2016-08-12 00:15:26.569781Z] Finished read-buildbot-config step (success) 17:15:26 INFO - [mozharness: 2016-08-12 00:15:26.569873Z] Running download-and-extract step. 17:15:26 INFO - Running pre-action listener: _resource_record_pre_action 17:15:26 INFO - Running main action method: download_and_extract 17:15:26 INFO - mkdir: /builds/slave/test/build/tests 17:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:26 INFO - trying https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:15:26 INFO - Downloading https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:15:27 INFO - Downloaded 1361 bytes. 17:15:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:15:27 INFO - Using the following test package requirements: 17:15:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:15:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:15:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:27 INFO - u'jsshell-linux-x86_64.zip'], 17:15:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:15:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:15:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:15:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:15:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:15:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:27 INFO - trying https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:15:27 INFO - Downloading https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:15:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:15:28 INFO - Downloaded 21833413 bytes. 17:15:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:15:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:15:29 INFO - Return code: 0 17:15:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:15:29 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:29 INFO - trying https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:15:29 INFO - Downloading https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:15:30 INFO - Downloaded 21833413 bytes. 17:15:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:15:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:15:31 INFO - Return code: 0 17:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:31 INFO - trying https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:31 INFO - Downloading https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:15:32 INFO - Downloaded 14413719 bytes. 17:15:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:15:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:15:32 INFO - Return code: 0 17:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:32 INFO - trying https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:15:32 INFO - Downloading https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:15:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:15:35 INFO - Downloaded 59339035 bytes. 17:15:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:15:35 INFO - mkdir: /builds/slave/test/properties 17:15:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:15:35 INFO - Writing to file /builds/slave/test/properties/build_url 17:15:35 INFO - Contents: 17:15:35 INFO - build_url:https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:15:36 INFO - Running post-action listener: _resource_record_post_action 17:15:36 INFO - Running post-action listener: set_extra_try_arguments 17:15:36 INFO - [mozharness: 2016-08-12 00:15:36.233834Z] Finished download-and-extract step (success) 17:15:36 INFO - [mozharness: 2016-08-12 00:15:36.234071Z] Running populate-webroot step. 17:15:36 INFO - Running pre-action listener: _resource_record_pre_action 17:15:36 INFO - Running main action method: populate_webroot 17:15:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:15:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:15:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:15:36 INFO - '--tppagecycles', 17:15:36 INFO - '7'], 17:15:36 INFO - 'tests': ['tsvgm']}}, 17:15:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:15:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:15:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:15:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:15:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:15:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:15:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:36 INFO - 'talos_options': ['--disable-e10s'], 17:15:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:36 INFO - 'talos_options': ['--disable-e10s'], 17:15:36 INFO - 'tests': ['damp', 'tps']}, 17:15:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:36 INFO - 'tests': ['damp', 'tps']}, 17:15:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:15:36 INFO - 'tests': ['dromaeo_dom']}, 17:15:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:15:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:15:36 INFO - 'tests': ['basic_compositor_video']}, 17:15:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:15:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:15:36 INFO - 'tests': ['a11yr', 17:15:36 INFO - 'ts_paint', 17:15:36 INFO - 'tpaint', 17:15:36 INFO - 'sessionrestore', 17:15:36 INFO - 'sessionrestore_no_auto_restore', 17:15:36 INFO - 'tabpaint']}, 17:15:36 INFO - 'other-e10s': {'tests': ['a11yr', 17:15:36 INFO - 'ts_paint', 17:15:36 INFO - 'tpaint', 17:15:36 INFO - 'sessionrestore', 17:15:36 INFO - 'sessionrestore_no_auto_restore', 17:15:36 INFO - 'tabpaint']}, 17:15:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:15:36 INFO - 'ts_paint', 17:15:36 INFO - 'tpaint', 17:15:36 INFO - 'sessionrestore', 17:15:36 INFO - 'sessionrestore_no_auto_restore', 17:15:36 INFO - 'tabpaint']}, 17:15:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:15:36 INFO - 'ts_paint', 17:15:36 INFO - 'tpaint', 17:15:36 INFO - 'sessionrestore', 17:15:36 INFO - 'sessionrestore_no_auto_restore', 17:15:36 INFO - 'tabpaint']}, 17:15:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:15:36 INFO - 'tests': ['a11yr', 17:15:36 INFO - 'ts_paint', 17:15:36 INFO - 'tpaint', 17:15:36 INFO - 'sessionrestore', 17:15:36 INFO - 'sessionrestore_no_auto_restore', 17:15:36 INFO - 'tabpaint']}, 17:15:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:15:36 INFO - 'tests': ['a11yr', 17:15:36 INFO - 'ts_paint', 17:15:36 INFO - 'tpaint', 17:15:36 INFO - 'sessionrestore', 17:15:36 INFO - 'sessionrestore_no_auto_restore', 17:15:36 INFO - 'tabpaint']}, 17:15:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:15:36 INFO - 'tests': ['tsvgx', 17:15:36 INFO - 'tsvgr_opacity', 17:15:36 INFO - 'tart', 17:15:36 INFO - 'tscrollx', 17:15:36 INFO - 'cart']}, 17:15:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:15:36 INFO - 'tsvgr_opacity', 17:15:36 INFO - 'tart', 17:15:36 INFO - 'tscrollx', 17:15:36 INFO - 'cart']}, 17:15:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:36 INFO - 'talos_options': ['--disable-e10s'], 17:15:36 INFO - 'tests': ['tp5o']}, 17:15:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:36 INFO - 'tests': ['tp5o']}, 17:15:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:36 INFO - 'talos_options': ['--disable-e10s', 17:15:36 INFO - '--xperf_path', 17:15:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:36 INFO - 'tests': ['tp5n']}, 17:15:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:36 INFO - 'talos_options': ['--xperf_path', 17:15:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:36 INFO - 'tests': ['tp5n']}}, 17:15:36 INFO - 'talos.zip': {'path': '', 17:15:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:15:36 INFO - Running post-action listener: _resource_record_post_action 17:15:36 INFO - [mozharness: 2016-08-12 00:15:36.252281Z] Finished populate-webroot step (success) 17:15:36 INFO - [mozharness: 2016-08-12 00:15:36.252370Z] Running create-virtualenv step. 17:15:36 INFO - Running pre-action listener: _resource_record_pre_action 17:15:36 INFO - Running main action method: create_virtualenv 17:15:36 INFO - Creating virtualenv /builds/slave/test/build/venv 17:15:36 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 17:15:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:15:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:15:36 INFO - Using real prefix '/usr' 17:15:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:15:36 INFO - Installing distribute.............................................................................................................................................................................................done. 17:15:38 INFO - Installing pip.................done. 17:15:38 INFO - Return code: 0 17:15:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c913b0>, '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 0x2c922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c92740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', '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 17:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:15:38 INFO - Using env: {'DISPLAY': ':0', 17:15:38 INFO - 'HOME': '/home/cltbld', 17:15:38 INFO - 'LANG': 'en_US.UTF-8', 17:15:38 INFO - 'LANGUAGE': 'en_US:en', 17:15:38 INFO - 'LOGNAME': 'cltbld', 17:15:38 INFO - 'MAIL': '/var/mail/cltbld', 17:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:38 INFO - 'MOZ_NO_REMOTE': '1', 17:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:38 INFO - 'NO_EM_RESTART': '1', 17:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:38 INFO - 'PWD': '/builds/slave/test', 17:15:38 INFO - 'SHELL': '/bin/bash', 17:15:38 INFO - 'SHLVL': '1', 17:15:38 INFO - 'TERM': 'linux', 17:15:38 INFO - 'TMOUT': '86400', 17:15:38 INFO - 'USER': 'cltbld', 17:15:38 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', 17:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:38 INFO - '_': '/tools/buildbot/bin/python'} 17:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:39 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 17:15:39 INFO - Cleaning up... 17:15:39 INFO - Return code: 0 17:15:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c913b0>, '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 0x2c922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c92740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', '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 17:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:15:39 INFO - Using env: {'DISPLAY': ':0', 17:15:39 INFO - 'HOME': '/home/cltbld', 17:15:39 INFO - 'LANG': 'en_US.UTF-8', 17:15:39 INFO - 'LANGUAGE': 'en_US:en', 17:15:39 INFO - 'LOGNAME': 'cltbld', 17:15:39 INFO - 'MAIL': '/var/mail/cltbld', 17:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:39 INFO - 'MOZ_NO_REMOTE': '1', 17:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:39 INFO - 'NO_EM_RESTART': '1', 17:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:39 INFO - 'PWD': '/builds/slave/test', 17:15:39 INFO - 'SHELL': '/bin/bash', 17:15:39 INFO - 'SHLVL': '1', 17:15:39 INFO - 'TERM': 'linux', 17:15:39 INFO - 'TMOUT': '86400', 17:15:39 INFO - 'USER': 'cltbld', 17:15:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', 17:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:39 INFO - '_': '/tools/buildbot/bin/python'} 17:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:39 INFO - Downloading/unpacking psutil>=3.1.1 17:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:15:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:41 INFO - Installing collected packages: psutil 17:15:41 INFO - Running setup.py install for psutil 17:15:41 INFO - building 'psutil._psutil_linux' extension 17:15:41 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 17:15:41 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 17:15:41 INFO - building 'psutil._psutil_posix' extension 17:15:41 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 17:15:41 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 17:15:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:41 INFO - Successfully installed psutil 17:15:41 INFO - Cleaning up... 17:15:41 INFO - Return code: 0 17:15:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:41 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 0x29d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c913b0>, '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 0x2c922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c92740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', '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 17:15:41 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 17:15:41 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 17:15:41 INFO - Using env: {'DISPLAY': ':0', 17:15:41 INFO - 'HOME': '/home/cltbld', 17:15:41 INFO - 'LANG': 'en_US.UTF-8', 17:15:41 INFO - 'LANGUAGE': 'en_US:en', 17:15:41 INFO - 'LOGNAME': 'cltbld', 17:15:41 INFO - 'MAIL': '/var/mail/cltbld', 17:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:41 INFO - 'MOZ_NO_REMOTE': '1', 17:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:41 INFO - 'NO_EM_RESTART': '1', 17:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:41 INFO - 'PWD': '/builds/slave/test', 17:15:41 INFO - 'SHELL': '/bin/bash', 17:15:41 INFO - 'SHLVL': '1', 17:15:41 INFO - 'TERM': 'linux', 17:15:41 INFO - 'TMOUT': '86400', 17:15:41 INFO - 'USER': 'cltbld', 17:15:41 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', 17:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:41 INFO - '_': '/tools/buildbot/bin/python'} 17:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:15:43 INFO - Installing collected packages: mozsystemmonitor 17:15:43 INFO - Running setup.py install for mozsystemmonitor 17:15:44 INFO - Successfully installed mozsystemmonitor 17:15:44 INFO - Cleaning up... 17:15:44 INFO - Return code: 0 17:15:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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', '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 0x29d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c913b0>, '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 0x2c922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c92740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', '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 17:15: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:15: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 jsonschema==2.5.1 17:15:44 INFO - Using env: {'DISPLAY': ':0', 17:15:44 INFO - 'HOME': '/home/cltbld', 17:15:44 INFO - 'LANG': 'en_US.UTF-8', 17:15:44 INFO - 'LANGUAGE': 'en_US:en', 17:15:44 INFO - 'LOGNAME': 'cltbld', 17:15:44 INFO - 'MAIL': '/var/mail/cltbld', 17:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:44 INFO - 'MOZ_NO_REMOTE': '1', 17:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:44 INFO - 'NO_EM_RESTART': '1', 17:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:44 INFO - 'PWD': '/builds/slave/test', 17:15:44 INFO - 'SHELL': '/bin/bash', 17:15:44 INFO - 'SHLVL': '1', 17:15:44 INFO - 'TERM': 'linux', 17:15:44 INFO - 'TMOUT': '86400', 17:15:44 INFO - 'USER': 'cltbld', 17:15:44 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', 17:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:44 INFO - '_': '/tools/buildbot/bin/python'} 17:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:44 INFO - Downloading/unpacking jsonschema==2.5.1 17:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:15:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:46 INFO - Downloading functools32-3.2.3-2.tar.gz 17:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:15:46 INFO - warning: no files found matching '*.txt' 17:15:46 INFO - no previously-included directories found matching 'build' 17:15:46 INFO - no previously-included directories found matching 'dist' 17:15:46 INFO - no previously-included directories found matching '.git*' 17:15:46 INFO - Installing collected packages: jsonschema, functools32 17:15:46 INFO - Running setup.py install for functools32 17:15:46 INFO - warning: no files found matching '*.txt' 17:15:46 INFO - no previously-included directories found matching 'build' 17:15:46 INFO - no previously-included directories found matching 'dist' 17:15:46 INFO - no previously-included directories found matching '.git*' 17:15:46 INFO - Successfully installed jsonschema functools32 17:15:46 INFO - Cleaning up... 17:15:46 INFO - Return code: 0 17:15:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:15:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:46 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c913b0>, '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 0x2c922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c92740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', '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 17:15:46 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:15:46 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 functools32==3.2.3-2 17:15:46 INFO - Using env: {'DISPLAY': ':0', 17:15:46 INFO - 'HOME': '/home/cltbld', 17:15:46 INFO - 'LANG': 'en_US.UTF-8', 17:15:46 INFO - 'LANGUAGE': 'en_US:en', 17:15:46 INFO - 'LOGNAME': 'cltbld', 17:15:46 INFO - 'MAIL': '/var/mail/cltbld', 17:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:46 INFO - 'MOZ_NO_REMOTE': '1', 17:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:46 INFO - 'NO_EM_RESTART': '1', 17:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:46 INFO - 'PWD': '/builds/slave/test', 17:15:46 INFO - 'SHELL': '/bin/bash', 17:15:46 INFO - 'SHLVL': '1', 17:15:46 INFO - 'TERM': 'linux', 17:15:46 INFO - 'TMOUT': '86400', 17:15:46 INFO - 'USER': 'cltbld', 17:15:46 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', 17:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:46 INFO - '_': '/tools/buildbot/bin/python'} 17:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:15:46 INFO - Cleaning up... 17:15:46 INFO - Return code: 0 17:15:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:15:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:46 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 0x29d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c913b0>, '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 0x2c922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c92740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', '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 17:15:46 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 17:15:46 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 17:15:46 INFO - Using env: {'DISPLAY': ':0', 17:15:46 INFO - 'HOME': '/home/cltbld', 17:15:46 INFO - 'LANG': 'en_US.UTF-8', 17:15:46 INFO - 'LANGUAGE': 'en_US:en', 17:15:46 INFO - 'LOGNAME': 'cltbld', 17:15:46 INFO - 'MAIL': '/var/mail/cltbld', 17:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:46 INFO - 'MOZ_NO_REMOTE': '1', 17:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:46 INFO - 'NO_EM_RESTART': '1', 17:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:46 INFO - 'PWD': '/builds/slave/test', 17:15:46 INFO - 'SHELL': '/bin/bash', 17:15:46 INFO - 'SHLVL': '1', 17:15:46 INFO - 'TERM': 'linux', 17:15:46 INFO - 'TMOUT': '86400', 17:15:46 INFO - 'USER': 'cltbld', 17:15:46 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', 17:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:46 INFO - '_': '/tools/buildbot/bin/python'} 17:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:47 INFO - Downloading/unpacking blobuploader==1.2.4 17:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:48 INFO - Downloading blobuploader-1.2.4.tar.gz 17:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:15:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:15:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:49 INFO - Downloading docopt-0.6.1.tar.gz 17:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:15:49 INFO - Installing collected packages: blobuploader, requests, docopt 17:15:49 INFO - Running setup.py install for blobuploader 17:15:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:15:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:15:49 INFO - Running setup.py install for requests 17:15:50 INFO - Running setup.py install for docopt 17:15:50 INFO - Successfully installed blobuploader requests docopt 17:15:50 INFO - Cleaning up... 17:15:50 INFO - Return code: 0 17:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:50 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 0x29d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c913b0>, '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 0x2c922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c92740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', '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 17:15:50 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 17:15:50 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 17:15:50 INFO - Using env: {'DISPLAY': ':0', 17:15:50 INFO - 'HOME': '/home/cltbld', 17:15:50 INFO - 'LANG': 'en_US.UTF-8', 17:15:50 INFO - 'LANGUAGE': 'en_US:en', 17:15:50 INFO - 'LOGNAME': 'cltbld', 17:15:50 INFO - 'MAIL': '/var/mail/cltbld', 17:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:50 INFO - 'MOZ_NO_REMOTE': '1', 17:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:50 INFO - 'NO_EM_RESTART': '1', 17:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:50 INFO - 'PWD': '/builds/slave/test', 17:15:50 INFO - 'SHELL': '/bin/bash', 17:15:50 INFO - 'SHLVL': '1', 17:15:50 INFO - 'TERM': 'linux', 17:15:50 INFO - 'TMOUT': '86400', 17:15:50 INFO - 'USER': 'cltbld', 17:15:50 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', 17:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:50 INFO - '_': '/tools/buildbot/bin/python'} 17:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:50 INFO - Running setup.py (path:/tmp/pip-kTTX9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:50 INFO - Running setup.py (path:/tmp/pip-a6u0iU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:50 INFO - Running setup.py (path:/tmp/pip-O2WSUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:50 INFO - Running setup.py (path:/tmp/pip-b0LdQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:50 INFO - Running setup.py (path:/tmp/pip-kz0jCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:50 INFO - Running setup.py (path:/tmp/pip-Xta39N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:51 INFO - Running setup.py (path:/tmp/pip-GkVUul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:51 INFO - Running setup.py (path:/tmp/pip-pbevIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:51 INFO - Running setup.py (path:/tmp/pip-OFWh8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:51 INFO - Running setup.py (path:/tmp/pip-73IXXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:51 INFO - Running setup.py (path:/tmp/pip-Uo03QZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:51 INFO - Running setup.py (path:/tmp/pip-lnSOxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:51 INFO - Running setup.py (path:/tmp/pip-_Epz4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:51 INFO - Running setup.py (path:/tmp/pip-27nXWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:51 INFO - Running setup.py (path:/tmp/pip-n9PwYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:51 INFO - Running setup.py (path:/tmp/pip-nbrDWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:51 INFO - Running setup.py (path:/tmp/pip-HeuuqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:15:51 INFO - Running setup.py install for manifestparser 17:15:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:15:51 INFO - Running setup.py install for mozcrash 17:15:52 INFO - Running setup.py install for mozdebug 17:15:52 INFO - Running setup.py install for mozdevice 17:15:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:15:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:15:52 INFO - Running setup.py install for mozfile 17:15:52 INFO - Running setup.py install for mozhttpd 17:15:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:15:52 INFO - Running setup.py install for mozinfo 17:15:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:15:52 INFO - Running setup.py install for mozInstall 17:15:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:15:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:15:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:15:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:15:52 INFO - Running setup.py install for mozleak 17:15:52 INFO - Running setup.py install for mozlog 17:15:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:15:52 INFO - Running setup.py install for moznetwork 17:15:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:15:52 INFO - Running setup.py install for mozprocess 17:15:53 INFO - Running setup.py install for mozprofile 17:15:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:15:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:15:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:15:53 INFO - Running setup.py install for mozrunner 17:15:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:15:53 INFO - Running setup.py install for mozscreenshot 17:15:53 INFO - Running setup.py install for moztest 17:15:53 INFO - Running setup.py install for mozversion 17:15:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:15:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:15:53 INFO - Cleaning up... 17:15:53 INFO - Return code: 0 17:15:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:53 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 0x29d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c913b0>, '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 0x2c922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c92740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', '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 17:15:53 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 17:15:53 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 17:15:53 INFO - Using env: {'DISPLAY': ':0', 17:15:53 INFO - 'HOME': '/home/cltbld', 17:15:53 INFO - 'LANG': 'en_US.UTF-8', 17:15:53 INFO - 'LANGUAGE': 'en_US:en', 17:15:53 INFO - 'LOGNAME': 'cltbld', 17:15:53 INFO - 'MAIL': '/var/mail/cltbld', 17:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:53 INFO - 'MOZ_NO_REMOTE': '1', 17:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:53 INFO - 'NO_EM_RESTART': '1', 17:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:53 INFO - 'PWD': '/builds/slave/test', 17:15:53 INFO - 'SHELL': '/bin/bash', 17:15:53 INFO - 'SHLVL': '1', 17:15:53 INFO - 'TERM': 'linux', 17:15:53 INFO - 'TMOUT': '86400', 17:15:53 INFO - 'USER': 'cltbld', 17:15:53 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', 17:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:53 INFO - '_': '/tools/buildbot/bin/python'} 17:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:53 INFO - Running setup.py (path:/tmp/pip-y2y1Wh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:53 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)) 17:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:53 INFO - Running setup.py (path:/tmp/pip-hmXFS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:53 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)) 17:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:53 INFO - Running setup.py (path:/tmp/pip-t5s7O5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:54 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)) 17:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:54 INFO - Running setup.py (path:/tmp/pip-80hXC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:54 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)) 17:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:54 INFO - Running setup.py (path:/tmp/pip-N26IHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:54 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)) 17:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:54 INFO - Running setup.py (path:/tmp/pip-tkcisT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:54 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)) 17:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:54 INFO - Running setup.py (path:/tmp/pip-nptzHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:54 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)) 17:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:54 INFO - Running setup.py (path:/tmp/pip-e4lloc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:54 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)) 17:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:54 INFO - Running setup.py (path:/tmp/pip-utA1Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:54 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)) 17:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:54 INFO - Running setup.py (path:/tmp/pip-d1w5h3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 17:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:54 INFO - Running setup.py (path:/tmp/pip-1V7ifd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:54 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)) 17:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:54 INFO - Running setup.py (path:/tmp/pip-bLptd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:54 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)) 17:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:54 INFO - Running setup.py (path:/tmp/pip-BFSaEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:54 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)) 17:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:54 INFO - Running setup.py (path:/tmp/pip-bHdhzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:54 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)) 17:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:54 INFO - Running setup.py (path:/tmp/pip-EwKZjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:54 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)) 17:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:54 INFO - Running setup.py (path:/tmp/pip-1iJrFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:54 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)) 17:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:54 INFO - Running setup.py (path:/tmp/pip-AdAKEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:55 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)) 17:15:55 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)) 17:15:55 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)) 17:15:55 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)) 17:15:55 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)) 17:15:55 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)) 17:15:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:15:55 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 17:15:55 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 17:15:55 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 17:15:55 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 17:15:55 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 17:15:55 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 17:15:56 INFO - Downloading blessings-1.6.tar.gz 17:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:15:57 INFO - Installing collected packages: blessings 17:15:57 INFO - Running setup.py install for blessings 17:15:57 INFO - Successfully installed blessings 17:15:57 INFO - Cleaning up... 17:15:57 INFO - Return code: 0 17:15:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:15:57 INFO - Reading from file tmpfile_stdout 17:15:57 INFO - Current package versions: 17:15:57 INFO - argparse == 1.2.1 17:15:57 INFO - blessings == 1.6 17:15:57 INFO - blobuploader == 1.2.4 17:15:57 INFO - docopt == 0.6.1 17:15:57 INFO - functools32 == 3.2.3-2 17:15:57 INFO - jsonschema == 2.5.1 17:15:57 INFO - manifestparser == 1.1 17:15:57 INFO - mozInstall == 1.12 17:15:57 INFO - mozcrash == 0.17 17:15:57 INFO - mozdebug == 0.1 17:15:57 INFO - mozdevice == 0.48 17:15:57 INFO - mozfile == 1.2 17:15:57 INFO - mozhttpd == 0.7 17:15:57 INFO - mozinfo == 0.9 17:15:57 INFO - mozleak == 0.1 17:15:57 INFO - mozlog == 3.3 17:15:57 INFO - moznetwork == 0.27 17:15:57 INFO - mozprocess == 0.23 17:15:57 INFO - mozprofile == 0.28 17:15:57 INFO - mozrunner == 6.12 17:15:57 INFO - mozscreenshot == 0.1 17:15:57 INFO - mozsystemmonitor == 0.3 17:15:57 INFO - moztest == 0.7 17:15:57 INFO - mozversion == 1.4 17:15:57 INFO - psutil == 3.1.1 17:15:57 INFO - requests == 1.2.3 17:15:57 INFO - wsgiref == 0.1.2 17:15:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:57 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 0x29d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c913b0>, '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 0x2c922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c92740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', '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 17:15:57 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 17:15:57 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 17:15:57 INFO - Using env: {'DISPLAY': ':0', 17:15:57 INFO - 'HOME': '/home/cltbld', 17:15:57 INFO - 'LANG': 'en_US.UTF-8', 17:15:57 INFO - 'LANGUAGE': 'en_US:en', 17:15:57 INFO - 'LOGNAME': 'cltbld', 17:15:57 INFO - 'MAIL': '/var/mail/cltbld', 17:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:57 INFO - 'MOZ_NO_REMOTE': '1', 17:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:57 INFO - 'NO_EM_RESTART': '1', 17:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:57 INFO - 'PWD': '/builds/slave/test', 17:15:57 INFO - 'SHELL': '/bin/bash', 17:15:57 INFO - 'SHLVL': '1', 17:15:57 INFO - 'TERM': 'linux', 17:15:57 INFO - 'TMOUT': '86400', 17:15:57 INFO - 'USER': 'cltbld', 17:15:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', 17:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:57 INFO - '_': '/tools/buildbot/bin/python'} 17:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:57 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)) 17:15:57 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)) 17:15:57 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)) 17:15:57 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)) 17:15:57 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)) 17:15:57 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)) 17:15:57 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)) 17:15:57 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)) 17:15:57 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)) 17:15:57 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)) 17:15:57 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)) 17:15:57 INFO - Cleaning up... 17:15:57 INFO - Return code: 0 17:15:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:57 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 0x29d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c913b0>, '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 0x2c922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c92740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', '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 17:15:57 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 17:15:57 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 17:15:57 INFO - Using env: {'DISPLAY': ':0', 17:15:57 INFO - 'HOME': '/home/cltbld', 17:15:57 INFO - 'LANG': 'en_US.UTF-8', 17:15:57 INFO - 'LANGUAGE': 'en_US:en', 17:15:57 INFO - 'LOGNAME': 'cltbld', 17:15:57 INFO - 'MAIL': '/var/mail/cltbld', 17:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:57 INFO - 'MOZ_NO_REMOTE': '1', 17:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:57 INFO - 'NO_EM_RESTART': '1', 17:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:57 INFO - 'PWD': '/builds/slave/test', 17:15:57 INFO - 'SHELL': '/bin/bash', 17:15:57 INFO - 'SHLVL': '1', 17:15:57 INFO - 'TERM': 'linux', 17:15:57 INFO - 'TMOUT': '86400', 17:15:57 INFO - 'USER': 'cltbld', 17:15:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', 17:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:57 INFO - '_': '/tools/buildbot/bin/python'} 17:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:15:57 INFO - Cleaning up... 17:15:57 INFO - Return code: 0 17:15:57 INFO - Running post-action listener: _resource_record_post_action 17:15:57 INFO - Running post-action listener: _start_resource_monitoring 17:15:57 INFO - Starting resource monitoring. 17:15:57 INFO - [mozharness: 2016-08-12 00:15:57.902474Z] Finished create-virtualenv step (success) 17:15:57 INFO - [mozharness: 2016-08-12 00:15:57.902960Z] Running install step. 17:15:57 INFO - Running pre-action listener: _resource_record_pre_action 17:15:57 INFO - Running main action method: install 17:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:15:58 INFO - Reading from file tmpfile_stdout 17:15:58 INFO - Detecting whether we're running mozinstall >=1.0... 17:15:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:15:58 INFO - Reading from file tmpfile_stdout 17:15:58 INFO - Output received: 17:15:58 INFO - Usage: mozinstall [options] installer 17:15:58 INFO - Options: 17:15:58 INFO - -h, --help show this help message and exit 17:15:58 INFO - -d DEST, --destination=DEST 17:15:58 INFO - Directory to install application into. [default: 17:15:58 INFO - "/builds/slave/test"] 17:15:58 INFO - --app=APP Application being installed. [default: firefox] 17:15:58 INFO - mkdir: /builds/slave/test/build/application 17:15:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:16:15 INFO - Reading from file tmpfile_stdout 17:16:15 INFO - Output received: 17:16:15 INFO - /builds/slave/test/build/application/firefox/firefox 17:16:15 INFO - Running post-action listener: _resource_record_post_action 17:16:15 INFO - [mozharness: 2016-08-12 00:16:15.170244Z] Finished install step (success) 17:16:15 INFO - [mozharness: 2016-08-12 00:16:15.170491Z] Running run-tests step. 17:16:15 INFO - Running pre-action listener: _resource_record_pre_action 17:16:15 INFO - Running main action method: run_tests 17:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:16:15 INFO - Python 2.7.3 17:16:15 INFO - Return code: 0 17:16:15 INFO - grabbing minidump binary from tooltool 17:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:15 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 0x2c913b0>, '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 0x2c922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c92740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:16:15 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 17:16:15 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 17:16:15 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 17:16:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:16:15 INFO - Return code: 0 17:16:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:16:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:16:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:16:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:16:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:16:15 INFO - Using env: {'DISPLAY': ':0', 17:16:15 INFO - 'HOME': '/home/cltbld', 17:16:15 INFO - 'LANG': 'en_US.UTF-8', 17:16:15 INFO - 'LANGUAGE': 'en_US:en', 17:16:15 INFO - 'LOGNAME': 'cltbld', 17:16:15 INFO - 'MAIL': '/var/mail/cltbld', 17:16:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:16:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:15 INFO - 'MOZ_NO_REMOTE': '1', 17:16:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:15 INFO - 'NO_EM_RESTART': '1', 17:16:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:15 INFO - 'PWD': '/builds/slave/test', 17:16:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:16:15 INFO - 'SHELL': '/bin/bash', 17:16:15 INFO - 'SHLVL': '1', 17:16:15 INFO - 'TERM': 'linux', 17:16:15 INFO - 'TMOUT': '86400', 17:16:15 INFO - 'USER': 'cltbld', 17:16:15 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783', 17:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:15 INFO - '_': '/tools/buildbot/bin/python'} 17:16:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:16:15 INFO - mozversion application_buildid: 20160811113001 17:16:15 INFO - mozversion application_changeset: 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 17:16:15 INFO - mozversion application_display_name: Nightly 17:16:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:16:15 INFO - mozversion application_name: Firefox 17:16:15 INFO - mozversion application_remotingname: firefox 17:16:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:16:15 INFO - mozversion application_vendor: Mozilla 17:16:15 INFO - mozversion application_version: 51.0a1 17:16:15 INFO - mozversion platform_buildid: 20160811113001 17:16:15 INFO - mozversion platform_changeset: 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 17:16:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:16:15 INFO - mozversion platform_version: 51.0a1 17:16:15 INFO - using testdate: 1470960975 17:16:15 INFO - actual date: 1470960975 17:16:15 INFO - starting webserver on 'localhost:37114' 17:16:15 INFO - SUITE-START | Running 2 tests 17:16:15 INFO - TEST-START | dromaeo_css 17:16:15 INFO - operating with platform_type : linux_ 17:16:15 INFO - Initialising browser for dromaeo_css test... 17:16:15 INFO - TEST-INFO | started process 18881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbfqd_F/profile http://localhost:37114/getInfo.html) 17:16:20 INFO - PROCESS | 18881 | __metrics Screen width/height:1600/1200 17:16:20 INFO - PROCESS | 18881 | colorDepth:24 17:16:20 INFO - PROCESS | 18881 | Browser inner width/height: 1024/697 17:16:20 INFO - PROCESS | 18881 | __metrics 17:16:20 ERROR - PROCESS | 18881 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 17:16:21 INFO - TEST-INFO | 18881: exit 0 17:16:21 INFO - Browser initialized. 17:16:21 INFO - Running cycle 1/1 for dromaeo_css test... 17:16:21 INFO - TEST-INFO | started process 19002 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbfqd_F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:33 INFO - PROCESS | 19002 | RSS: Main: 163155968 17:16:33 INFO - PROCESS | 19002 | 17:17:23 INFO - PROCESS | 19002 | 1470961043174 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] 17:19:32 INFO - PROCESS | 19002 | Cycle 1(1): loaded http://localhost:37114/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37114/tests/dromaeo/cssquery-ext.html) 17:19:33 INFO - PROCESS | 19002 | RSS: Main: 166330368 17:19:33 INFO - PROCESS | 19002 | 17:22:36 INFO - PROCESS | 19002 | Cycle 1(1): loaded http://localhost:37114/tests/dromaeo/cssquery-ext.html (next: http://localhost:37114/tests/dromaeo/cssquery-jquery.html) 17:22:36 INFO - PROCESS | 19002 | RSS: Main: 165617664 17:22:36 INFO - PROCESS | 19002 | 17:25:38 INFO - PROCESS | 19002 | Cycle 1(1): loaded http://localhost:37114/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37114/tests/dromaeo/cssquery-mootools.html) 17:25:39 INFO - PROCESS | 19002 | RSS: Main: 169562112 17:25:39 INFO - PROCESS | 19002 | 17:28:41 INFO - PROCESS | 19002 | Cycle 1(1): loaded http://localhost:37114/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37114/tests/dromaeo/cssquery-prototype.html) 17:28:41 INFO - PROCESS | 19002 | RSS: Main: 163799040 17:28:41 INFO - PROCESS | 19002 | 17:31:44 INFO - PROCESS | 19002 | Cycle 1(1): loaded http://localhost:37114/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37114/tests/dromaeo/cssquery-yui.html) 17:31:44 INFO - PROCESS | 19002 | RSS: Main: 166064128 17:31:44 INFO - PROCESS | 19002 | 17:34:47 INFO - PROCESS | 19002 | Cycle 1(1): loaded http://localhost:37114/tests/dromaeo/cssquery-yui.html (next: http://localhost:37114/tests/dromaeo/cssquery-dojo.html) 17:34:47 INFO - PROCESS | 19002 | RSS: Main: 169697280 17:34:47 INFO - PROCESS | 19002 | 17:34:47 INFO - PROCESS | 19002 | __start_tp_report 17:34:47 INFO - PROCESS | 19002 | _x_x_mozilla_page_load 17:34:47 INFO - PROCESS | 19002 | _x_x_mozilla_page_load_details 17:34:47 INFO - PROCESS | 19002 | |i|pagename|runs| 17:34:47 INFO - PROCESS | 19002 | |0;dojo.html;3110.0980715592477;3153.3693261347735;3185.076327864919;3187.3625274945016;3196.648368679445;5346.759395827187;5488.2865227520415;5490.56075513959;5547.639403438784;5551.417101204376;5387.703676297802;5423.484768946943;5469.945300546993;5475.698836563987;5485.067538518451;4893.0213957208525;4951.653384263103;4953.529414705597;4982.57648099912;4993.151164302078;5011.248312753098;5016.2224855147515;5105.974470127644;5121.769520371592;5125.513076257749;4971.925421118686;4979.004199160183;5026.97486512567;5032.094223039851;5088.92366614501;4868.123737727207;4876.122297986361;4906.730129842857;4927.260910863363;4983.900321993576;4864.027194561102;4871.780769865364;4886.047220791947;4889.863905736609;4924.9507504925205;5290.39160496544;5369.382521010095;5373.408925018245;5374.435684253136;5380.973095134538;5734.827955161351;5795.594308398372;5805.187273781674;5850.414958504158;5851.268591426072;5780.653160810322;5825.242718446617;5826.941730582682;5843.240378750777;5844.123381492767;5286.36563612369;5344.679319240858;5417.837464876021;5420.810271640513;5423.376311724123;5851.473367396955;5941.494972927263;5956.13636022783;5991.011483105326;5998.400159984054;5699.658020518782;5700.116481945305;5712.542996560265;5716.171155182476;5725.656460612377;5568.749406276646;5747.1379293106365;5791.362950075489;5804.622699524517;5807.970960145172;5583.162525621108;5692.743826527816;5807.912881306784;5929.52563794904;5932.7330270137945;5695.316562012502;5753.539716822645;5806.390329015392;5823.708814559255;5868.853278667982;4414.426124603845;4421.42521472213;4422.778861056934;4435.955640443554;4457.175422546839;3907.8241479133508;3936.9212615748097;3938;3974.880753577397;3993.381025940984;5559.972200138974;5569.916451253234;5606.6636001840025;5672.716364181774;5676.517496012885;5900.763969441175;5904.996150654399;5910.645361278251;5919.378465261172;5921.437463440966;5440.211169380417;5506.614536982373;5548.4451554845;5609.915851262234;5616.241807356037;5072.923906141411;5073.1122053640465;5076.060928728197;5099.69401835891;5117.130087885069;6101;6103.786367477117;6104.969475152596;6107.4197951194565;6111.54163437744;5669.773209071591;5726.541876649775;5775.960327141155;5865.208196893535;5892.734826932712;6078.878422431439;6088.786892458743;6113.205283313318;6116.938830611637;6133.325334213144;5711.828645140652;5752.654840709571;5756.827295181151;5757.107648314518;5765.250517432707;5685.971570142123;5738.053221218619;5762.510186634183;5855.3266374367495;5859.150423188699;5697.003024470784;5709;5711.428857114255;5744.224529688438;5757.078867381367;5635.746391412478;5657.575681823797;5664.49019588239;5667.8866422672145;5683.744231509675;5444.346678398618;5655.264815573949;5663.7451314690115;5678.20505129274;5730.570207234391;5804.332501762183;5818.156367326629;5835.2122463466885;5868.3251426086545;5882.852928676817;5589.888202236014;5647.068233741386;5669.943300566942;5706.600537962303;5707.486326230659 17:34:47 INFO - PROCESS | 19002 | |1;ext.html;542.3503694070117;580.8402689260453;581.8109114537775;596.1862058290434;633.3286716080958;39218.41172382413;42942.355864662015;43162;43208.56791432085;43312.3503147453;44191.33712994299;44710.552894471046;44760.10479790402;44805.77597112018;44961.775191124;8790.64837406503;8918.375713700043;8937.77655558613;8937.865932010993;8940.597673104727;8768.517731524764;8811.11888811117;8900.109989001114;8918.108189181063;8921.732348029569;8931.41945773526;8951.41815781972;8977.640894364218;8983.19151276385;9001.244757272334;8863.423877447978;8908.064653211384;8911.598978046004;8914.108589141066;8914.687985920527;8786.209241168262;8843.336749743796;8851.424657397312;8858.247049000842;8884.777880552972;42662.78668606668;43076;43170;43198.78400608008;43207.783961080306;3491.9650803491895;3777.8677746279022;4010.9398359024344;4065.2276067547073;4279.550647182032;33676.15809604755;34005;34100.48849267263;34222;34755.30489390198;4240.703150779446;4245.702800803945;4341.522432532419;4384.364267181241;4540.296254080623;365397;366468;368058.1597092024;368620;371167;58444.70777646085;58906.41093589095;58946.70526647339;58981.41018589845;59014.70492647509;37155.442668359996;37578.812105939294;37990.62009379871;39536.60463395329;39671.60328396737;17874.374396896048;18207.45377638673;18244.361447349544;18248.087595620433;18258.45224643263;12892.419841107172;12980.286084265455;13012.674683132807;13078.869211307765;13108.082434229704;19424.514387140436;19493.610127797365;19595.60808783816;19731;19806.70289945652;7080.398166155935;7175.246599107123;7292.161401438796;7312.268773122645;7480.251974802476;946.6592026870321;969.3699095587924;1059.3590877519143;1070.8875568065241;1089.1810676170815;32198.356032879212;33953.32093358119;34244.657553424644;34505.13737156541;35045.64954350424;1112.6439539347493;1115.570505355444;1129.8079326514348;1173.5188572685329;1194.3908606610692;16291.266892989845;17605.119744012747;17848.839825411305;17966.281348745903;18146.274149034154;589505;594905;596774;597296;601292;61728.69135654383;62134.37865621376;62196.37803621996;62275.688621556605;62706.0594091089;1368.589423173044;1389.5900709290784;1412.1950488221821;1413.4063693248654;1417.0859795431888;32783.34433311273;34866.059168643114;35188.94433167009;35518.822405887804;35642.46536302009;53419.19871202013;57174.14238786339;59011.40988590059;59222.40777592169;63572.68213658902;527561;533495;533638;533653;534930;42983;43127.56872431361;43581.56418435902;43932.341014884165;46998.53001470078;50801.23798143105;51198.48801512086;51697;51824;51910;42512.57487425086;42687.786561067;43540.12919741651;44102;45412.54587454083;42688.14623707446;43220;43805;44528;44920.55079449164;38114.047148821504;42877;43202.35196472118;44465.33302000408;46761.53238467572;36270.274594507435;38560.42159367556;38994.80502597469;39204.2159156821;39635.60364396319;29459.55810662799;29637.407251855275;29943.85028074846;29991.70008299889;30114.397712046073 17:34:47 INFO - PROCESS | 19002 | |2;jquery.html;376.46541910487105;387.70921808643516;399.85605182134424;400.8116185392866;415.1033767063144;18684.90657546712;20072.397828065146;20707.792922070774;20752.48118797029;20858.687119693215;18956.763347792177;19295.421137365865;20166.798332016675;20297.39107826764;20344.593108137866;5544.972275138619;5650.208970744099;5786.56600754943;5834.6790926499025;5925.585209035369;5867.11993201019;5908.202392676976;5916.852078698045;5918.319393269764;5943;5899.970500147493;5930.258717660293;5974.731137098819;6047.3650266722025;6068.908966365508;5481.397046324901;5712.371639119693;5739.081746920494;5822.097574875901;5836.241288632451;5552.944470555283;5643.209950606918;5753.769849206069;5763.1355296705415;5782.855428614276;14192.716145677132;14348.852091832629;14498.42006319746;23936.640950385758;24129.276121716375;2322.5238826040622;2350.247920665388;2372.9525409491885;2679.2364176209685;2683.892644294226;10329.070383665507;10520.210984176218;10528.315659482185;10626.681199564026;10643.254972151875;1917.51103468616;1920.1071501751612;1953.5506833428249;1997.1455190596025;2009.9347345906692;86704;87411.56294218489;88169;90123;90485;9537.570809313598;9556.283278754121;9601.663941762145;9738.415695058318;9850.50747462624;15530;15549.455769048029;15586.142762147963;15588;15642.530724078295;7718.884216736754;7861.174576669482;7941.086775020831;8014.959925200336;8088.514689118554;7222.602756848424;7246.963765181245;7405;7453.85092298151;7561.697532098655;4545.204589196877;4726.054789042205;4747.905041899212;4752.263399173134;4827.08285425768;1925.9037048147536;1967.928939222486;2002.0490267123291;2024.665930121543;2032.1871251499224;938.5541867612966;951.8667386565886;975.8487434447673;999.5002498750624;1006.6728313298207;20134.597308053755;20430.897845510677;20712.792872071088;20825.18859953887;20895.37313880586;996.3473924579412;1021.6934919524113;1057.5505410200633;1069.2354966199205;1070.202698989258;10441.477926103817;11572.305661660328;11592.420378981018;11606;11609.071274298036;488878;492376;495448;503180;522689;55257.44742552523;94989;95122.524387379;98186.50906745564;99403.50298248607;1015.2639336480992;1025.5282570017876;1051.673981065872;1052.6947185316174;1058.2327812336148;17195.312187512358;17733.73399398984;18727.71908421402;19009.239630414628;19525.902370488056;36798;43822.85773989809;44524.332135018645;44579.331310029724;45810.54189458063;55352.16971745508;56799;59298.40173174779;61631.07553386613;61970;8521.701740439055;8629;8640.438371505832;8661.566921654017;8845.380823342304;9491.145796878314;11262;11281.71795705114;13095;13306.201627902357;11681.88318116808;11831.40842957866;12113.69715757113;12579.182353147016;12616.17994830333;11856.110791690486;11857.466414011218;12172.57395991136;12176.634700958986;12543.87456125427;11687.88312116868;12084.75830483403;12127.636170914533;12185.086118540967;12323.815142773044;8553.101924297858;8578.270846977826;8583.313334933315;8830.337724670548;8850.424722393023;9909.851352229578;10161.390316581028;11077.169212308949;11857.288562686266;11975.341356225492 17:34:47 INFO - PROCESS | 19002 | |3;mootools.html;1508.0951429142515;1521.1405555860938;1661.7424299233614;1724.862011039117;1810.7555480010203;8144.06343270524;8591;8763.386562940597;9534.95232523838;9535.475548844819;8515.276201522862;8885.111488851111;8899.288056955444;8899.466032038083;8900.955495222532;2373.6914201153827;2426.5268272686744;2427.854328740272;2432.1852179519883;2444.926652200437;2348.776866197717;2405.386626410263;2425.19968410425;2426.6360045993065;2441.072392490851;2425.1027119965547;2427.2718184544656;2433.5497932882386;2456.8771561421945;2483.192962287264;2393.377721792338;2416;2421.9757802421927;2422.297533715238;2443.4135807406096;2308.3998160478395;2359.917402890908;2362.1378196957985;2362.7400985891536;2375.4892698069825;9199.632014719404;9265.814683706289;9280.35037547372;9294.117058879396;9316.534173291308;5309.548688361494;5420.34955805302;5442.510174084351;5454.699991500466;5457.918131228034;3457.17027913299;3490.616032236452;3502.8949131526097;3595.982020089883;3606.981965090184;1102.079763397556;1115.5928086248541;1116.179607988128;1120.9551617935272;1132.88104749001;12795.296258705768;12976.35118244084;13004.544840930617;13074.084814062924;13102;4413.757243351646;4625.514320996314;4719.598834099072;4764.784375265518;4824.614030877521;10927.289726167774;10941.23411361197;10959.50682219302;10961.506732197071;10992.505337259843;5345.3852806926925;5356.437574054746;5368.785248590013;5397.4062853086125;5401.783928642889;4363.19280933022;4931.3589233399425;4937.703737775745;5034.395872495324;5034.924476132861;4118.842659014854;4163.770992595376;4171.749695018309;4178.05993651426;4209.6000879916355;1318.2024874950516;1343.5096189890814;1353.9729205415836;1363.9113457625222;1372.389286767399;863.5552690364467;979.0796651147898;987.3088837813559;993.3344659078434;1005.6228914157191;5901.144334071536;5932.436418540232;5951.5833891628035;5982.0727787193055;6047.516198704093;452.91168222196353;465.12788521522145;469.1695698613435;472.091224393042;483.7653737937098;4095.508538975342;4125.711200215956;4140.668746500272;4179.414881916534;4207.810648520824;11252.099832013419;11426;11484.885151148548;11524.59663911759;11537.307761534335;11382.886171138349;11444.656660300205;11446.885531144748;11480.081593472501;11487.655370338904;8110.878336824952;8427.199416055464;8437.662493500315;8524.232819046192;8615.267702245379;5955.464008239279;5983.0380870233375;6104.816855494342;6144.109104179958;6178.62928224308;10079.596816127272;10117.59529618807;10300.793984120426;10317.226208034277;10356.896431035895;10225.130863876653;10235.795284094425;10249.897501024894;10397.84403233937;10469.371837689763;7367;8014.479058861389;8150.144234855255;8358.247757701836;8457.281131103926;9057;9145.405548639317;9151.405158664666;9165.312601554777;9176.908230917872;7947.8807817881625;8096.311813495919;8133.349332053303;8218.63016164262;8400.579971001547;7973.760787176394;8018;8099.230573095547;8235.917640823754;8320.70877519284;7439.590822504598;7470.3276705096805;7542.773716788505;7559.848803024019;7575.810604734926;5378.489043540857;5397.541208997122;5405.675659460445;5511.118221084607;5556.805511807067;5319.734013299397;5398.163284690879;5460.235567020541;5527.419620939904;5569.66582005081 17:34:47 INFO - PROCESS | 19002 | |4;prototype.html;316.140098930908;325.4613614468055;330.2766940400523;335.0868882295744;337.9797212167269;5485.232067510552;5510.393856675768;5515.172724091388;5533.652140455027;5585.329760428749;5430.83707488776;5442.612133905858;5459.153831156177;5460.426655201206;5483.917741233885;4296.57034296571;4331.112122014987;4339.218940590692;4357;4366.148601022802;3912.941305880414;3948.492707130964;4286.578083382894;4296.291111966521;4334.393184954093;4234.92009537569;4241.851535196269;4243.299855523835;4257.446531950842;4289.935650965238;4283.100548884722;4289.978550107261;4304.665553678338;4311.310190369526;4314.288142456475;3746.38184699527;3748.9437658435145;3800.9619903801163;3818.3581060144406;3829.80850957451;5307.469253074701;5319.20211968204;5321.122014867542;5342.252084708144;5347.491988261109;4813.951860481386;4852.854414367539;4854.708717476963;4863.513648635108;4883.902321953577;5475.616706830523;5670.6030577859565;5676.687782171979;5680.289963754531;5777.45114214149;4098.159877225162;4102.733322334038;4110.630043296088;4118.5263694675195;4144.564820693844;5675.2054712340305;5803.535717142577;5957.1957785698805;5969.373215812364;5985.281766188085;4205.36919462077;4220.957790422118;4230.957690423118;4244.087521182961;4247.4265974093105;4263.936040959388;4305.720128191658;4306.720063195882;4316.0720445103825;4323.675724320626;4522.3442600823355;4889.511048895153;4897.7795999180125;4915.557599816034;4922.360093187935;5688.146777983253;5689.80514092037;5702.914456283159;5742.253507044057;5757.913631295534;1434.634168287101;1437.2238990944982;1449.3188201545256;1453.5972786261098;1454.3092031285055;871.4205053639259;919.1635611593551;920.3787443475627;923.1091996223677;936.0031566381917;4795.904081918342;4811.879703007453;4842.709437433765;4844.4186697596515;4914.852554423302;5234.691327168208;5237.2766161595755;5238.6594871334;5270.420253772082;5286.47135286476;4792.664513484093;4860.3195552622665;4913.361263035782;4938.481459446778;4975.825846095369;2709.5122877882172;2728.1133631569423;2740.945181096367;2751.876165572554;2755.6279902213346;5382.327209098863;5403.351597808288;5432;5492.203630473559;5534.308211473566;5097.260897169889;5127.871868188992;5254.7635356409055;5262.026954770542;5355.625106242525;5334.5732341412595;5351.464853514617;5408.810691625774;5436.689407002008;5470.425605311385;5125.71905502063;5140.43455219918;5199.610029247897;5226.346706661668;5229.660072095302;4999.225275027458;5184.148718204897;5189.247559103985;5209.557187639093;5225.118957175489;5432.266644003167;5909.468147866713;6057.273127224761;6163.537734669828;6165.0444181152;4155.605217504332;4189.853355132555;4203.4115223868075;4206.432131662186;4218.873433796991;5741;5970.820875373745;5990.974557848259;6000.759969601341;6009.188759517409;5733.655980641175;5747.770089196385;5761.337446193741;5777.688924430262;5814.825555233349;5743.368229494836;5743.4256574342235;5771.047777116896;5783.103618939072;5811.360750317546;5532.557395408277;5671.574631902707;5705.4009329019855;5803.883922321615;5818.4763371296785;5873.588848780715;5906.379830117948;5911.674857882857;5916.467517923407;5983.132445795248;5548.529639645417;5699.458551437607;5760.971195143998;5802.419758024333;5810.360860305447 17:34:47 INFO - PROCESS | 19002 | |5;yui.html;640.6124294801645;678.6165816313783;709.3792931185213;740.4187712645574;782.8160382310158;16358.754618680714;16978.40575579855;17033.574160645974;17055.232514536845;17081.23134458949;15077.924610376933;15144;15145.469908553203;15207.087574745496;15272.847271527282;801.3509057663282;827.065416079829;828.7969447485375;831.6548632317612;835.7952301686096;648.4164252173035;796.2793671727068;821.0885916632562;823.9382046346518;823.9629216685264;857.4683696108422;874.899386570543;877.394597727566;879.0813599788237;879.5118709116438;866.1944391715701;866.7096522664851;866.8439680857443;867.9913200867974;869.9951555952853;641.1216633212482;641.3746597067822;641.4932203559183;642.4410762636536;644.5584774429531;15690.450834220861;15936.840631593652;15966.361345546164;15975.760363594556;15987.44043958456;15234.390624375012;15722.213889305489;15772.211389430597;15849.920750396173;15967.281472333772;12520.612778677294;12666.240025598494;12701.745965080647;12727.045471589669;13068.411921463461;3581.197472212701;3740.4763333133383;3764.849406023756;3775.452559378875;3817.560980487224;77536.61231693861;77551.61224193899;77563.61218193985;78688.60655696742;78773;11004.339739615649;11271.774564508663;11297.830532542019;11476.770464590662;11639.127065470124;18258.543536411697;18362.265509379744;18376.264949401873;18381;18392;8180.550069746221;8194.426390152632;8261.421700480909;8349.248567628943;8436.578171091422;4160.708750387505;4283.233265518744;4325.935110973338;4346.261135606955;4356.150550642657;3426.880059197916;3552.0587044433246;3566.0728210665416;3579.463080537888;3587;653.7123665587127;658.7990662847782;661.8180000499805;668.1014036121409;673.8618583190434;591.7603370634899;659.7031335898864;668.3383450384182;694.5034300475185;707.5259576084036;9623.63172889497;10396.48017599132;10735.463226838627;10946.56213751457;11239;651.2608189704624;664.2095905871997;702.3924305475829;709.4289097276742;720.8594324106749;4595.954040459619;5186.118359878829;5188.45521220274;5215.16557350822;5253;65912;65956.67021664957;66012;66186.66906665532;125509;107240;107300;108343;110510;116163;56873.715631421575;87298;88927.55536222277;91464;92024;8874.423162494417;9323.393979391318;9539.14147726708;9599.47202903819;9612.134907858326;38187.80906095563;52035.73982130065;54332.45667543274;55060.72469637626;55423.16865247105;52749.472505274454;61176.694116529135;63631.68184159049;66250.66874665595;76014.6199269;12309.815352769894;12763.744725105631;12980.870191297967;13236.801447978096;13665.726685466434;14400.495982640976;14429.711405771615;14510.85489145095;14661.85338146605;15343.693126137192;13579.110286104054;13781.310934453037;14213.644658883197;14586.781198281822;14651.487197948021;13234.470621175045;13643;13664.248466334448;14367.353469093707;14757.92621036888;14769.92615036918;14870.77693834615;15133.319000644777;15203.847961520243;15633.843661563693;10567.841482377924;10893.945530272615;11088.778224435628;11105.333679979227;11388.601398950997;9935.552900119368;11318.717032073935;11604.535818567163;11615.6515304541;11993.220440671328 17:34:47 INFO - PROCESS | 19002 | __end_tp_report 17:34:47 INFO - PROCESS | 19002 | __start_cc_report 17:34:47 INFO - PROCESS | 19002 | _x_x_mozilla_cycle_collect,332 17:34:47 INFO - PROCESS | 19002 | __end_cc_report 17:34:47 INFO - PROCESS | 19002 | __startTimestamp1470962087824__endTimestamp 17:34:47 INFO - PROCESS | 19002 | 17:34:47 INFO - PROCESS | 19002 | ------- Summary: start ------- 17:34:47 INFO - PROCESS | 19002 | Number of tests: 6 17:34:47 INFO - PROCESS | 19002 | 17:34:47 INFO - PROCESS | 19002 | [#0] dojo.html Cycles:165 Average:5421.02 Median:5664.49 stddev:618.85 (10.9%) stddev-sans-first:593.60 17:34:47 INFO - PROCESS | 19002 | Values: 3110.1 3153.4 3185.1 3187.4 3196.6 5346.8 5488.3 5490.6 5547.6 5551.4 5387.7 5423.5 5469.9 5475.7 5485.1 4893.0 4951.7 4953.5 4982.6 4993.2 5011.2 5016.2 5106.0 5121.8 5125.5 4971.9 4979.0 5027.0 5032.1 5088.9 4868.1 4876.1 4906.7 4927.3 4983.9 4864.0 4871.8 4886.0 4889.9 4925.0 5290.4 5369.4 5373.4 5374.4 5381.0 5734.8 5795.6 5805.2 5850.4 5851.3 5780.7 5825.2 5826.9 5843.2 5844.1 5286.4 5344.7 5417.8 5420.8 5423.4 5851.5 5941.5 5956.1 5991.0 5998.4 5699.7 5700.1 5712.5 5716.2 5725.7 5568.7 5747.1 5791.4 5804.6 5808.0 5583.2 5692.7 5807.9 5929.5 5932.7 5695.3 5753.5 5806.4 5823.7 5868.9 4414.4 4421.4 4422.8 4436.0 4457.2 3907.8 3936.9 3938.0 3974.9 3993.4 5560.0 5569.9 5606.7 5672.7 5676.5 5900.8 5905.0 5910.6 5919.4 5921.4 5440.2 5506.6 5548.4 5609.9 5616.2 5072.9 5073.1 5076.1 5099.7 5117.1 6101.0 6103.8 6105.0 6107.4 6111.5 5669.8 5726.5 5776.0 5865.2 5892.7 6078.9 6088.8 6113.2 6116.9 6133.3 5711.8 5752.7 5756.8 5757.1 5765.3 5686.0 5738.1 5762.5 5855.3 5859.2 5697.0 5709.0 5711.4 5744.2 5757.1 5635.7 5657.6 5664.5 5667.9 5683.7 5444.3 5655.3 5663.7 5678.2 5730.6 5804.3 5818.2 5835.2 5868.3 5882.9 5589.9 5647.1 5669.9 5706.6 5707.5 17:34:47 INFO - PROCESS | 19002 | 17:34:47 INFO - PROCESS | 19002 | [#1] ext.html Cycles:180 Average:65962.11 Median:43208.18 stddev:135100.57 (312.7%) stddev-sans-first:135390.28 17:34:47 INFO - PROCESS | 19002 | Values: 542.4 580.8 581.8 596.2 633.3 39218.4 42942.4 43162.0 43208.6 43312.4 44191.3 44710.6 44760.1 44805.8 44961.8 8790.6 8918.4 8937.8 8937.9 8940.6 8768.5 8811.1 8900.1 8918.1 8921.7 8931.4 8951.4 8977.6 8983.2 9001.2 8863.4 8908.1 8911.6 8914.1 8914.7 8786.2 8843.3 8851.4 8858.2 8884.8 42662.8 43076.0 43170.0 43198.8 43207.8 3492.0 3777.9 4010.9 4065.2 4279.6 33676.2 34005.0 34100.5 34222.0 34755.3 4240.7 4245.7 4341.5 4384.4 4540.3 365397.0 366468.0 368058.2 368620.0 371167.0 58444.7 58906.4 58946.7 58981.4 59014.7 37155.4 37578.8 37990.6 39536.6 39671.6 17874.4 18207.5 18244.4 18248.1 18258.5 12892.4 12980.3 13012.7 13078.9 13108.1 19424.5 19493.6 19595.6 19731.0 19806.7 7080.4 7175.2 7292.2 7312.3 7480.3 946.7 969.4 1059.4 1070.9 1089.2 32198.4 33953.3 34244.7 34505.1 35045.6 1112.6 1115.6 1129.8 1173.5 1194.4 16291.3 17605.1 17848.8 17966.3 18146.3 589505.0 594905.0 596774.0 597296.0 601292.0 61728.7 62134.4 62196.4 62275.7 62706.1 1368.6 1389.6 1412.2 1413.4 1417.1 32783.3 34866.1 35188.9 35518.8 35642.5 53419.2 57174.1 59011.4 59222.4 63572.7 527561.0 533495.0 533638.0 533653.0 534930.0 42983.0 43127.6 43581.6 43932.3 46998.5 50801.2 51198.5 51697.0 51824.0 51910.0 42512.6 42687.8 43540.1 44102.0 45412.5 42688.1 43220.0 43805.0 44528.0 44920.6 38114.0 42877.0 43202.4 44465.3 46761.5 36270.3 38560.4 38994.8 39204.2 39635.6 29459.6 29637.4 29943.9 29991.7 30114.4 17:34:47 INFO - PROCESS | 19002 | 17:34:47 INFO - PROCESS | 19002 | [#2] jquery.html Cycles:180 Average:29432.71 Median:393.78 stddev:82638.78 (20985.9%) stddev-sans-first:82841.80 17:34:47 INFO - PROCESS | 19002 | Values: 376.5 387.7 399.9 400.8 415.1 18684.9 20072.4 20707.8 20752.5 20858.7 18956.8 19295.4 20166.8 20297.4 20344.6 5545.0 5650.2 5786.6 5834.7 5925.6 5867.1 5908.2 5916.9 5918.3 5943.0 5900.0 5930.3 5974.7 6047.4 6068.9 5481.4 5712.4 5739.1 5822.1 5836.2 5552.9 5643.2 5753.8 5763.1 5782.9 14192.7 14348.9 14498.4 23936.6 24129.3 2322.5 2350.2 2373.0 2679.2 2683.9 10329.1 10520.2 10528.3 10626.7 10643.3 1917.5 1920.1 1953.6 1997.1 2009.9 86704.0 87411.6 88169.0 90123.0 90485.0 9537.6 9556.3 9601.7 9738.4 9850.5 15530.0 15549.5 15586.1 15588.0 15642.5 7718.9 7861.2 7941.1 8015.0 8088.5 7222.6 7247.0 7405.0 7453.9 7561.7 4545.2 4726.1 4747.9 4752.3 4827.1 1925.9 1967.9 2002.0 2024.7 2032.2 938.6 951.9 975.8 999.5 1006.7 20134.6 20430.9 20712.8 20825.2 20895.4 996.3 1021.7 1057.6 1069.2 1070.2 10441.5 11572.3 11592.4 11606.0 11609.1 488878.0 492376.0 495448.0 503180.0 522689.0 55257.4 94989.0 95122.5 98186.5 99403.5 1015.3 1025.5 1051.7 1052.7 1058.2 17195.3 17733.7 18727.7 19009.2 19525.9 36798.0 43822.9 44524.3 44579.3 45810.5 55352.2 56799.0 59298.4 61631.1 61970.0 8521.7 8629.0 8640.4 8661.6 8845.4 9491.1 11262.0 11281.7 13095.0 13306.2 11681.9 11831.4 12113.7 12579.2 12616.2 11856.1 11857.5 12172.6 12176.6 12543.9 11687.9 12084.8 12127.6 12185.1 12323.8 8553.1 8578.3 8583.3 8830.3 8850.4 9909.9 10161.4 11077.2 11857.3 11975.3 17:34:47 INFO - PROCESS | 19002 | 17:34:47 INFO - PROCESS | 19002 | [#3] mootools.html Cycles:180 Average:6015.03 Median:467.15 stddev:3468.89 (742.6%) stddev-sans-first:3462.09 17:34:47 INFO - PROCESS | 19002 | Values: 1508.1 1521.1 1661.7 1724.9 1810.8 8144.1 8591.0 8763.4 9535.0 9535.5 8515.3 8885.1 8899.3 8899.5 8901.0 2373.7 2426.5 2427.9 2432.2 2444.9 2348.8 2405.4 2425.2 2426.6 2441.1 2425.1 2427.3 2433.5 2456.9 2483.2 2393.4 2416.0 2422.0 2422.3 2443.4 2308.4 2359.9 2362.1 2362.7 2375.5 9199.6 9265.8 9280.4 9294.1 9316.5 5309.5 5420.3 5442.5 5454.7 5457.9 3457.2 3490.6 3502.9 3596.0 3607.0 1102.1 1115.6 1116.2 1121.0 1132.9 12795.3 12976.4 13004.5 13074.1 13102.0 4413.8 4625.5 4719.6 4764.8 4824.6 10927.3 10941.2 10959.5 10961.5 10992.5 5345.4 5356.4 5368.8 5397.4 5401.8 4363.2 4931.4 4937.7 5034.4 5034.9 4118.8 4163.8 4171.7 4178.1 4209.6 1318.2 1343.5 1354.0 1363.9 1372.4 863.6 979.1 987.3 993.3 1005.6 5901.1 5932.4 5951.6 5982.1 6047.5 452.9 465.1 469.2 472.1 483.8 4095.5 4125.7 4140.7 4179.4 4207.8 11252.1 11426.0 11484.9 11524.6 11537.3 11382.9 11444.7 11446.9 11480.1 11487.7 8110.9 8427.2 8437.7 8524.2 8615.3 5955.5 5983.0 6104.8 6144.1 6178.6 10079.6 10117.6 10300.8 10317.2 10356.9 10225.1 10235.8 10249.9 10397.8 10469.4 7367.0 8014.5 8150.1 8358.2 8457.3 9057.0 9145.4 9151.4 9165.3 9176.9 7947.9 8096.3 8133.3 8218.6 8400.6 7973.8 8018.0 8099.2 8235.9 8320.7 7439.6 7470.3 7542.8 7559.8 7575.8 5378.5 5397.5 5405.7 5511.1 5556.8 5319.7 5398.2 5460.2 5527.4 5569.7 17:34:47 INFO - PROCESS | 19002 | 17:34:47 INFO - PROCESS | 19002 | [#4] prototype.html Cycles:180 Average:4681.36 Median:5228.00 stddev:1365.68 (26.1%) stddev-sans-first:1329.63 17:34:47 INFO - PROCESS | 19002 | Values: 316.1 325.5 330.3 335.1 338.0 5485.2 5510.4 5515.2 5533.7 5585.3 5430.8 5442.6 5459.2 5460.4 5483.9 4296.6 4331.1 4339.2 4357.0 4366.1 3912.9 3948.5 4286.6 4296.3 4334.4 4234.9 4241.9 4243.3 4257.4 4289.9 4283.1 4290.0 4304.7 4311.3 4314.3 3746.4 3748.9 3801.0 3818.4 3829.8 5307.5 5319.2 5321.1 5342.3 5347.5 4814.0 4852.9 4854.7 4863.5 4883.9 5475.6 5670.6 5676.7 5680.3 5777.5 4098.2 4102.7 4110.6 4118.5 4144.6 5675.2 5803.5 5957.2 5969.4 5985.3 4205.4 4221.0 4231.0 4244.1 4247.4 4263.9 4305.7 4306.7 4316.1 4323.7 4522.3 4889.5 4897.8 4915.6 4922.4 5688.1 5689.8 5702.9 5742.3 5757.9 1434.6 1437.2 1449.3 1453.6 1454.3 871.4 919.2 920.4 923.1 936.0 4795.9 4811.9 4842.7 4844.4 4914.9 5234.7 5237.3 5238.7 5270.4 5286.5 4792.7 4860.3 4913.4 4938.5 4975.8 2709.5 2728.1 2740.9 2751.9 2755.6 5382.3 5403.4 5432.0 5492.2 5534.3 5097.3 5127.9 5254.8 5262.0 5355.6 5334.6 5351.5 5408.8 5436.7 5470.4 5125.7 5140.4 5199.6 5226.3 5229.7 4999.2 5184.1 5189.2 5209.6 5225.1 5432.3 5909.5 6057.3 6163.5 6165.0 4155.6 4189.9 4203.4 4206.4 4218.9 5741.0 5970.8 5991.0 6000.8 6009.2 5733.7 5747.8 5761.3 5777.7 5814.8 5743.4 5743.4 5771.0 5783.1 5811.4 5532.6 5671.6 5705.4 5803.9 5818.5 5873.6 5906.4 5911.7 5916.5 5983.1 5548.5 5699.5 5761.0 5802.4 5810.4 17:34:47 INFO - PROCESS | 19002 | 17:34:47 INFO - PROCESS | 19002 | [#5] yui.html Cycles:180 Average:19863.40 Median:4221.97 stddev:27852.00 (659.7%) stddev-sans-first:27892.73 17:34:47 INFO - PROCESS | 19002 | Values: 640.6 678.6 709.4 740.4 782.8 16358.8 16978.4 17033.6 17055.2 17081.2 15077.9 15144.0 15145.5 15207.1 15272.8 801.4 827.1 828.8 831.7 835.8 648.4 796.3 821.1 823.9 824.0 857.5 874.9 877.4 879.1 879.5 866.2 866.7 866.8 868.0 870.0 641.1 641.4 641.5 642.4 644.6 15690.5 15936.8 15966.4 15975.8 15987.4 15234.4 15722.2 15772.2 15849.9 15967.3 12520.6 12666.2 12701.7 12727.0 13068.4 3581.2 3740.5 3764.8 3775.5 3817.6 77536.6 77551.6 77563.6 78688.6 78773.0 11004.3 11271.8 11297.8 11476.8 11639.1 18258.5 18362.3 18376.3 18381.0 18392.0 8180.6 8194.4 8261.4 8349.2 8436.6 4160.7 4283.2 4325.9 4346.3 4356.2 3426.9 3552.1 3566.1 3579.5 3587.0 653.7 658.8 661.8 668.1 673.9 591.8 659.7 668.3 694.5 707.5 9623.6 10396.5 10735.5 10946.6 11239.0 651.3 664.2 702.4 709.4 720.9 4596.0 5186.1 5188.5 5215.2 5253.0 65912.0 65956.7 66012.0 66186.7 125509.0 107240.0 107300.0 108343.0 110510.0 116163.0 56873.7 87298.0 88927.6 91464.0 92024.0 8874.4 9323.4 9539.1 9599.5 9612.1 38187.8 52035.7 54332.5 55060.7 55423.2 52749.5 61176.7 63631.7 66250.7 76014.6 12309.8 12763.7 12980.9 13236.8 13665.7 14400.5 14429.7 14510.9 14661.9 15343.7 13579.1 13781.3 14213.6 14586.8 14651.5 13234.5 13643.0 13664.2 14367.4 14757.9 14769.9 14870.8 15133.3 15203.8 15633.8 10567.8 10893.9 11088.8 11105.3 11388.6 9935.6 11318.7 11604.5 11615.7 11993.2 17:34:47 INFO - PROCESS | 19002 | -------- Summary: end -------- 17:34:47 INFO - PROCESS | 19002 | 17:34:48 INFO - TEST-INFO | 19002: exit 0 17:34:48 INFO - TEST-OK | dromaeo_css | took 1113105ms 17:34:48 INFO - TEST-START | kraken 17:34:48 INFO - operating with platform_type : linux_ 17:34:48 INFO - Initialising browser for kraken test... 17:34:48 INFO - TEST-INFO | started process 19252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6sxGaw/profile http://localhost:37114/getInfo.html) 17:34:53 INFO - PROCESS | 19252 | __metrics Screen width/height:1600/1200 17:34:53 INFO - PROCESS | 19252 | colorDepth:24 17:34:53 INFO - PROCESS | 19252 | Browser inner width/height: 1024/697 17:34:53 INFO - PROCESS | 19252 | __metrics 17:34:53 ERROR - PROCESS | 19252 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 17:34:54 INFO - TEST-INFO | 19252: exit 0 17:34:54 INFO - Browser initialized. 17:34:54 INFO - Running cycle 1/1 for kraken test... 17:34:54 INFO - TEST-INFO | started process 19371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6sxGaw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:06 INFO - PROCESS | 19371 | RSS: Main: 163037184 17:35:06 INFO - PROCESS | 19371 | 17:35:09 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37114/tests/kraken/driver.html?testName=audio-beat-detection) 17:35:10 INFO - PROCESS | 19371 | RSS: Main: 169119744 17:35:10 INFO - PROCESS | 19371 | 17:35:12 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37114/tests/kraken/driver.html?testName=audio-dft) 17:35:13 INFO - PROCESS | 19371 | RSS: Main: 167108608 17:35:13 INFO - PROCESS | 19371 | 17:35:16 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37114/tests/kraken/driver.html?testName=audio-fft) 17:35:16 INFO - PROCESS | 19371 | RSS: Main: 163299328 17:35:16 INFO - PROCESS | 19371 | 17:35:19 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37114/tests/kraken/driver.html?testName=audio-oscillator) 17:35:19 INFO - PROCESS | 19371 | RSS: Main: 164540416 17:35:19 INFO - PROCESS | 19371 | 17:35:21 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37114/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:35:22 INFO - PROCESS | 19371 | RSS: Main: 163917824 17:35:22 INFO - PROCESS | 19371 | 17:35:25 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37114/tests/kraken/driver.html?testName=imaging-darkroom) 17:35:26 INFO - PROCESS | 19371 | RSS: Main: 165355520 17:35:26 INFO - PROCESS | 19371 | 17:35:29 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37114/tests/kraken/driver.html?testName=imaging-desaturate) 17:35:30 INFO - PROCESS | 19371 | RSS: Main: 162312192 17:35:30 INFO - PROCESS | 19371 | 17:35:33 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37114/tests/kraken/driver.html?testName=json-parse-financial) 17:35:33 INFO - PROCESS | 19371 | RSS: Main: 164073472 17:35:33 INFO - PROCESS | 19371 | 17:35:35 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37114/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:35:36 INFO - PROCESS | 19371 | RSS: Main: 163971072 17:35:36 INFO - PROCESS | 19371 | 17:35:37 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37114/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:35:38 INFO - PROCESS | 19371 | RSS: Main: 163807232 17:35:38 INFO - PROCESS | 19371 | 17:35:40 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37114/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:35:41 INFO - PROCESS | 19371 | RSS: Main: 164569088 17:35:41 INFO - PROCESS | 19371 | 17:35:43 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37114/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:35:44 INFO - PROCESS | 19371 | RSS: Main: 163749888 17:35:44 INFO - PROCESS | 19371 | 17:35:47 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37114/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:35:47 INFO - PROCESS | 19371 | RSS: Main: 164335616 17:35:47 INFO - PROCESS | 19371 | 17:35:49 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:37114/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37114/tests/kraken/driver.html?testName=ai-astar) 17:35:49 INFO - PROCESS | 19371 | RSS: Main: 165359616 17:35:49 INFO - PROCESS | 19371 | 17:35:49 INFO - PROCESS | 19371 | __start_tp_report 17:35:49 INFO - PROCESS | 19371 | _x_x_mozilla_page_load 17:35:49 INFO - PROCESS | 19371 | _x_x_mozilla_page_load_details 17:35:49 INFO - PROCESS | 19371 | |i|pagename|runs| 17:35:49 INFO - PROCESS | 19371 | |0;ai-astar;102;115;106;112;112;113;113;116;112;112 17:35:49 INFO - PROCESS | 19371 | |1;audio-beat-detection;153;119;148;177;119;155;156;121;171;119 17:35:49 INFO - PROCESS | 19371 | |2;audio-dft;162;164;163;163;166;168;169;164;163;163 17:35:49 INFO - PROCESS | 19371 | |3;audio-fft;75;75;76;183;77;76;76;76;163;77 17:35:49 INFO - PROCESS | 19371 | |4;audio-oscillator;85;83;142;84;86;85;158;85;85;155 17:35:49 INFO - PROCESS | 19371 | |5;imaging-gaussian-blur;118;117;118;117;117;118;117;117;117;118 17:35:49 INFO - PROCESS | 19371 | |6;imaging-darkroom;149;149;155;148;152;149;149;149;150;152 17:35:49 INFO - PROCESS | 19371 | |7;imaging-desaturate;97;96;97;96;95;95;95;96;96;96 17:35:49 INFO - PROCESS | 19371 | |8;json-parse-financial;53;52;53;57;51;58;52;59;52;50 17:35:49 INFO - PROCESS | 19371 | |9;json-stringify-tinderbox;61;61;60;61;61;61;61;61;61;62 17:35:49 INFO - PROCESS | 19371 | |10;stanford-crypto-aes;88;78;78;83;78;77;77;88;81;77 17:35:49 INFO - PROCESS | 19371 | |11;stanford-crypto-ccm;136;126;133;127;127;134;143;129;152;139 17:35:49 INFO - PROCESS | 19371 | |12;stanford-crypto-pbkdf2;161;161;164;163;165;158;162;164;167;162 17:35:49 INFO - PROCESS | 19371 | |13;stanford-crypto-sha256-iterative;65;65;65;63;68;63;65;64;62;68 17:35:49 INFO - PROCESS | 19371 | __end_tp_report 17:35:49 INFO - PROCESS | 19371 | __start_cc_report 17:35:49 INFO - PROCESS | 19371 | _x_x_mozilla_cycle_collect,860 17:35:49 INFO - PROCESS | 19371 | __end_cc_report 17:35:49 INFO - PROCESS | 19371 | __startTimestamp1470962149873__endTimestamp 17:35:49 INFO - PROCESS | 19371 | 17:35:49 INFO - PROCESS | 19371 | ------- Summary: start ------- 17:35:49 INFO - PROCESS | 19371 | Number of tests: 14 17:35:49 INFO - PROCESS | 19371 | 17:35:49 INFO - PROCESS | 19371 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:4.19 (3.7%) stddev-sans-first:2.78 17:35:49 INFO - PROCESS | 19371 | Values: 102.0 115.0 106.0 112.0 112.0 113.0 113.0 116.0 112.0 112.0 17:35:49 INFO - PROCESS | 19371 | 17:35:49 INFO - PROCESS | 19371 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:154.00 stddev:22.57 (14.7%) stddev-sans-first:23.69 17:35:49 INFO - PROCESS | 19371 | Values: 153.0 119.0 148.0 177.0 119.0 155.0 156.0 121.0 171.0 119.0 17:35:49 INFO - PROCESS | 19371 | 17:35:49 INFO - PROCESS | 19371 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.37 (1.4%) stddev-sans-first:2.33 17:35:49 INFO - PROCESS | 19371 | Values: 162.0 164.0 163.0 163.0 166.0 168.0 169.0 164.0 163.0 163.0 17:35:49 INFO - PROCESS | 19371 | 17:35:49 INFO - PROCESS | 19371 | [#3] audio-fft Cycles:10 Average:95.40 Median:76.00 stddev:41.17 (54.2%) stddev-sans-first:43.01 17:35:49 INFO - PROCESS | 19371 | Values: 75.0 75.0 76.0 183.0 77.0 76.0 76.0 76.0 163.0 77.0 17:35:49 INFO - PROCESS | 19371 | 17:35:49 INFO - PROCESS | 19371 | [#4] audio-oscillator Cycles:10 Average:104.80 Median:85.00 stddev:32.60 (38.4%) stddev-sans-first:33.78 17:35:49 INFO - PROCESS | 19371 | Values: 85.0 83.0 142.0 84.0 86.0 85.0 158.0 85.0 85.0 155.0 17:35:49 INFO - PROCESS | 19371 | 17:35:49 INFO - PROCESS | 19371 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 17:35:49 INFO - PROCESS | 19371 | Values: 118.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 17:35:49 INFO - PROCESS | 19371 | 17:35:49 INFO - PROCESS | 19371 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:149.50 stddev:2.15 (1.4%) stddev-sans-first:2.24 17:35:49 INFO - PROCESS | 19371 | Values: 149.0 149.0 155.0 148.0 152.0 149.0 149.0 149.0 150.0 152.0 17:35:49 INFO - PROCESS | 19371 | 17:35:49 INFO - PROCESS | 19371 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 17:35:49 INFO - PROCESS | 19371 | Values: 97.0 96.0 97.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 17:35:49 INFO - PROCESS | 19371 | 17:35:49 INFO - PROCESS | 19371 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.00 stddev:3.13 (5.9%) stddev-sans-first:3.31 17:35:49 INFO - PROCESS | 19371 | Values: 53.0 52.0 53.0 57.0 51.0 58.0 52.0 59.0 52.0 50.0 17:35:49 INFO - PROCESS | 19371 | 17:35:49 INFO - PROCESS | 19371 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 17:35:49 INFO - PROCESS | 19371 | Values: 61.0 61.0 60.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 17:35:49 INFO - PROCESS | 19371 | 17:35:49 INFO - PROCESS | 19371 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:79.50 stddev:4.40 (5.5%) stddev-sans-first:3.74 17:35:49 INFO - PROCESS | 19371 | Values: 88.0 78.0 78.0 83.0 78.0 77.0 77.0 88.0 81.0 77.0 17:35:49 INFO - PROCESS | 19371 | 17:35:49 INFO - PROCESS | 19371 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:135.00 stddev:8.29 (6.1%) stddev-sans-first:8.78 17:35:49 INFO - PROCESS | 19371 | Values: 136.0 126.0 133.0 127.0 127.0 134.0 143.0 129.0 152.0 139.0 17:35:49 INFO - PROCESS | 19371 | 17:35:49 INFO - PROCESS | 19371 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:163.50 stddev:2.50 (1.5%) stddev-sans-first:2.57 17:35:49 INFO - PROCESS | 19371 | Values: 161.0 161.0 164.0 163.0 165.0 158.0 162.0 164.0 167.0 162.0 17:35:49 INFO - PROCESS | 19371 | 17:35:49 INFO - PROCESS | 19371 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.99 (3.1%) stddev-sans-first:2.11 17:35:49 INFO - PROCESS | 19371 | Values: 65.0 65.0 65.0 63.0 68.0 63.0 65.0 64.0 62.0 68.0 17:35:49 INFO - PROCESS | 19371 | -------- Summary: end -------- 17:35:49 INFO - PROCESS | 19371 | 17:35:50 INFO - TEST-INFO | 19371: exit 0 17:35:50 INFO - TEST-OK | kraken | took 62313ms 17:35:50 INFO - SUITE-END | took 1175s 17:35:51 INFO - Completed test suite (00:19:35) 17:35:51 INFO - javascript benchmark 17:35:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7346.58133257202, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3110.0980715592477, 3153.3693261347735, 3185.076327864919, 3187.3625274945016, 3196.648368679445, 5346.759395827187, 5488.2865227520415, 5490.56075513959, 5547.639403438784, 5551.417101204376, 5387.703676297802, 5423.484768946943, 5469.945300546993, 5475.698836563987, 5485.067538518451, 4893.0213957208525, 4951.653384263103, 4953.529414705597, 4982.57648099912, 4993.151164302078, 5011.248312753098, 5016.2224855147515, 5105.974470127644, 5121.769520371592, 5125.513076257749, 4971.925421118686, 4979.004199160183, 5026.97486512567, 5032.094223039851, 5088.92366614501, 4868.123737727207, 4876.122297986361, 4906.730129842857, 4927.260910863363, 4983.900321993576, 4864.027194561102, 4871.780769865364, 4886.047220791947, 4889.863905736609, 4924.9507504925205, 5290.39160496544, 5369.382521010095, 5373.408925018245, 5374.435684253136, 5380.973095134538, 5734.827955161351, 5795.594308398372, 5805.187273781674, 5850.414958504158, 5851.268591426072, 5780.653160810322, 5825.242718446617, 5826.941730582682, 5843.240378750777, 5844.123381492767, 5286.36563612369, 5344.679319240858, 5417.837464876021, 5420.810271640513, 5423.376311724123, 5851.473367396955, 5941.494972927263, 5956.13636022783, 5991.011483105326, 5998.400159984054, 5699.658020518782, 5700.116481945305, 5712.542996560265, 5716.171155182476, 5725.656460612377, 5568.749406276646, 5747.1379293106365, 5791.362950075489, 5804.622699524517, 5807.970960145172, 5583.162525621108, 5692.743826527816, 5807.912881306784, 5929.52563794904, 5932.7330270137945, 5695.316562012502, 5753.539716822645, 5806.390329015392, 5823.708814559255, 5868.853278667982, 4414.426124603845, 4421.42521472213, 4422.778861056934, 4435.955640443554, 4457.175422546839, 3907.8241479133508, 3936.9212615748097, 3938.0, 3974.880753577397, 3993.381025940984, 5559.972200138974, 5569.916451253234, 5606.6636001840025, 5672.716364181774, 5676.517496012885, 5900.763969441175, 5904.996150654399, 5910.645361278251, 5919.378465261172, 5921.437463440966, 5440.211169380417, 5506.614536982373, 5548.4451554845, 5609.915851262234, 5616.241807356037, 5072.923906141411, 5073.1122053640465, 5076.060928728197, 5099.69401835891, 5117.130087885069, 6101.0, 6103.786367477117, 6104.969475152596, 6107.4197951194565, 6111.54163437744, 5669.773209071591, 5726.541876649775, 5775.960327141155, 5865.208196893535, 5892.734826932712, 6078.878422431439, 6088.786892458743, 6113.205283313318, 6116.938830611637, 6133.325334213144, 5711.828645140652, 5752.654840709571, 5756.827295181151, 5757.107648314518, 5765.250517432707, 5685.971570142123, 5738.053221218619, 5762.510186634183, 5855.3266374367495, 5859.150423188699, 5697.003024470784, 5709.0, 5711.428857114255, 5744.224529688438, 5757.078867381367, 5635.746391412478, 5657.575681823797, 5664.49019588239, 5667.8866422672145, 5683.744231509675, 5444.346678398618, 5655.264815573949, 5663.7451314690115, 5678.20505129274, 5730.570207234391, 5804.332501762183, 5818.156367326629, 5835.2122463466885, 5868.3251426086545, 5882.852928676817, 5589.888202236014, 5647.068233741386, 5669.943300566942, 5706.600537962303, 5707.486326230659], "value": 5379.044442281534, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.3503694070117, 580.8402689260453, 581.8109114537775, 596.1862058290434, 633.3286716080958, 39218.41172382413, 42942.355864662015, 43162.0, 43208.56791432085, 43312.3503147453, 44191.33712994299, 44710.552894471046, 44760.10479790402, 44805.77597112018, 44961.775191124, 8790.64837406503, 8918.375713700043, 8937.77655558613, 8937.865932010993, 8940.597673104727, 8768.517731524764, 8811.11888811117, 8900.109989001114, 8918.108189181063, 8921.732348029569, 8931.41945773526, 8951.41815781972, 8977.640894364218, 8983.19151276385, 9001.244757272334, 8863.423877447978, 8908.064653211384, 8911.598978046004, 8914.108589141066, 8914.687985920527, 8786.209241168262, 8843.336749743796, 8851.424657397312, 8858.247049000842, 8884.777880552972, 42662.78668606668, 43076.0, 43170.0, 43198.78400608008, 43207.783961080306, 3491.9650803491895, 3777.8677746279022, 4010.9398359024344, 4065.2276067547073, 4279.550647182032, 33676.15809604755, 34005.0, 34100.48849267263, 34222.0, 34755.30489390198, 4240.703150779446, 4245.702800803945, 4341.522432532419, 4384.364267181241, 4540.296254080623, 365397.0, 366468.0, 368058.1597092024, 368620.0, 371167.0, 58444.70777646085, 58906.41093589095, 58946.70526647339, 58981.41018589845, 59014.70492647509, 37155.442668359996, 37578.812105939294, 37990.62009379871, 39536.60463395329, 39671.60328396737, 17874.374396896048, 18207.45377638673, 18244.361447349544, 18248.087595620433, 18258.45224643263, 12892.419841107172, 12980.286084265455, 13012.674683132807, 13078.869211307765, 13108.082434229704, 19424.514387140436, 19493.610127797365, 19595.60808783816, 19731.0, 19806.70289945652, 7080.398166155935, 7175.246599107123, 7292.161401438796, 7312.268773122645, 7480.251974802476, 946.6592026870321, 969.3699095587924, 1059.3590877519143, 1070.8875568065241, 1089.1810676170815, 32198.356032879212, 33953.32093358119, 34244.657553424644, 34505.13737156541, 35045.64954350424, 1112.6439539347493, 1115.570505355444, 1129.8079326514348, 1173.5188572685329, 1194.3908606610692, 16291.266892989845, 17605.119744012747, 17848.839825411305, 17966.281348745903, 18146.274149034154, 589505.0, 594905.0, 596774.0, 597296.0, 601292.0, 61728.69135654383, 62134.37865621376, 62196.37803621996, 62275.688621556605, 62706.0594091089, 1368.589423173044, 1389.5900709290784, 1412.1950488221821, 1413.4063693248654, 1417.0859795431888, 32783.34433311273, 34866.059168643114, 35188.94433167009, 35518.822405887804, 35642.46536302009, 53419.19871202013, 57174.14238786339, 59011.40988590059, 59222.40777592169, 63572.68213658902, 527561.0, 533495.0, 533638.0, 533653.0, 534930.0, 42983.0, 43127.56872431361, 43581.56418435902, 43932.341014884165, 46998.53001470078, 50801.23798143105, 51198.48801512086, 51697.0, 51824.0, 51910.0, 42512.57487425086, 42687.786561067, 43540.12919741651, 44102.0, 45412.54587454083, 42688.14623707446, 43220.0, 43805.0, 44528.0, 44920.55079449164, 38114.047148821504, 42877.0, 43202.35196472118, 44465.33302000408, 46761.53238467572, 36270.274594507435, 38560.42159367556, 38994.80502597469, 39204.2159156821, 39635.60364396319, 29459.55810662799, 29637.407251855275, 29943.85028074846, 29991.70008299889, 30114.397712046073], "value": 20961.272496047804, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.46541910487105, 387.70921808643516, 399.85605182134424, 400.8116185392866, 415.1033767063144, 18684.90657546712, 20072.397828065146, 20707.792922070774, 20752.48118797029, 20858.687119693215, 18956.763347792177, 19295.421137365865, 20166.798332016675, 20297.39107826764, 20344.593108137866, 5544.972275138619, 5650.208970744099, 5786.56600754943, 5834.6790926499025, 5925.585209035369, 5867.11993201019, 5908.202392676976, 5916.852078698045, 5918.319393269764, 5943.0, 5899.970500147493, 5930.258717660293, 5974.731137098819, 6047.3650266722025, 6068.908966365508, 5481.397046324901, 5712.371639119693, 5739.081746920494, 5822.097574875901, 5836.241288632451, 5552.944470555283, 5643.209950606918, 5753.769849206069, 5763.1355296705415, 5782.855428614276, 14192.716145677132, 14348.852091832629, 14498.42006319746, 23936.640950385758, 24129.276121716375, 2322.5238826040622, 2350.247920665388, 2372.9525409491885, 2679.2364176209685, 2683.892644294226, 10329.070383665507, 10520.210984176218, 10528.315659482185, 10626.681199564026, 10643.254972151875, 1917.51103468616, 1920.1071501751612, 1953.5506833428249, 1997.1455190596025, 2009.9347345906692, 86704.0, 87411.56294218489, 88169.0, 90123.0, 90485.0, 9537.570809313598, 9556.283278754121, 9601.663941762145, 9738.415695058318, 9850.50747462624, 15530.0, 15549.455769048029, 15586.142762147963, 15588.0, 15642.530724078295, 7718.884216736754, 7861.174576669482, 7941.086775020831, 8014.959925200336, 8088.514689118554, 7222.602756848424, 7246.963765181245, 7405.0, 7453.85092298151, 7561.697532098655, 4545.204589196877, 4726.054789042205, 4747.905041899212, 4752.263399173134, 4827.08285425768, 1925.9037048147536, 1967.928939222486, 2002.0490267123291, 2024.665930121543, 2032.1871251499224, 938.5541867612966, 951.8667386565886, 975.8487434447673, 999.5002498750624, 1006.6728313298207, 20134.597308053755, 20430.897845510677, 20712.792872071088, 20825.18859953887, 20895.37313880586, 996.3473924579412, 1021.6934919524113, 1057.5505410200633, 1069.2354966199205, 1070.202698989258, 10441.477926103817, 11572.305661660328, 11592.420378981018, 11606.0, 11609.071274298036, 488878.0, 492376.0, 495448.0, 503180.0, 522689.0, 55257.44742552523, 94989.0, 95122.524387379, 98186.50906745564, 99403.50298248607, 1015.2639336480992, 1025.5282570017876, 1051.673981065872, 1052.6947185316174, 1058.2327812336148, 17195.312187512358, 17733.73399398984, 18727.71908421402, 19009.239630414628, 19525.902370488056, 36798.0, 43822.85773989809, 44524.332135018645, 44579.331310029724, 45810.54189458063, 55352.16971745508, 56799.0, 59298.40173174779, 61631.07553386613, 61970.0, 8521.701740439055, 8629.0, 8640.438371505832, 8661.566921654017, 8845.380823342304, 9491.145796878314, 11262.0, 11281.71795705114, 13095.0, 13306.201627902357, 11681.88318116808, 11831.40842957866, 12113.69715757113, 12579.182353147016, 12616.17994830333, 11856.110791690486, 11857.466414011218, 12172.57395991136, 12176.634700958986, 12543.87456125427, 11687.88312116868, 12084.75830483403, 12127.636170914533, 12185.086118540967, 12323.815142773044, 8553.101924297858, 8578.270846977826, 8583.313334933315, 8830.337724670548, 8850.424722393023, 9909.851352229578, 10161.390316581028, 11077.169212308949, 11857.288562686266, 11975.341356225492], "value": 9264.727179925205, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.0951429142515, 1521.1405555860938, 1661.7424299233614, 1724.862011039117, 1810.7555480010203, 8144.06343270524, 8591.0, 8763.386562940597, 9534.95232523838, 9535.475548844819, 8515.276201522862, 8885.111488851111, 8899.288056955444, 8899.466032038083, 8900.955495222532, 2373.6914201153827, 2426.5268272686744, 2427.854328740272, 2432.1852179519883, 2444.926652200437, 2348.776866197717, 2405.386626410263, 2425.19968410425, 2426.6360045993065, 2441.072392490851, 2425.1027119965547, 2427.2718184544656, 2433.5497932882386, 2456.8771561421945, 2483.192962287264, 2393.377721792338, 2416.0, 2421.9757802421927, 2422.297533715238, 2443.4135807406096, 2308.3998160478395, 2359.917402890908, 2362.1378196957985, 2362.7400985891536, 2375.4892698069825, 9199.632014719404, 9265.814683706289, 9280.35037547372, 9294.117058879396, 9316.534173291308, 5309.548688361494, 5420.34955805302, 5442.510174084351, 5454.699991500466, 5457.918131228034, 3457.17027913299, 3490.616032236452, 3502.8949131526097, 3595.982020089883, 3606.981965090184, 1102.079763397556, 1115.5928086248541, 1116.179607988128, 1120.9551617935272, 1132.88104749001, 12795.296258705768, 12976.35118244084, 13004.544840930617, 13074.084814062924, 13102.0, 4413.757243351646, 4625.514320996314, 4719.598834099072, 4764.784375265518, 4824.614030877521, 10927.289726167774, 10941.23411361197, 10959.50682219302, 10961.506732197071, 10992.505337259843, 5345.3852806926925, 5356.437574054746, 5368.785248590013, 5397.4062853086125, 5401.783928642889, 4363.19280933022, 4931.3589233399425, 4937.703737775745, 5034.395872495324, 5034.924476132861, 4118.842659014854, 4163.770992595376, 4171.749695018309, 4178.05993651426, 4209.6000879916355, 1318.2024874950516, 1343.5096189890814, 1353.9729205415836, 1363.9113457625222, 1372.389286767399, 863.5552690364467, 979.0796651147898, 987.3088837813559, 993.3344659078434, 1005.6228914157191, 5901.144334071536, 5932.436418540232, 5951.5833891628035, 5982.0727787193055, 6047.516198704093, 452.91168222196353, 465.12788521522145, 469.1695698613435, 472.091224393042, 483.7653737937098, 4095.508538975342, 4125.711200215956, 4140.668746500272, 4179.414881916534, 4207.810648520824, 11252.099832013419, 11426.0, 11484.885151148548, 11524.59663911759, 11537.307761534335, 11382.886171138349, 11444.656660300205, 11446.885531144748, 11480.081593472501, 11487.655370338904, 8110.878336824952, 8427.199416055464, 8437.662493500315, 8524.232819046192, 8615.267702245379, 5955.464008239279, 5983.0380870233375, 6104.816855494342, 6144.109104179958, 6178.62928224308, 10079.596816127272, 10117.59529618807, 10300.793984120426, 10317.226208034277, 10356.896431035895, 10225.130863876653, 10235.795284094425, 10249.897501024894, 10397.84403233937, 10469.371837689763, 7367.0, 8014.479058861389, 8150.144234855255, 8358.247757701836, 8457.281131103926, 9057.0, 9145.405548639317, 9151.405158664666, 9165.312601554777, 9176.908230917872, 7947.8807817881625, 8096.311813495919, 8133.349332053303, 8218.63016164262, 8400.579971001547, 7973.760787176394, 8018.0, 8099.230573095547, 8235.917640823754, 8320.70877519284, 7439.590822504598, 7470.3276705096805, 7542.773716788505, 7559.848803024019, 7575.810604734926, 5378.489043540857, 5397.541208997122, 5405.675659460445, 5511.118221084607, 5556.805511807067, 5319.734013299397, 5398.163284690879, 5460.235567020541, 5527.419620939904, 5569.66582005081], "value": 4715.7457431539515, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.140098930908, 325.4613614468055, 330.2766940400523, 335.0868882295744, 337.9797212167269, 5485.232067510552, 5510.393856675768, 5515.172724091388, 5533.652140455027, 5585.329760428749, 5430.83707488776, 5442.612133905858, 5459.153831156177, 5460.426655201206, 5483.917741233885, 4296.57034296571, 4331.112122014987, 4339.218940590692, 4357.0, 4366.148601022802, 3912.941305880414, 3948.492707130964, 4286.578083382894, 4296.291111966521, 4334.393184954093, 4234.92009537569, 4241.851535196269, 4243.299855523835, 4257.446531950842, 4289.935650965238, 4283.100548884722, 4289.978550107261, 4304.665553678338, 4311.310190369526, 4314.288142456475, 3746.38184699527, 3748.9437658435145, 3800.9619903801163, 3818.3581060144406, 3829.80850957451, 5307.469253074701, 5319.20211968204, 5321.122014867542, 5342.252084708144, 5347.491988261109, 4813.951860481386, 4852.854414367539, 4854.708717476963, 4863.513648635108, 4883.902321953577, 5475.616706830523, 5670.6030577859565, 5676.687782171979, 5680.289963754531, 5777.45114214149, 4098.159877225162, 4102.733322334038, 4110.630043296088, 4118.5263694675195, 4144.564820693844, 5675.2054712340305, 5803.535717142577, 5957.1957785698805, 5969.373215812364, 5985.281766188085, 4205.36919462077, 4220.957790422118, 4230.957690423118, 4244.087521182961, 4247.4265974093105, 4263.936040959388, 4305.720128191658, 4306.720063195882, 4316.0720445103825, 4323.675724320626, 4522.3442600823355, 4889.511048895153, 4897.7795999180125, 4915.557599816034, 4922.360093187935, 5688.146777983253, 5689.80514092037, 5702.914456283159, 5742.253507044057, 5757.913631295534, 1434.634168287101, 1437.2238990944982, 1449.3188201545256, 1453.5972786261098, 1454.3092031285055, 871.4205053639259, 919.1635611593551, 920.3787443475627, 923.1091996223677, 936.0031566381917, 4795.904081918342, 4811.879703007453, 4842.709437433765, 4844.4186697596515, 4914.852554423302, 5234.691327168208, 5237.2766161595755, 5238.6594871334, 5270.420253772082, 5286.47135286476, 4792.664513484093, 4860.3195552622665, 4913.361263035782, 4938.481459446778, 4975.825846095369, 2709.5122877882172, 2728.1133631569423, 2740.945181096367, 2751.876165572554, 2755.6279902213346, 5382.327209098863, 5403.351597808288, 5432.0, 5492.203630473559, 5534.308211473566, 5097.260897169889, 5127.871868188992, 5254.7635356409055, 5262.026954770542, 5355.625106242525, 5334.5732341412595, 5351.464853514617, 5408.810691625774, 5436.689407002008, 5470.425605311385, 5125.71905502063, 5140.43455219918, 5199.610029247897, 5226.346706661668, 5229.660072095302, 4999.225275027458, 5184.148718204897, 5189.247559103985, 5209.557187639093, 5225.118957175489, 5432.266644003167, 5909.468147866713, 6057.273127224761, 6163.537734669828, 6165.0444181152, 4155.605217504332, 4189.853355132555, 4203.4115223868075, 4206.432131662186, 4218.873433796991, 5741.0, 5970.820875373745, 5990.974557848259, 6000.759969601341, 6009.188759517409, 5733.655980641175, 5747.770089196385, 5761.337446193741, 5777.688924430262, 5814.825555233349, 5743.368229494836, 5743.4256574342235, 5771.047777116896, 5783.103618939072, 5811.360750317546, 5532.557395408277, 5671.574631902707, 5705.4009329019855, 5803.883922321615, 5818.4763371296785, 5873.588848780715, 5906.379830117948, 5911.674857882857, 5916.467517923407, 5983.132445795248, 5548.529639645417, 5699.458551437607, 5760.971195143998, 5802.419758024333, 5810.360860305447], "value": 4241.62969327851, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.6124294801645, 678.6165816313783, 709.3792931185213, 740.4187712645574, 782.8160382310158, 16358.754618680714, 16978.40575579855, 17033.574160645974, 17055.232514536845, 17081.23134458949, 15077.924610376933, 15144.0, 15145.469908553203, 15207.087574745496, 15272.847271527282, 801.3509057663282, 827.065416079829, 828.7969447485375, 831.6548632317612, 835.7952301686096, 648.4164252173035, 796.2793671727068, 821.0885916632562, 823.9382046346518, 823.9629216685264, 857.4683696108422, 874.899386570543, 877.394597727566, 879.0813599788237, 879.5118709116438, 866.1944391715701, 866.7096522664851, 866.8439680857443, 867.9913200867974, 869.9951555952853, 641.1216633212482, 641.3746597067822, 641.4932203559183, 642.4410762636536, 644.5584774429531, 15690.450834220861, 15936.840631593652, 15966.361345546164, 15975.760363594556, 15987.44043958456, 15234.390624375012, 15722.213889305489, 15772.211389430597, 15849.920750396173, 15967.281472333772, 12520.612778677294, 12666.240025598494, 12701.745965080647, 12727.045471589669, 13068.411921463461, 3581.197472212701, 3740.4763333133383, 3764.849406023756, 3775.452559378875, 3817.560980487224, 77536.61231693861, 77551.61224193899, 77563.61218193985, 78688.60655696742, 78773.0, 11004.339739615649, 11271.774564508663, 11297.830532542019, 11476.770464590662, 11639.127065470124, 18258.543536411697, 18362.265509379744, 18376.264949401873, 18381.0, 18392.0, 8180.550069746221, 8194.426390152632, 8261.421700480909, 8349.248567628943, 8436.578171091422, 4160.708750387505, 4283.233265518744, 4325.935110973338, 4346.261135606955, 4356.150550642657, 3426.880059197916, 3552.0587044433246, 3566.0728210665416, 3579.463080537888, 3587.0, 653.7123665587127, 658.7990662847782, 661.8180000499805, 668.1014036121409, 673.8618583190434, 591.7603370634899, 659.7031335898864, 668.3383450384182, 694.5034300475185, 707.5259576084036, 9623.63172889497, 10396.48017599132, 10735.463226838627, 10946.56213751457, 11239.0, 651.2608189704624, 664.2095905871997, 702.3924305475829, 709.4289097276742, 720.8594324106749, 4595.954040459619, 5186.118359878829, 5188.45521220274, 5215.16557350822, 5253.0, 65912.0, 65956.67021664957, 66012.0, 66186.66906665532, 125509.0, 107240.0, 107300.0, 108343.0, 110510.0, 116163.0, 56873.715631421575, 87298.0, 88927.55536222277, 91464.0, 92024.0, 8874.423162494417, 9323.393979391318, 9539.14147726708, 9599.47202903819, 9612.134907858326, 38187.80906095563, 52035.73982130065, 54332.45667543274, 55060.72469637626, 55423.16865247105, 52749.472505274454, 61176.694116529135, 63631.68184159049, 66250.66874665595, 76014.6199269, 12309.815352769894, 12763.744725105631, 12980.870191297967, 13236.801447978096, 13665.726685466434, 14400.495982640976, 14429.711405771615, 14510.85489145095, 14661.85338146605, 15343.693126137192, 13579.110286104054, 13781.310934453037, 14213.644658883197, 14586.781198281822, 14651.487197948021, 13234.470621175045, 13643.0, 13664.248466334448, 14367.353469093707, 14757.92621036888, 14769.92615036918, 14870.77693834615, 15133.319000644777, 15203.847961520243, 15633.843661563693, 10567.841482377924, 10893.945530272615, 11088.778224435628, 11105.333679979227, 11388.601398950997, 9935.552900119368, 11318.717032073935, 11604.535818567163, 11615.6515304541, 11993.220440671328], "value": 7523.628881433795, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 106.0, 112.0, 112.0, 113.0, 113.0, 116.0, 112.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 119.0, 148.0, 177.0, 119.0, 155.0, 156.0, 121.0, 171.0, 119.0], "value": 143.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 163.0, 166.0, 168.0, 169.0, 164.0, 163.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 183.0, 77.0, 76.0, 76.0, 76.0, 163.0, 77.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 142.0, 84.0, 86.0, 85.0, 158.0, 85.0, 85.0, 155.0], "value": 104.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 155.0, 148.0, 152.0, 149.0, 149.0, 149.0, 150.0, 152.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 57.0, 51.0, 58.0, 52.0, 59.0, 52.0, 50.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 78.0, 78.0, 83.0, 78.0, 77.0, 77.0, 88.0, 81.0, 77.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 126.0, 133.0, 127.0, 127.0, 134.0, 143.0, 129.0, 152.0, 139.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 164.0, 163.0, 165.0, 158.0, 162.0, 164.0, 167.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 63.0, 68.0, 63.0, 65.0, 64.0, 62.0, 68.0], "value": 64.8, "unit": "score"}]}]} 17:35:51 INFO - Return code: 0 17:35:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:35:51 ERROR - # TBPL SUCCESS # 17:35:51 INFO - Running post-action listener: _resource_record_post_action 17:35:51 INFO - [mozharness: 2016-08-12 00:35:51.159946Z] Finished run-tests step (success) 17:35:51 INFO - Running post-run listener: _resource_record_post_run 17:35:51 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549793792; Read time: 12; Write time: 620024 17:35:51 INFO - TinderboxPrint: CPU usage
13.4% 17:35:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:35:51 INFO - TinderboxPrint: I/O write bytes / time
549,793,792 / 620,024 17:35:51 INFO - TinderboxPrint: CPU idle
8,239.7 (86.6%) 17:35:51 INFO - TinderboxPrint: CPU user
1,220.2 (12.8%) 17:35:51 INFO - TinderboxPrint: Swap in / out
0 / 0 17:35:51 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258281472; Read time: 0; Write time: 368948 17:35:51 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 291336192; Read time: 0; Write time: 251040 17:35:51 INFO - Running post-run listener: _upload_blobber_files 17:35:51 INFO - Blob upload gear active. 17:35:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:35:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:35:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:35:52 INFO - (blobuploader) - INFO - Open directory for files ... 17:35:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:35:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:35:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:57 INFO - (blobuploader) - INFO - Done attempting. 17:35:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:35:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:35:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:58 INFO - (blobuploader) - INFO - Done attempting. 17:35:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:35:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:35:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:59 INFO - (blobuploader) - INFO - Done attempting. 17:35:59 INFO - (blobuploader) - INFO - Iteration through files over. 17:35:59 INFO - Return code: 0 17:35:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:35:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:35:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99236315d18ae6d5d39d4989ed0d810338c7d58f8df8081e4d279f0ac44196d55eb4b98ec8582d65d783469db61d54c22abbc2a7dbf52afc480b3420a136e57a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/306968b3e927f447fcc23d95134b16819b2ecd46eb21749392b36e07d51183e7ba414f9da044d04bb32d177921f62903ae53e1c92398931b934e6c601ef7b2bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/451aedee6c65df87d281ed78bfabfa5c9b6d28d786d32c75615cc4d370b8a625311b5217fb71f54a493b3add0783f14db19dad1dc15a87c748e4ad07484d6f66"} 17:35:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:35:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:35:59 INFO - Contents: 17:35:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99236315d18ae6d5d39d4989ed0d810338c7d58f8df8081e4d279f0ac44196d55eb4b98ec8582d65d783469db61d54c22abbc2a7dbf52afc480b3420a136e57a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/306968b3e927f447fcc23d95134b16819b2ecd46eb21749392b36e07d51183e7ba414f9da044d04bb32d177921f62903ae53e1c92398931b934e6c601ef7b2bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/451aedee6c65df87d281ed78bfabfa5c9b6d28d786d32c75615cc4d370b8a625311b5217fb71f54a493b3add0783f14db19dad1dc15a87c748e4ad07484d6f66"} 17:35:59 INFO - Running post-run listener: copy_logs_to_upload_dir 17:35:59 INFO - Copying logs to upload dir... 17:35:59 INFO - mkdir: /builds/slave/test/build/upload/logs 17:35:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.607797 ========= master_lag: 0.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-08-11 17:35:59.433728) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 17:35:59.441732) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99236315d18ae6d5d39d4989ed0d810338c7d58f8df8081e4d279f0ac44196d55eb4b98ec8582d65d783469db61d54c22abbc2a7dbf52afc480b3420a136e57a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/306968b3e927f447fcc23d95134b16819b2ecd46eb21749392b36e07d51183e7ba414f9da044d04bb32d177921f62903ae53e1c92398931b934e6c601ef7b2bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/451aedee6c65df87d281ed78bfabfa5c9b6d28d786d32c75615cc4d370b8a625311b5217fb71f54a493b3add0783f14db19dad1dc15a87c748e4ad07484d6f66"} build_url:https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/TYb1_0EJRiSYzzkvtyGl1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99236315d18ae6d5d39d4989ed0d810338c7d58f8df8081e4d279f0ac44196d55eb4b98ec8582d65d783469db61d54c22abbc2a7dbf52afc480b3420a136e57a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/306968b3e927f447fcc23d95134b16819b2ecd46eb21749392b36e07d51183e7ba414f9da044d04bb32d177921f62903ae53e1c92398931b934e6c601ef7b2bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/451aedee6c65df87d281ed78bfabfa5c9b6d28d786d32c75615cc4d370b8a625311b5217fb71f54a493b3add0783f14db19dad1dc15a87c748e4ad07484d6f66"}' ========= master_lag: 0.28 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 17:35:59.728917) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 17:35:59.729272) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1470959591.781566-1498501783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 17:35:59.749258) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 17:35:59.749587) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 17:35:59.749917) ========= ========= Total master_lag: 0.95 =========