builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1470802284.42 results: success (0) buildid: 20160809183001 builduid: 7829f6a628ea491eb4d3e10f7f40e457 revision: 15d404ae1609b59cc09436df4f3a1ed46a57346d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 21:11:24.423173) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 21:11:24.423648) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 21:11:24.423937) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 21:11:24.479932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 21:11:24.480244) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1470802119.966445-492577301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 21:11:24-- 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% 43.4M=0s 2016-08-09 21:11:24 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088363 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 21:11:24.585546) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 21:11:24.585838) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1470802119.966445-492577301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017523 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 21:11:24.634960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 21:11:24.635335) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 15d404ae1609b59cc09436df4f3a1ed46a57346d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 15d404ae1609b59cc09436df4f3a1ed46a57346d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1470802119.966445-492577301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 21:11:24,850 truncating revision to first 12 chars 2016-08-09 21:11:24,850 Setting DEBUG logging. 2016-08-09 21:11:24,850 attempt 1/10 2016-08-09 21:11:24,850 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/15d404ae1609?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 21:11:25,822 unpacking tar archive at: autoland-15d404ae1609/testing/mozharness/ program finished with exit code 0 elapsedTime=1.372639 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 21:11:26.023629) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 21:11:26.024126) ========= script_repo_revision: 15d404ae1609b59cc09436df4f3a1ed46a57346d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 21:11:26.024801) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 21:11:26.025295) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 21:11:26.037674) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-09 21:11:26.038270) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1470802119.966445-492577301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:11:26 INFO - MultiFileLogger online at 20160809 21:11:26 in /builds/slave/test 21:11:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:11:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:11:26 INFO - {'append_to_log': False, 21:11:26 INFO - 'base_work_dir': '/builds/slave/test', 21:11:26 INFO - 'blob_upload_branch': 'Autoland', 21:11:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:11:26 INFO - 'branch': 'Autoland', 21:11:26 INFO - 'buildbot_json_path': 'buildprops.json', 21:11:26 INFO - 'config_files': ('talos/linux_config.py',), 21:11:26 INFO - 'default_actions': ('clobber', 21:11:26 INFO - 'read-buildbot-config', 21:11:26 INFO - 'download-and-extract', 21:11:26 INFO - 'populate-webroot', 21:11:26 INFO - 'create-virtualenv', 21:11:26 INFO - 'install', 21:11:26 INFO - 'run-tests'), 21:11:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:11:26 INFO - 'download_minidump_stackwalk': True, 21:11:26 INFO - 'download_symbols': 'ondemand', 21:11:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:11:26 INFO - 'tooltool.py': '/tools/tooltool.py', 21:11:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:11:26 INFO - '/tools/misc-python/virtualenv.py')}, 21:11:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:11:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:11:26 INFO - 'installer_path': 'installer.exe', 21:11:26 INFO - 'log_level': 'info', 21:11:26 INFO - 'log_name': 'talos', 21:11:26 INFO - 'log_to_console': True, 21:11:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:11:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:11:26 INFO - 'opt_config_files': (), 21:11:26 INFO - 'pip_index': False, 21:11:26 INFO - 'sps_profile': False, 21:11:26 INFO - 'sps_profile_interval': 0, 21:11:26 INFO - 'suite': 'dromaeojs', 21:11:26 INFO - 'system_bits': '32', 21:11:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:11:26 INFO - 'title': 'talos-linux64-ix-021', 21:11:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:11:26 INFO - 'use_talos_json': True, 21:11:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:11:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:11:26 INFO - 'work_dir': 'build'} 21:11:26 INFO - [mozharness: 2016-08-10 04:11:26.350887Z] Running clobber step. 21:11:26 INFO - Running pre-action listener: _resource_record_pre_action 21:11:26 INFO - Running main action method: clobber 21:11:26 INFO - rmtree: /builds/slave/test/build 21:11:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:11:26 INFO - Running post-action listener: _resource_record_post_action 21:11:26 INFO - [mozharness: 2016-08-10 04:11:26.816024Z] Finished clobber step (success) 21:11:26 INFO - [mozharness: 2016-08-10 04:11:26.816125Z] Running read-buildbot-config step. 21:11:26 INFO - Running pre-action listener: _resource_record_pre_action 21:11:26 INFO - Running main action method: read_buildbot_config 21:11:26 INFO - Using buildbot properties: 21:11:26 INFO - { 21:11:26 INFO - "project": "", 21:11:26 INFO - "product": "firefox", 21:11:26 INFO - "script_repo_revision": "production", 21:11:26 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 21:11:26 INFO - "repository": "", 21:11:26 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 21:11:26 INFO - "buildid": "20160809183001", 21:11:26 INFO - "pgo_build": "True", 21:11:26 INFO - "basedir": "/builds/slave/test", 21:11:26 INFO - "buildnumber": 107, 21:11:26 INFO - "slavename": "talos-linux64-ix-021", 21:11:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:11:26 INFO - "platform": "ubuntu64_hw", 21:11:26 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 21:11:26 INFO - "branch": "autoland", 21:11:26 INFO - "repo_path": "integration/autoland", 21:11:26 INFO - "revision": "15d404ae1609b59cc09436df4f3a1ed46a57346d", 21:11:26 INFO - "stage_platform": "linux64-pgo", 21:11:26 INFO - "builduid": "7829f6a628ea491eb4d3e10f7f40e457", 21:11:26 INFO - "slavebuilddir": "test" 21:11:26 INFO - } 21:11:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 21:11:26 INFO - Running post-action listener: _resource_record_post_action 21:11:26 INFO - [mozharness: 2016-08-10 04:11:26.818763Z] Finished read-buildbot-config step (success) 21:11:26 INFO - [mozharness: 2016-08-10 04:11:26.818851Z] Running download-and-extract step. 21:11:26 INFO - Running pre-action listener: _resource_record_pre_action 21:11:26 INFO - Running main action method: download_and_extract 21:11:26 INFO - mkdir: /builds/slave/test/build/tests 21:11: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')]} 21:11:26 INFO - trying https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:11:26 INFO - Downloading https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:11:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:11:27 INFO - Downloaded 1361 bytes. 21:11:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:11:27 INFO - Using the following test package requirements: 21:11:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:11:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:11:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:11:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:11:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:11:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:11:27 INFO - u'jsshell-linux-x86_64.zip'], 21:11:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:11:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:11:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:11:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:11:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:11:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:11:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:11:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:11:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:11:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:11:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:11:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:11: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')]} 21:11:27 INFO - trying https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:11:27 INFO - Downloading https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:11:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:11:28 INFO - Downloaded 21831190 bytes. 21:11: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'] 21:11: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 21:11:29 INFO - Return code: 0 21:11: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 21:11: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')]} 21:11:29 INFO - trying https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:11:29 INFO - Downloading https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:11:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:11:30 INFO - Downloaded 21831190 bytes. 21:11: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'] 21:11: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 21:11:31 INFO - Return code: 0 21:11: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')]} 21:11:31 INFO - trying https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 21:11:31 INFO - Downloading https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:11:32 INFO - Downloaded 14413723 bytes. 21:11: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'] 21:11: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 21:11:32 INFO - Return code: 0 21:11: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')]} 21:11:32 INFO - trying https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:11:32 INFO - Downloading https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:11:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/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 21:11:34 INFO - Downloaded 59343507 bytes. 21:11:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:11:34 INFO - mkdir: /builds/slave/test/properties 21:11:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:11:34 INFO - Writing to file /builds/slave/test/properties/build_url 21:11:34 INFO - Contents: 21:11:34 INFO - build_url:https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:11:35 INFO - Running post-action listener: _resource_record_post_action 21:11:35 INFO - Running post-action listener: set_extra_try_arguments 21:11:35 INFO - [mozharness: 2016-08-10 04:11:35.000745Z] Finished download-and-extract step (success) 21:11:35 INFO - [mozharness: 2016-08-10 04:11:35.000978Z] Running populate-webroot step. 21:11:35 INFO - Running pre-action listener: _resource_record_pre_action 21:11:35 INFO - Running main action method: populate_webroot 21:11:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:11:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:11:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:11:35 INFO - '--tppagecycles', 21:11:35 INFO - '7'], 21:11:35 INFO - 'tests': ['tsvgm']}}, 21:11:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:11:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:11:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:11:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:11:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:11:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:11:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:11:35 INFO - 'talos_options': ['--disable-e10s'], 21:11:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:11:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:11:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:11:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:11:35 INFO - 'talos_options': ['--disable-e10s'], 21:11:35 INFO - 'tests': ['damp', 'tps']}, 21:11:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:11:35 INFO - 'tests': ['damp', 'tps']}, 21:11:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:11:35 INFO - 'tests': ['dromaeo_dom']}, 21:11:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:11:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:11:35 INFO - 'tests': ['basic_compositor_video']}, 21:11:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:11:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:11:35 INFO - 'tests': ['a11yr', 21:11:35 INFO - 'ts_paint', 21:11:35 INFO - 'tpaint', 21:11:35 INFO - 'sessionrestore', 21:11:35 INFO - 'sessionrestore_no_auto_restore', 21:11:35 INFO - 'tabpaint']}, 21:11:35 INFO - 'other-e10s': {'tests': ['a11yr', 21:11:35 INFO - 'ts_paint', 21:11:35 INFO - 'tpaint', 21:11:35 INFO - 'sessionrestore', 21:11:35 INFO - 'sessionrestore_no_auto_restore', 21:11:35 INFO - 'tabpaint']}, 21:11:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:11:35 INFO - 'ts_paint', 21:11:35 INFO - 'tpaint', 21:11:35 INFO - 'sessionrestore', 21:11:35 INFO - 'sessionrestore_no_auto_restore', 21:11:35 INFO - 'tabpaint']}, 21:11:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:11:35 INFO - 'ts_paint', 21:11:35 INFO - 'tpaint', 21:11:35 INFO - 'sessionrestore', 21:11:35 INFO - 'sessionrestore_no_auto_restore', 21:11:35 INFO - 'tabpaint']}, 21:11:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:11:35 INFO - 'tests': ['a11yr', 21:11:35 INFO - 'ts_paint', 21:11:35 INFO - 'tpaint', 21:11:35 INFO - 'sessionrestore', 21:11:35 INFO - 'sessionrestore_no_auto_restore', 21:11:35 INFO - 'tabpaint']}, 21:11:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:11:35 INFO - 'tests': ['a11yr', 21:11:35 INFO - 'ts_paint', 21:11:35 INFO - 'tpaint', 21:11:35 INFO - 'sessionrestore', 21:11:35 INFO - 'sessionrestore_no_auto_restore', 21:11:35 INFO - 'tabpaint']}, 21:11:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:11:35 INFO - 'tests': ['tsvgx', 21:11:35 INFO - 'tsvgr_opacity', 21:11:35 INFO - 'tart', 21:11:35 INFO - 'tscrollx', 21:11:35 INFO - 'cart']}, 21:11:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:11:35 INFO - 'tsvgr_opacity', 21:11:35 INFO - 'tart', 21:11:35 INFO - 'tscrollx', 21:11:35 INFO - 'cart']}, 21:11:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:11:35 INFO - 'talos_options': ['--disable-e10s'], 21:11:35 INFO - 'tests': ['tp5o']}, 21:11:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:11:35 INFO - 'tests': ['tp5o']}, 21:11:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:11:35 INFO - 'talos_options': ['--disable-e10s', 21:11:35 INFO - '--xperf_path', 21:11:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:11:35 INFO - 'tests': ['tp5n']}, 21:11:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:11:35 INFO - 'talos_options': ['--xperf_path', 21:11:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:11:35 INFO - 'tests': ['tp5n']}}, 21:11:35 INFO - 'talos.zip': {'path': '', 21:11:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:11:35 INFO - Running post-action listener: _resource_record_post_action 21:11:35 INFO - [mozharness: 2016-08-10 04:11:35.022284Z] Finished populate-webroot step (success) 21:11:35 INFO - [mozharness: 2016-08-10 04:11:35.022373Z] Running create-virtualenv step. 21:11:35 INFO - Running pre-action listener: _resource_record_pre_action 21:11:35 INFO - Running main action method: create_virtualenv 21:11:35 INFO - Creating virtualenv /builds/slave/test/build/venv 21:11:35 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 21:11:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:11:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:11:35 INFO - Using real prefix '/usr' 21:11:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:11:36 INFO - Installing distribute.............................................................................................................................................................................................done. 21:11:37 INFO - Installing pip.................done. 21:11:37 INFO - Return code: 0 21:11:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:11:37 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')]} 21:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11: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')]} 21:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11: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 0x18f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb83b0>, '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 0x1bb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', '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 21:11: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 21:11: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 21:11:38 INFO - Using env: {'DISPLAY': ':0', 21:11:38 INFO - 'HOME': '/home/cltbld', 21:11:38 INFO - 'LANG': 'en_US.UTF-8', 21:11:38 INFO - 'LANGUAGE': 'en_US:en', 21:11:38 INFO - 'LOGNAME': 'cltbld', 21:11:38 INFO - 'MAIL': '/var/mail/cltbld', 21:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:38 INFO - 'MOZ_NO_REMOTE': '1', 21:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:38 INFO - 'NO_EM_RESTART': '1', 21:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:38 INFO - 'PWD': '/builds/slave/test', 21:11:38 INFO - 'SHELL': '/bin/bash', 21:11:38 INFO - 'SHLVL': '1', 21:11:38 INFO - 'TERM': 'linux', 21:11:38 INFO - 'TMOUT': '86400', 21:11:38 INFO - 'USER': 'cltbld', 21:11:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', 21:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:38 INFO - '_': '/tools/buildbot/bin/python'} 21:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:38 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 21:11:38 INFO - Cleaning up... 21:11:38 INFO - Return code: 0 21:11:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:11: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')]} 21:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11: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')]} 21:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11: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', '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 0x18f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb83b0>, '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 0x1bb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', '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 21:11: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', 'psutil>=3.1.1'] in /builds/slave/test/build 21:11: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 psutil>=3.1.1 21:11:38 INFO - Using env: {'DISPLAY': ':0', 21:11:38 INFO - 'HOME': '/home/cltbld', 21:11:38 INFO - 'LANG': 'en_US.UTF-8', 21:11:38 INFO - 'LANGUAGE': 'en_US:en', 21:11:38 INFO - 'LOGNAME': 'cltbld', 21:11:38 INFO - 'MAIL': '/var/mail/cltbld', 21:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:38 INFO - 'MOZ_NO_REMOTE': '1', 21:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:38 INFO - 'NO_EM_RESTART': '1', 21:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:38 INFO - 'PWD': '/builds/slave/test', 21:11:38 INFO - 'SHELL': '/bin/bash', 21:11:38 INFO - 'SHLVL': '1', 21:11:38 INFO - 'TERM': 'linux', 21:11:38 INFO - 'TMOUT': '86400', 21:11:38 INFO - 'USER': 'cltbld', 21:11:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', 21:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:38 INFO - '_': '/tools/buildbot/bin/python'} 21:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:38 INFO - Downloading/unpacking psutil>=3.1.1 21:11:38 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 21:11:38 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 21:11:38 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 21:11:38 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 21:11:38 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 21:11:38 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 21:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:11:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:11:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:11:40 INFO - Installing collected packages: psutil 21:11:40 INFO - Running setup.py install for psutil 21:11:40 INFO - building 'psutil._psutil_linux' extension 21:11:40 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 21:11:40 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 21:11:40 INFO - building 'psutil._psutil_posix' extension 21:11:40 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 21:11:40 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 21:11:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:11:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:11:40 INFO - Successfully installed psutil 21:11:40 INFO - Cleaning up... 21:11:40 INFO - Return code: 0 21:11:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:11:40 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')]} 21:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:40 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')]} 21:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:40 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 0x18f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb83b0>, '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 0x1bb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', '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 21:11:40 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 21:11:40 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 21:11:40 INFO - Using env: {'DISPLAY': ':0', 21:11:40 INFO - 'HOME': '/home/cltbld', 21:11:40 INFO - 'LANG': 'en_US.UTF-8', 21:11:40 INFO - 'LANGUAGE': 'en_US:en', 21:11:40 INFO - 'LOGNAME': 'cltbld', 21:11:40 INFO - 'MAIL': '/var/mail/cltbld', 21:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:40 INFO - 'MOZ_NO_REMOTE': '1', 21:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:40 INFO - 'NO_EM_RESTART': '1', 21:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:40 INFO - 'PWD': '/builds/slave/test', 21:11:40 INFO - 'SHELL': '/bin/bash', 21:11:40 INFO - 'SHLVL': '1', 21:11:40 INFO - 'TERM': 'linux', 21:11:40 INFO - 'TMOUT': '86400', 21:11:40 INFO - 'USER': 'cltbld', 21:11:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', 21:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:40 INFO - '_': '/tools/buildbot/bin/python'} 21:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:11: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 21:11: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 21:11: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 21:11: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 21:11: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 21:11: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 21:11:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:11:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:11:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:11:43 INFO - Installing collected packages: mozsystemmonitor 21:11:43 INFO - Running setup.py install for mozsystemmonitor 21:11:43 INFO - Successfully installed mozsystemmonitor 21:11:43 INFO - Cleaning up... 21:11:43 INFO - Return code: 0 21:11:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:43 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 0x18f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb83b0>, '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 0x1bb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', '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 21:11:43 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 21:11:43 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 21:11:43 INFO - Using env: {'DISPLAY': ':0', 21:11:43 INFO - 'HOME': '/home/cltbld', 21:11:43 INFO - 'LANG': 'en_US.UTF-8', 21:11:43 INFO - 'LANGUAGE': 'en_US:en', 21:11:43 INFO - 'LOGNAME': 'cltbld', 21:11:43 INFO - 'MAIL': '/var/mail/cltbld', 21:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:43 INFO - 'MOZ_NO_REMOTE': '1', 21:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:43 INFO - 'NO_EM_RESTART': '1', 21:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:43 INFO - 'PWD': '/builds/slave/test', 21:11:43 INFO - 'SHELL': '/bin/bash', 21:11:43 INFO - 'SHLVL': '1', 21:11:43 INFO - 'TERM': 'linux', 21:11:43 INFO - 'TMOUT': '86400', 21:11:43 INFO - 'USER': 'cltbld', 21:11:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', 21:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:43 INFO - '_': '/tools/buildbot/bin/python'} 21:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:43 INFO - Downloading/unpacking jsonschema==2.5.1 21:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:11:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:45 INFO - Downloading functools32-3.2.3-2.tar.gz 21:11:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:11:45 INFO - warning: no files found matching '*.txt' 21:11:45 INFO - no previously-included directories found matching 'build' 21:11:45 INFO - no previously-included directories found matching 'dist' 21:11:45 INFO - no previously-included directories found matching '.git*' 21:11:45 INFO - Installing collected packages: jsonschema, functools32 21:11:45 INFO - Running setup.py install for functools32 21:11:45 INFO - warning: no files found matching '*.txt' 21:11:45 INFO - no previously-included directories found matching 'build' 21:11:45 INFO - no previously-included directories found matching 'dist' 21:11:45 INFO - no previously-included directories found matching '.git*' 21:11:45 INFO - Successfully installed jsonschema functools32 21:11:45 INFO - Cleaning up... 21:11:45 INFO - Return code: 0 21:11:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb83b0>, '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 0x1bb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', '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 21:11:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:11:45 INFO - Using env: {'DISPLAY': ':0', 21:11:45 INFO - 'HOME': '/home/cltbld', 21:11:45 INFO - 'LANG': 'en_US.UTF-8', 21:11:45 INFO - 'LANGUAGE': 'en_US:en', 21:11:45 INFO - 'LOGNAME': 'cltbld', 21:11:45 INFO - 'MAIL': '/var/mail/cltbld', 21:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:45 INFO - 'MOZ_NO_REMOTE': '1', 21:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:45 INFO - 'NO_EM_RESTART': '1', 21:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:45 INFO - 'PWD': '/builds/slave/test', 21:11:45 INFO - 'SHELL': '/bin/bash', 21:11:45 INFO - 'SHLVL': '1', 21:11:45 INFO - 'TERM': 'linux', 21:11:45 INFO - 'TMOUT': '86400', 21:11:45 INFO - 'USER': 'cltbld', 21:11:45 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', 21:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:45 INFO - '_': '/tools/buildbot/bin/python'} 21:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:11:46 INFO - Cleaning up... 21:11:46 INFO - Return code: 0 21:11:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:11: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')]} 21:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11: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')]} 21:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11: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 0x18f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb83b0>, '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 0x1bb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', '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 21:11: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 21:11: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 21:11:46 INFO - Using env: {'DISPLAY': ':0', 21:11:46 INFO - 'HOME': '/home/cltbld', 21:11:46 INFO - 'LANG': 'en_US.UTF-8', 21:11:46 INFO - 'LANGUAGE': 'en_US:en', 21:11:46 INFO - 'LOGNAME': 'cltbld', 21:11:46 INFO - 'MAIL': '/var/mail/cltbld', 21:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:46 INFO - 'MOZ_NO_REMOTE': '1', 21:11:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:46 INFO - 'NO_EM_RESTART': '1', 21:11:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:46 INFO - 'PWD': '/builds/slave/test', 21:11:46 INFO - 'SHELL': '/bin/bash', 21:11:46 INFO - 'SHLVL': '1', 21:11:46 INFO - 'TERM': 'linux', 21:11:46 INFO - 'TMOUT': '86400', 21:11:46 INFO - 'USER': 'cltbld', 21:11:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', 21:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:46 INFO - '_': '/tools/buildbot/bin/python'} 21:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:46 INFO - Downloading/unpacking blobuploader==1.2.4 21:11: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 21:11: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 21:11: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 21:11: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 21:11: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 21:11: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 21:11:48 INFO - Downloading blobuploader-1.2.4.tar.gz 21:11:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:11:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:11:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:48 INFO - Downloading docopt-0.6.1.tar.gz 21:11:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:11:49 INFO - Installing collected packages: blobuploader, requests, docopt 21:11:49 INFO - Running setup.py install for blobuploader 21:11:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:11:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:11:49 INFO - Running setup.py install for requests 21:11:49 INFO - Running setup.py install for docopt 21:11:49 INFO - Successfully installed blobuploader requests docopt 21:11:49 INFO - Cleaning up... 21:11:49 INFO - Return code: 0 21:11:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:11:49 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')]} 21:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:49 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')]} 21:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:49 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 0x18f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb83b0>, '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 0x1bb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', '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 21:11:49 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 21:11:49 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 21:11:49 INFO - Using env: {'DISPLAY': ':0', 21:11:49 INFO - 'HOME': '/home/cltbld', 21:11:49 INFO - 'LANG': 'en_US.UTF-8', 21:11:49 INFO - 'LANGUAGE': 'en_US:en', 21:11:49 INFO - 'LOGNAME': 'cltbld', 21:11:49 INFO - 'MAIL': '/var/mail/cltbld', 21:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:49 INFO - 'MOZ_NO_REMOTE': '1', 21:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:49 INFO - 'NO_EM_RESTART': '1', 21:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:49 INFO - 'PWD': '/builds/slave/test', 21:11:49 INFO - 'SHELL': '/bin/bash', 21:11:49 INFO - 'SHLVL': '1', 21:11:49 INFO - 'TERM': 'linux', 21:11:49 INFO - 'TMOUT': '86400', 21:11:49 INFO - 'USER': 'cltbld', 21:11:49 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', 21:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:49 INFO - '_': '/tools/buildbot/bin/python'} 21:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:11:49 INFO - Running setup.py (path:/tmp/pip-JkqgUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:11:49 INFO - Running setup.py (path:/tmp/pip-_ctv7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:11:49 INFO - Running setup.py (path:/tmp/pip-EuDDtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:11:50 INFO - Running setup.py (path:/tmp/pip-XIoOTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:11:50 INFO - Running setup.py (path:/tmp/pip-YuJlsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:11:50 INFO - Running setup.py (path:/tmp/pip-kGnbWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:11:50 INFO - Running setup.py (path:/tmp/pip-IAfXYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:11:50 INFO - Running setup.py (path:/tmp/pip-YdXEpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:11:50 INFO - Running setup.py (path:/tmp/pip-ORGcOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:11:50 INFO - Running setup.py (path:/tmp/pip-sEmPGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:11:50 INFO - Running setup.py (path:/tmp/pip-UEELAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:11:50 INFO - Running setup.py (path:/tmp/pip-FXGVJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:11:50 INFO - Running setup.py (path:/tmp/pip-jV5mY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:11:50 INFO - Running setup.py (path:/tmp/pip-JsNJh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:11:50 INFO - Running setup.py (path:/tmp/pip-Ukoo0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:11:50 INFO - Running setup.py (path:/tmp/pip-WjLLEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:11:50 INFO - Running setup.py (path:/tmp/pip-SSqERb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:11:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:11:51 INFO - Running setup.py install for manifestparser 21:11:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:11:51 INFO - Running setup.py install for mozcrash 21:11:51 INFO - Running setup.py install for mozdebug 21:11:51 INFO - Running setup.py install for mozdevice 21:11:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:11:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:11:51 INFO - Running setup.py install for mozfile 21:11:51 INFO - Running setup.py install for mozhttpd 21:11:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:11:51 INFO - Running setup.py install for mozinfo 21:11:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:11:51 INFO - Running setup.py install for mozInstall 21:11:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:11:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:11:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:11:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:11:51 INFO - Running setup.py install for mozleak 21:11:51 INFO - Running setup.py install for mozlog 21:11:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:11:52 INFO - Running setup.py install for moznetwork 21:11:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:11:52 INFO - Running setup.py install for mozprocess 21:11:52 INFO - Running setup.py install for mozprofile 21:11:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:11:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:11:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:11:52 INFO - Running setup.py install for mozrunner 21:11:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:11:52 INFO - Running setup.py install for mozscreenshot 21:11:52 INFO - Running setup.py install for moztest 21:11:52 INFO - Running setup.py install for mozversion 21:11:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:11:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:11:52 INFO - Cleaning up... 21:11:52 INFO - Return code: 0 21:11:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:52 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 0x18f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb83b0>, '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 0x1bb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', '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 21:11:52 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 21:11:52 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 21:11:52 INFO - Using env: {'DISPLAY': ':0', 21:11:52 INFO - 'HOME': '/home/cltbld', 21:11:52 INFO - 'LANG': 'en_US.UTF-8', 21:11:52 INFO - 'LANGUAGE': 'en_US:en', 21:11:52 INFO - 'LOGNAME': 'cltbld', 21:11:52 INFO - 'MAIL': '/var/mail/cltbld', 21:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:52 INFO - 'MOZ_NO_REMOTE': '1', 21:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:52 INFO - 'NO_EM_RESTART': '1', 21:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:52 INFO - 'PWD': '/builds/slave/test', 21:11:52 INFO - 'SHELL': '/bin/bash', 21:11:52 INFO - 'SHLVL': '1', 21:11:52 INFO - 'TERM': 'linux', 21:11:52 INFO - 'TMOUT': '86400', 21:11:52 INFO - 'USER': 'cltbld', 21:11:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', 21:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:52 INFO - '_': '/tools/buildbot/bin/python'} 21:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:11:53 INFO - Running setup.py (path:/tmp/pip-uBcAA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:11: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)) 21:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:11:53 INFO - Running setup.py (path:/tmp/pip-35Nm1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:11: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)) 21:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:11:53 INFO - Running setup.py (path:/tmp/pip-RyZOxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:11:53 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)) 21:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:11:53 INFO - Running setup.py (path:/tmp/pip-1EZzQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:11:53 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)) 21:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:11:53 INFO - Running setup.py (path:/tmp/pip-JxHwUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:11:53 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)) 21:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:11:53 INFO - Running setup.py (path:/tmp/pip-dWE21S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:11:53 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)) 21:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:11:53 INFO - Running setup.py (path:/tmp/pip-fDcwb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:11:53 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)) 21:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:11:53 INFO - Running setup.py (path:/tmp/pip-DhU9nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:11:53 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)) 21:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:11:53 INFO - Running setup.py (path:/tmp/pip-RmDeSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:11:53 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)) 21:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:11:53 INFO - Running setup.py (path:/tmp/pip-xmSVpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:11:53 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)) 21:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:11:53 INFO - Running setup.py (path:/tmp/pip-F0heo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:11:53 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)) 21:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:11:53 INFO - Running setup.py (path:/tmp/pip-nP_2EI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:11:53 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)) 21:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:11:53 INFO - Running setup.py (path:/tmp/pip-wYl2v_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:11: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)) 21:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:11:54 INFO - Running setup.py (path:/tmp/pip-HeWm_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:11: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)) 21:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:11:54 INFO - Running setup.py (path:/tmp/pip-dtVsXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:11: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)) 21:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:11:54 INFO - Running setup.py (path:/tmp/pip-fSgKla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:11: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)) 21:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:11:54 INFO - Running setup.py (path:/tmp/pip-8RcONy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:11:54 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)) 21:11:54 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)) 21:11:54 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)) 21:11:54 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)) 21:11:54 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)) 21:11:54 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)) 21:11:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:56 INFO - Downloading blessings-1.6.tar.gz 21:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:11:56 INFO - Installing collected packages: blessings 21:11:56 INFO - Running setup.py install for blessings 21:11:56 INFO - Successfully installed blessings 21:11:56 INFO - Cleaning up... 21:11:56 INFO - Return code: 0 21:11:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:11:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:11:56 INFO - Reading from file tmpfile_stdout 21:11:56 INFO - Current package versions: 21:11:56 INFO - argparse == 1.2.1 21:11:56 INFO - blessings == 1.6 21:11:56 INFO - blobuploader == 1.2.4 21:11:56 INFO - docopt == 0.6.1 21:11:56 INFO - functools32 == 3.2.3-2 21:11:56 INFO - jsonschema == 2.5.1 21:11:56 INFO - manifestparser == 1.1 21:11:56 INFO - mozInstall == 1.12 21:11:56 INFO - mozcrash == 0.17 21:11:56 INFO - mozdebug == 0.1 21:11:56 INFO - mozdevice == 0.48 21:11:56 INFO - mozfile == 1.2 21:11:56 INFO - mozhttpd == 0.7 21:11:56 INFO - mozinfo == 0.9 21:11:56 INFO - mozleak == 0.1 21:11:56 INFO - mozlog == 3.3 21:11:56 INFO - moznetwork == 0.27 21:11:56 INFO - mozprocess == 0.23 21:11:56 INFO - mozprofile == 0.28 21:11:56 INFO - mozrunner == 6.12 21:11:56 INFO - mozscreenshot == 0.1 21:11:56 INFO - mozsystemmonitor == 0.3 21:11:56 INFO - moztest == 0.7 21:11:56 INFO - mozversion == 1.4 21:11:56 INFO - psutil == 3.1.1 21:11:56 INFO - requests == 1.2.3 21:11:56 INFO - wsgiref == 0.1.2 21:11:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:11:56 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')]} 21:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:56 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')]} 21:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:56 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 0x18f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb83b0>, '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 0x1bb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', '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 21:11:56 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 21:11:56 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 21:11:56 INFO - Using env: {'DISPLAY': ':0', 21:11:56 INFO - 'HOME': '/home/cltbld', 21:11:56 INFO - 'LANG': 'en_US.UTF-8', 21:11:56 INFO - 'LANGUAGE': 'en_US:en', 21:11:56 INFO - 'LOGNAME': 'cltbld', 21:11:56 INFO - 'MAIL': '/var/mail/cltbld', 21:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:56 INFO - 'MOZ_NO_REMOTE': '1', 21:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:56 INFO - 'NO_EM_RESTART': '1', 21:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:56 INFO - 'PWD': '/builds/slave/test', 21:11:56 INFO - 'SHELL': '/bin/bash', 21:11:56 INFO - 'SHLVL': '1', 21:11:56 INFO - 'TERM': 'linux', 21:11:56 INFO - 'TMOUT': '86400', 21:11:56 INFO - 'USER': 'cltbld', 21:11:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', 21:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:56 INFO - '_': '/tools/buildbot/bin/python'} 21:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:56 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)) 21:11:56 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)) 21:11:56 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)) 21:11:56 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)) 21:11:56 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)) 21:11:56 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)) 21:11:56 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)) 21:11:56 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)) 21:11:56 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)) 21:11:56 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)) 21:11:56 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)) 21:11:56 INFO - Cleaning up... 21:11:56 INFO - Return code: 0 21:11:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:11:56 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')]} 21:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:56 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')]} 21:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:56 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 0x18f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb83b0>, '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 0x1bb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', '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 21:11:56 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 21:11:56 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 21:11:56 INFO - Using env: {'DISPLAY': ':0', 21:11:56 INFO - 'HOME': '/home/cltbld', 21:11:56 INFO - 'LANG': 'en_US.UTF-8', 21:11:56 INFO - 'LANGUAGE': 'en_US:en', 21:11:56 INFO - 'LOGNAME': 'cltbld', 21:11:56 INFO - 'MAIL': '/var/mail/cltbld', 21:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:56 INFO - 'MOZ_NO_REMOTE': '1', 21:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:56 INFO - 'NO_EM_RESTART': '1', 21:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:56 INFO - 'PWD': '/builds/slave/test', 21:11:56 INFO - 'SHELL': '/bin/bash', 21:11:56 INFO - 'SHLVL': '1', 21:11:56 INFO - 'TERM': 'linux', 21:11:56 INFO - 'TMOUT': '86400', 21:11:56 INFO - 'USER': 'cltbld', 21:11:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', 21:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:56 INFO - '_': '/tools/buildbot/bin/python'} 21:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:11:57 INFO - Cleaning up... 21:11:57 INFO - Return code: 0 21:11:57 INFO - Running post-action listener: _resource_record_post_action 21:11:57 INFO - Running post-action listener: _start_resource_monitoring 21:11:57 INFO - Starting resource monitoring. 21:11:57 INFO - [mozharness: 2016-08-10 04:11:57.150312Z] Finished create-virtualenv step (success) 21:11:57 INFO - [mozharness: 2016-08-10 04:11:57.150751Z] Running install step. 21:11:57 INFO - Running pre-action listener: _resource_record_pre_action 21:11:57 INFO - Running main action method: install 21:11:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:11:57 INFO - Reading from file tmpfile_stdout 21:11:57 INFO - Detecting whether we're running mozinstall >=1.0... 21:11:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:11:57 INFO - Reading from file tmpfile_stdout 21:11:57 INFO - Output received: 21:11:57 INFO - Usage: mozinstall [options] installer 21:11:57 INFO - Options: 21:11:57 INFO - -h, --help show this help message and exit 21:11:57 INFO - -d DEST, --destination=DEST 21:11:57 INFO - Directory to install application into. [default: 21:11:57 INFO - "/builds/slave/test"] 21:11:57 INFO - --app=APP Application being installed. [default: firefox] 21:11:57 INFO - mkdir: /builds/slave/test/build/application 21:11:57 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'] 21:11:57 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 21:12:14 INFO - Reading from file tmpfile_stdout 21:12:14 INFO - Output received: 21:12:14 INFO - /builds/slave/test/build/application/firefox/firefox 21:12:14 INFO - Running post-action listener: _resource_record_post_action 21:12:14 INFO - [mozharness: 2016-08-10 04:12:14.406087Z] Finished install step (success) 21:12:14 INFO - [mozharness: 2016-08-10 04:12:14.406235Z] Running run-tests step. 21:12:14 INFO - Running pre-action listener: _resource_record_pre_action 21:12:14 INFO - Running main action method: run_tests 21:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:12:14 INFO - Python 2.7.3 21:12:14 INFO - Return code: 0 21:12:14 INFO - grabbing minidump binary from tooltool 21:12:14 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')]} 21:12:14 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 0x1bb83b0>, '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 0x1bb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:12:14 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 21:12:14 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 21:12:14 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 21:12:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:12:14 INFO - Return code: 0 21:12:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:12:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:12:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:12:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:12:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:12:14 INFO - Using env: {'DISPLAY': ':0', 21:12:14 INFO - 'HOME': '/home/cltbld', 21:12:14 INFO - 'LANG': 'en_US.UTF-8', 21:12:14 INFO - 'LANGUAGE': 'en_US:en', 21:12:14 INFO - 'LOGNAME': 'cltbld', 21:12:14 INFO - 'MAIL': '/var/mail/cltbld', 21:12:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:12:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:12:14 INFO - 'MOZ_NO_REMOTE': '1', 21:12:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:12:14 INFO - 'NO_EM_RESTART': '1', 21:12:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:12:14 INFO - 'PWD': '/builds/slave/test', 21:12:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:12:14 INFO - 'SHELL': '/bin/bash', 21:12:14 INFO - 'SHLVL': '1', 21:12:14 INFO - 'TERM': 'linux', 21:12:14 INFO - 'TMOUT': '86400', 21:12:14 INFO - 'USER': 'cltbld', 21:12:14 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470802119.966445-492577301', 21:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:12:14 INFO - '_': '/tools/buildbot/bin/python'} 21:12:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:12:15 INFO - mozversion application_buildid: 20160809183001 21:12:15 INFO - mozversion application_changeset: 15d404ae1609b59cc09436df4f3a1ed46a57346d 21:12:15 INFO - mozversion application_display_name: Nightly 21:12:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:12:15 INFO - mozversion application_name: Firefox 21:12:15 INFO - mozversion application_remotingname: firefox 21:12:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:12:15 INFO - mozversion application_vendor: Mozilla 21:12:15 INFO - mozversion application_version: 51.0a1 21:12:15 INFO - mozversion platform_buildid: 20160809183001 21:12:15 INFO - mozversion platform_changeset: 15d404ae1609b59cc09436df4f3a1ed46a57346d 21:12:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:12:15 INFO - mozversion platform_version: 51.0a1 21:12:15 INFO - using testdate: 1470802335 21:12:15 INFO - actual date: 1470802335 21:12:15 INFO - starting webserver on 'localhost:49769' 21:12:15 INFO - SUITE-START | Running 2 tests 21:12:15 INFO - TEST-START | dromaeo_css 21:12:15 INFO - operating with platform_type : linux_ 21:12:15 INFO - Initialising browser for dromaeo_css test... 21:12:15 INFO - TEST-INFO | started process 2173 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa02SVx/profile http://localhost:49769/getInfo.html) 21:12:21 INFO - PROCESS | 2173 | __metrics Screen width/height:1600/1200 21:12:21 INFO - PROCESS | 2173 | colorDepth:24 21:12:21 INFO - PROCESS | 2173 | Browser inner width/height: 1024/697 21:12:21 INFO - PROCESS | 2173 | __metrics 21:12:22 INFO - PROCESS | 2173 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:12:22 INFO - PROCESS | 2173 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:12:23 INFO - PROCESS | 2173 | console.error: PushService: 21:12:23 INFO - PROCESS | 2173 | stateChangeProcessEnqueue: Error transitioning state 21:12:23 INFO - PROCESS | 2173 | UnknownError 21:12:23 INFO - TEST-INFO | 2173: exit 0 21:12:23 INFO - Browser initialized. 21:12:23 INFO - Running cycle 1/1 for dromaeo_css test... 21:12:23 INFO - TEST-INFO | started process 2257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa02SVx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:12:35 INFO - PROCESS | 2257 | RSS: Main: 155852800 21:12:35 INFO - PROCESS | 2257 | 21:13:26 INFO - PROCESS | 2257 | 1470802406771 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] 21:15:36 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:49769/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49769/tests/dromaeo/cssquery-ext.html) 21:15:37 INFO - PROCESS | 2257 | RSS: Main: 247525376 21:15:37 INFO - PROCESS | 2257 | 21:18:39 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:49769/tests/dromaeo/cssquery-ext.html (next: http://localhost:49769/tests/dromaeo/cssquery-jquery.html) 21:18:40 INFO - PROCESS | 2257 | RSS: Main: 246145024 21:18:40 INFO - PROCESS | 2257 | 21:21:42 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:49769/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49769/tests/dromaeo/cssquery-mootools.html) 21:21:43 INFO - PROCESS | 2257 | RSS: Main: 187994112 21:21:43 INFO - PROCESS | 2257 | 21:24:45 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:49769/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49769/tests/dromaeo/cssquery-prototype.html) 21:24:45 INFO - PROCESS | 2257 | RSS: Main: 189526016 21:24:45 INFO - PROCESS | 2257 | 21:27:48 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:49769/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49769/tests/dromaeo/cssquery-yui.html) 21:27:48 INFO - PROCESS | 2257 | RSS: Main: 188608512 21:27:48 INFO - PROCESS | 2257 | 21:30:51 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:49769/tests/dromaeo/cssquery-yui.html (next: http://localhost:49769/tests/dromaeo/cssquery-dojo.html) 21:30:51 INFO - PROCESS | 2257 | RSS: Main: 274182144 21:30:51 INFO - PROCESS | 2257 | 21:30:51 INFO - PROCESS | 2257 | __start_tp_report 21:30:51 INFO - PROCESS | 2257 | _x_x_mozilla_page_load 21:30:51 INFO - PROCESS | 2257 | _x_x_mozilla_page_load_details 21:30:51 INFO - PROCESS | 2257 | |i|pagename|runs| 21:30:51 INFO - PROCESS | 2257 | |0;dojo.html;2948.24819670984;2997.8051426657253;3012.8041677290976;3092.026011806281;3093.814371137731;5308.946910530904;5338.172583249593;5351.197320401941;5440.727963601819;5456.9181462278;5368.946310536893;5371.623986320959;5427;5432.076546987012;5445.646033007852;4821.638377121712;4884.951150488485;4905.509449055084;4929.556339929406;5086.796528138889;4960.032793605248;4995.075910956485;5008.048470790538;5015.0972824891505;5017.498250174972;4802.4237091548885;4838.758062096898;4845.563899249049;4874.073925954093;4968.875778105558;4871.025794841011;4877.561019508225;4879.804807807684;4934.777934992934;4977.054359671651;4874.512548745132;4904.4605093439695;4904.5340692634145;4923.335349727777;4957.553820156168;5268.209768534713;5333.839984800462;5383.4616538346245;5404.1083221268445;5418.376886658006;5817.738201780888;5861.794837180678;5875.764969401219;5883.529317654577;5886.175935369009;5843.795467158671;5867.823965281048;5883.79406720767;5896.351401345849;5909.4090590941;5289.86775330616;5298.09932311508;5353.866153346197;5357.598180136505;5434.945650543523;5987.161797348374;6057;6059.575829691968;6060.969695151496;6061.878762424727;5786.189933409326;5796.1595568642315;5800.071988481823;5803.564732645069;5805.216295800013;5664.26364572603;5707.343655479673;5762.9135562966585;5769.711514424262;5856.765729370863;5752.9424705753245;5759.913601295984;5763.9135412968835;5769.8557536061935;5805.448482394166;5737.254156959569;5745.195672605839;5803.7968671096305;5805.651660900359;5807;4284.143171365739;4317.136572685476;4317.201317756162;4374.518802931675;4376.6498680105515;3897.3179693553516;3915.7454765440157;3919.1769728357363;3926.155876486569;3959.9604003960167;5436.864078398072;5444.972775136099;5481.177823326453;5488.423715509894;5491.039068163055;5847.44449277318;5851.385604511465;5852.882942341129;5861.20873682056;5868.501177399969;5226.555742761908;5371.597130215249;5381.30043094403;5439.646422982493;5452.536534394541;5056.620753443506;5061.848144555669;5063.240513922941;5065.341505604248;5109.08036553424;6103.725332360054;6117.449429551273;6124.387561243929;6124.969375153096;6126.08108783686;5569.526590239875;5762.4525670061275;5788.957987562279;5869.00226961409;5878.382769809279;6094.5014626406155;6099.563179733188;6102.901477734051;6104.9139292562195;6143.477804386677;5714.399988001366;5743.8851222976145;5758.654480731169;5786.392428795084;5808.21589085485;5561.63849349791;5662.980663480448;5859.589828711949;5876.559258055749;5880.676562789087;5600.60795744294;5665.603407761417;5666.2350582670815;5702.429757024264;5720.456556627114;5611.8877622448135;5649.491545760901;5650.0677388232125;5652.2086907833755;5655.830325090254;5436.755346009518;5523;5538.280023597068;5591.18927755465;5600.103983362643;5654.660720356792;5691.174779657009;5709.22925405065;5738.1679656450415;5751.166080918327;5537.031019571639;5573.331200255995;5588.497035266845;5589.776408943597;5591.133374326986 21:30:51 INFO - PROCESS | 2257 | |1;ext.html;602.8673691787807;621.7140115546848;623.8284471770263;630.2153818495973;636.2682914648157;33919.32161356774;36256.7368936796;43888.56111438889;45085.77457112718;45185.77407112968;47415.52584474154;48030;48072.278915816205;48092.2786158207;48094.51905480944;8814.691485798;8962.058983806704;8986.326025548078;8992.370534062618;8999.5050272235;8837.851079359674;8876.112388761105;8902.599383027748;8930.419522731034;8933.95533022334;8930.062343453941;8977.640894364251;9025.864612030824;9030.548472576378;9036.909630903705;8958.328125390557;8965.148310910454;9004.81990360189;9019;9021.323400744937;8811.911880881173;8881.289496840238;8896.154865287788;8897.199252067345;8900.287976961827;43704.781476092736;43953.78023109896;44114.117717645786;44166.116677666585;44171.337429938576;3722.3671975764187;3910.2179564087296;4293.205756934945;4363.694541382105;4424.247877860771;33277;33816;34160.31679366399;34209.31581368384;34559.13602159941;4318.3090705486975;4339.500957389909;4417.955820441786;4452.465704115527;4597.0116424968455;253026;253368;253578;253764;254802;58717;58824;58917.70541147267;59186.70406647939;59309;62455.37544624496;62495;62525.37474625195;62554.37445625576;62591.6870415645;15789.605259868365;15825.287862046236;15906;15944.2825072872;15949.88350815455;12227.877721222674;12228.449719762632;12241.632751017483;12253.693657658452;12289.201201921847;16053.839461605468;17256.482305530855;17421.738673919903;17434.738478922827;17440.912795436194;5461.9453805462235;6355.1420558224045;6364.840878978062;6491.480681545465;6537.607743535403;1016.9135623472088;1030.2177233386283;1071.3946620159586;1101.7245688577855;1110.8111621024284;32518.674813252037;33668.66331336655;34009.659903401145;34111.31777364439;34199.658003419645;1114.9163812713916;1154.5324143721807;1158.6060739348661;1173.0908545877014;1180.7520420711576;16785.58036049084;17617.885853697637;17665.38171164003;17772.822271777375;17805.198766055557;503667;507295;509939;514490;518238.270469177;60542.394576054554;60690.393096068474;60743.69628151831;60788.69605652032;60791.39208607857;1198.3049831097942;1290.8450985881566;1335.5325636027508;1345.065179700099;1347.4408120629828;33193.83403082969;34753.30493390169;34825.8258708715;34961.47557786686;35092;47007.76496117497;47374.76312618553;47390.28914566353;47394.76302618465;47411.28883066826;401596;402885;403179;405005;408041;29903.401931960805;30740.846295768377;30928.226794330323;31003.069907902798;42820.571794281655;49472.25791613057;49905.75047124741;50474.74762626163;50640;50750.74624626853;41815.37276940788;41861.37207941822;41962.79018604887;42641.573584265;43882.34176487419;42039.579604203565;42610;42944;42985;43803.78098109489;41518.16963660649;42171;43011.56988430201;43238.56761432345;43347.34978975381;35283.470747938285;36823.63176368309;37702.24595508129;38365;38557;28875.855620721763;29155.562666559596;29335.559966600944;29401.41197176002;29449.705502944696 21:30:51 INFO - PROCESS | 2257 | |2;jquery.html;378.2548379692006;397.73351854257663;406.2200574896199;413.46662804981577;424.11995110146455;13420.482328028687;19679.311224107158;20166.999999999964;20173.899130504327;20184.59630807383;12863.356832158379;13133.868661313383;13138.963460663588;13153.210807351566;13218;3966.8809935701975;5241.816536421226;5402.837914862561;5410.215518749779;5636.830895073133;5803.883922321551;5867.41325867412;5929.169916211712;5935.317438494563;5936.792212272571;5772.451617096369;5778.075507918734;5837.824865254049;5841.299044114712;5942.435468630495;5847.853803654922;5865;5886.323072846613;5888.941110588882;5893.5874488785585;5541.168824676291;5709.45760152789;5739.713014349266;5740.569457290678;5744.6840423776675;14382.137071775622;14499.927500362535;18874.62250754991;23351.299461016028;23583.646245306336;2253.2339004738305;2301.643245296965;2342.8711420871846;2441.389652586853;2489.850608963468;10555.525001374957;10626.574937002511;10969.341839489656;12813.679658008532;14086.506972256024;1897.4592241211326;1939.93210237641;1959.6864501679663;1983.514039060425;2046.0588129460466;65456.67271663659;66623.66688166528;73583.2641673587;80828.59585702093;88502.11497885003;9127.406718563272;9682.70951871431;9687.370320929118;9777.364471309342;10002.149817265614;13565.253911034988;13654.590362289147;13665.18008919468;13667.521636742666;13688.52090176859;7640.69437222516;7766.184550622216;8030.879536806952;8086.959565202136;8136.064352599408;7775.727849525239;7793.883091753628;7939.126696063428;7990.920090799018;8151.959240203761;4201.516825565038;4240.236757383639;4250.766207858597;4253.532111467736;4305.9569404306185;1962.9705554416696;2009.1260301768777;2032.6950957356514;2042.588009898612;2078.2622169130045;955.3646824861528;972.601233494264;1030.4384110659707;1035.0322448510667;1042.8696412948382;19730.90134549318;20464.079116439498;20575.794242057687;20637;20648.690269645966;1006.5470538257813;1008.5965613754411;1026.7381817636456;1049.6798476464598;1077.4881931082673;10817.83773243402;11436.599719009795;11503.827442588368;11535.71160720972;11542.711432214262;487080;489706;490861;492405;532632;85947;89610.55194723984;90323.54838225766;90703;92135;1006.8137394582026;1017.5217647705566;1049.753307972641;1050.1703654113317;1055.9155267578576;17840;18269.81730182681;18316.633667326845;18640.440786776417;18741.718874216625;43188.568114319714;43496;44223;45884;46720;61135;61422;61482.69258653678;61785.073223902575;62419;8158.673653053811;8298.834023319621;8355;8379.120192379956;8784.648614055366;9615.663451779154;12041.19382092658;12086.39568021613;12121.030317574396;12798.16811907223;10489.265751397328;10656;10757;10959.945200273947;11093.722656933642;10510.106640935606;10699.839502407625;11001.834972475259;11049.116070714485;11207.831882521605;10742.83885741699;11033.503492343025;11441.656750297505;11615.709607259887;11645.41772911368;8216.917830821616;8249.546274954935;8260.917390826015;8369.414141010315;8677.566121693764;8912.376133670581;10771.787370390248;11332.546698132312;11640.767184656428;11651.59219427316 21:30:51 INFO - PROCESS | 2257 | |3;mootools.html;1338.2128576129555;1452.027141814984;1502.4666243483562;1614.4510866305454;1794.4706311638074;8349.833003339938;8675.219230269282;8699.260562852158;8975.775605609846;9029.277657787377;8837.911620883806;8901.732948011553;8946;8955.328350373715;8964.058773828736;2401.4476670365825;2421.225207933462;2423.9394015149674;2424.903003879843;2429.0890915906534;2412.9034838606435;2442.7435119312395;2456.6806315179;2463.5072985402903;2465.543874383236;2369.609014512612;2387.510560335127;2394.916177933773;2403.795677367426;2419.854808711474;2359.9410014749596;2370.5969985102574;2391.354334329721;2416.081888882231;2416.1301931304715;2366.3019409274307;2368.97631023691;2409.506051259505;2409.590369637166;2411.5056413435204;8682.392232543725;8972.955135224347;8993.100689930954;8994.235489983359;8996.100389961017;5340.092184328634;5468.835934921959;5487.890242195173;5489.478499542537;5498.670079795185;3422.26421319415;3425.3320602482277;3459.9654003459896;3470.583529976394;3477.8087205203706;1082.8971247731454;1097.8847221041756;1106.8671759388844;1131.8868113188698;1146.9483873225724;12312.26126432408;12345.444454999546;12360;12396.566120185751;12413.131080824345;4503.234450143484;4509.098180363941;4636.83771068011;4645.256758918556;4761.571458568746;9244.214241789388;9251.907480925105;9260.21288190498;9260.444373337621;9291.117343852324;5338.519533242027;5352.223927530486;5356.0894647909945;5362.383325917492;5366.651167674088;4428.623566996777;4736.550027747358;4864.173090574611;4907.067657145131;4977.925331120036;3818.3699689550913;3868.207017561393;3951.940720889189;3959.3269144245546;3990.6009399060445;1144.5993902134353;1148.9310641361544;1156.3004382348727;1172.1853311948284;1188.6255829413708;889.2841262783392;926.786839027014;966.5747071288611;1007.9193664506822;1025.5590096258532;6114.2357205349335;6119.418655227746;6210.875782484325;6316.589421687576;6409.4231519163495;462.3065401897154;467.7661169415292;471.7028272188568;489.10249691815915;491.3882216640306;4266.360045993064;4366.410534577792;4498.212812757754;4540.387047748578;4551.0442807010895;10639.148868090535;10913.781724365468;11006.229563930608;11010.779784404427;11013.449327533592;10908.127349811995;10926.672199834018;10932.234743568033;10938;10941.070009049161;8023.277904988579;8305.792355191048;8334.541600211925;8488.702895398756;8514.78713032179;6337.524685648687;6388.265349484683;6427.967860160669;6428.517861160525;6520.478361731145;10166.644167454104;10372.636957706443;10374;10490.790184196121;10506.737331566772;9886.406815590799;10259.333143345659;10267.024632659886;10269.897301026895;10445.895541044492;7758.4181186410115;7951.761447156595;7980.880286795818;8331.166883311862;8474.491530508189;8352.83294334122;8498.490090594583;8608.268297194558;8655.30757539408;8842.911570884466;7654.770356889302;7780.610969451618;7898.802529936797;7910.864066702074;7946.046474423106;7573.394128469599;7652.73215437457;7687.461877668733;7704.345130663956;7807.531548107132;7083.150021997187;7204.675789589376;7217.350438460354;7221.566705997657;7221.819454513679;5339.759710812945;5455.563554915677;5521.558275338044;5562.3881373048125;5659.03796354629;5442.197119653973;5530.55755539564;5568.721563921707;5654.547636189012;5714 21:30:51 INFO - PROCESS | 2257 | |4;prototype.html;338.1411215512598;346.3938108310457;347.1754582865695;353.8054070261357;354.6418117701121;5221.973890130549;5306.973465132679;5313.309269794921;5316.5215130638235;5320.760565774535;5251;5273.815416460425;5280.762365693543;5281.471852814717;5284.656497327671;3700.962990370089;3990.7206495545324;4007.5591684914634;4074.5314288856716;4138.296489596776;4136.31750761124;4138.151678905832;4142.275101857178;4145.191687620915;4160.230357383879;4124.52567954686;4130.822715526076;4134.37984302354;4146.854860079898;4165.645920096796;3954.4661470701376;4036.4147198656324;4133.276676581586;4162.667946257199;4176.68674849386;3668.6147954464664;3687.8340474678703;3689.815509224528;3703.7962912039825;3712.1833196696684;5072.797088116471;5084.186530155194;5102.744862756885;5114.33513643224;5163.8192663256605;4419.62433193179;4646.3495110684535;4758.405199350082;4758.690685105457;4761.738104404257;5360.437154098841;5368.516833485005;5373.516383525502;5404.297441332602;5415.512603865671;3935.6851451884068;3958.6635136013474;3961.564227934925;3962.583928687504;3967.841286348543;5433.918491222635;5583.441655834384;5605.383407825136;5607.691576963265;5618.0449323614675;4021.8537716750584;4022.778747168934;4024.2353952748886;4033.596640335943;4047.494063242095;4092.7748973806133;4093.6256970956774;4093.7339072960162;4100.65144462718;4103.5691252418665;4566.315052742115;4666.160091183551;4675.883102922454;4689.015306785545;4701.177293973541;5437.728113594305;5449.754761035763;5461.726913654302;5477.507024367826;5478.931608336416;1391.7355702416507;1402.1236727045596;1408.7323408552343;1410.9435622574981;1411.371939486939;854.9273311768569;914.7804526913493;920.5535315372039;922.3220932614523;924.7179610218814;4671.182543054952;4676.386646606983;4686.179918514246;4687.695299805502;4727.858164255078;4910.288008238786;4974.562464392422;5014.749262536859;5018.820577164363;5025.246213067996;4622.2604383299185;4642.398372561461;4678.555537223959;4691.771408580965;4850;2923.640507164179;2962.333474968115;2969.5248760198265;2969.8171843694868;2977.1217490840254;5826.417358264224;5835.912461313083;5844.47399734026;5857.560682948796;5859.414058594191;5517.063773097127;5668.319801623749;5684.403137670568;5689.601727879009;5739.5695322850115;5496.7526461309335;5684.442001099522;5795.88408231833;5830.47525722687;5830.96789669378;5592.601849537616;5605.290386432014;5615.410381909841;5617.185508101221;5618.780581670136;5382.703951282717;5481.506664400223;5506.311711036121;5523.978064058162;5539.25220095282;5803.763252825545;5826.650400975955;5830.416958304136;5869.7945571904775;5887.58786884931;3988.8603898863403;3994.2211268802303;4010.733935326531;4013.7190396673122;4023.93964090533;5342.519173274424;5620.831375058755;5660.801871934463;5664.150377443417;5675.829725108253;5494.80768173128;5497.972510137423;5503.807366742145;5510.173473978935;5523;5479.917801232905;5495.175723641486;5508.20131080999;5515.172724091419;5536.584756143225;5204.739763011758;5427.6661035755005;5429.212764149097;5463.759858458013;5464.808731694372;5542.3626282977975;5547.8890422190525;5566.888662226814;5573.665580065047;5578.9163162553405;5201.6735732388;5432.945670543402;5457.890842183214;5460.481254280996;5479.109707151027 21:30:51 INFO - PROCESS | 2257 | |5;yui.html;713.7109470664379;754.5397307642337;808.4946908182386;820.478995837643;874.7987962768563;15057.698846023073;15432.305546250418;15547.92226038871;16304.673906521863;16315.673686526277;14751.926240368783;14932.40270389186;14991.700165996674;14995.700085998273;15009.474668386609;658.3383699382114;791.5369508837337;810.088650268448;819.9918000819976;822.5475988206492;814.7392834293029;819.4018366592392;823.983520329593;824.3364091906013;831.3847752663016;865.6061492021115;867.2281669314315;868.8045189832269;871.6077765005773;871.8038441350709;700.7337211859511;712.5261700968849;869.0483920107504;871.2681347667958;871.507598207011;523.8035736598775;608.3126067543692;619.4177473175201;620.5873094392224;624.6626821516376;15023.248837558078;15082.321295541728;15093.698126037527;15106.093634381863;15120.39518419262;14128.152310861278;14773.778393324108;14882.553523394316;14935.402583896739;14968;13884.4446222151;13981.231032293219;14017.299135043208;14284.214368209745;14321.57035288943;3841.2125514269505;4107.671386289119;4755.904881902343;4842.15262329091;4887.266909963499;79922.60038699828;80337.59831200865;81010.59494702489;81021.18978810195;81096.18903810946;11373.943130284295;11663.183577149688;11817.468213930393;11870.584529541424;12212.618539384735;19061.714074288895;19077.61844763125;19110.33113841009;19113.426597202106;19162.137703803084;8559.272461840814;8704.78238044054;8732.214100730966;8914.687985920462;9010.729678109667;4630;4668.486466488684;4789.592884604778;4811.975940120277;4868.634852386085;3684.09739613791;3833.463315135883;3834.6740527055513;3835.6356146166067;3842.558105817867;620.7423919073624;622.0979579609494;631.2677294338637;631.7915088020942;634.3086036220542;661.890788019981;689.9719418067044;706.8833642449041;717.9338682057141;797.3461761355633;9777.706668799947;9788.363756355815;10064.647737329306;10179.84730229047;10440.477976101316;647.6935245571384;700.2752151523149;735.7866218796596;747.0379943523953;763.8472305538914;4309.332053531708;4501.88745281364;4631.745254011062;4707.6233901287815;4708.223143181405;126123.3693831525;128011.35994320155;130811;132986;140604;112023.43988280007;114239.42880285712;117082.41458792651;118174.40912795381;119657;100773.16498181946;102883.48558257161;103757;105776;108096;10183.439910804977;10327.48362581853;10384.876567867845;10453.9477302613;10772.838407423738;52314;52431.47568524266;53601.73199134135;53733;53781.46218537921;75193;75538;75544;76420.61789691016;76559.23440765744;13394.531191408643;13417.463301468222;13597.184168949894;13747.793783093062;13752.793708094187;15451.922740386226;15479.767803482731;16010.359585616445;16258.187090645657;16688.666226675643;13734.313284335944;14590.343434545259;15013.099214047192;15120;15161.617769993285;11590.246633968765;13388.598342049754;13672.248026358247;13693.31533423305;14199.630093669779;13470.326483675974;13524.526641567498;13791.448342066205;13991;14546.854531454974;11629.941850291032;11650.825237621611;11887.524499019943;12283.754324913272;12315.19951203169;12156;12318.384080795746;12467.5012999479;12688.555900543437;12810 21:30:51 INFO - PROCESS | 2257 | __end_tp_report 21:30:51 INFO - PROCESS | 2257 | __start_cc_report 21:30:51 INFO - PROCESS | 2257 | _x_x_mozilla_cycle_collect,988 21:30:51 INFO - PROCESS | 2257 | __end_cc_report 21:30:51 INFO - PROCESS | 2257 | __startTimestamp1470803451852__endTimestamp 21:30:51 INFO - PROCESS | 2257 | 21:30:51 INFO - PROCESS | 2257 | ------- Summary: start ------- 21:30:51 INFO - PROCESS | 2257 | Number of tests: 6 21:30:51 INFO - PROCESS | 2257 | 21:30:51 INFO - PROCESS | 2257 | [#0] dojo.html Cycles:165 Average:5385.66 Median:5588.50 stddev:644.45 (11.5%) stddev-sans-first:617.41 21:30:51 INFO - PROCESS | 2257 | Values: 2948.2 2997.8 3012.8 3092.0 3093.8 5308.9 5338.2 5351.2 5440.7 5456.9 5368.9 5371.6 5427.0 5432.1 5445.6 4821.6 4885.0 4905.5 4929.6 5086.8 4960.0 4995.1 5008.0 5015.1 5017.5 4802.4 4838.8 4845.6 4874.1 4968.9 4871.0 4877.6 4879.8 4934.8 4977.1 4874.5 4904.5 4904.5 4923.3 4957.6 5268.2 5333.8 5383.5 5404.1 5418.4 5817.7 5861.8 5875.8 5883.5 5886.2 5843.8 5867.8 5883.8 5896.4 5909.4 5289.9 5298.1 5353.9 5357.6 5434.9 5987.2 6057.0 6059.6 6061.0 6061.9 5786.2 5796.2 5800.1 5803.6 5805.2 5664.3 5707.3 5762.9 5769.7 5856.8 5752.9 5759.9 5763.9 5769.9 5805.4 5737.3 5745.2 5803.8 5805.7 5807.0 4284.1 4317.1 4317.2 4374.5 4376.6 3897.3 3915.7 3919.2 3926.2 3960.0 5436.9 5445.0 5481.2 5488.4 5491.0 5847.4 5851.4 5852.9 5861.2 5868.5 5226.6 5371.6 5381.3 5439.6 5452.5 5056.6 5061.8 5063.2 5065.3 5109.1 6103.7 6117.4 6124.4 6125.0 6126.1 5569.5 5762.5 5789.0 5869.0 5878.4 6094.5 6099.6 6102.9 6104.9 6143.5 5714.4 5743.9 5758.7 5786.4 5808.2 5561.6 5663.0 5859.6 5876.6 5880.7 5600.6 5665.6 5666.2 5702.4 5720.5 5611.9 5649.5 5650.1 5652.2 5655.8 5436.8 5523.0 5538.3 5591.2 5600.1 5654.7 5691.2 5709.2 5738.2 5751.2 5537.0 5573.3 5588.5 5589.8 5591.1 21:30:51 INFO - PROCESS | 2257 | 21:30:51 INFO - PROCESS | 2257 | [#1] ext.html Cycles:180 Average:56598.95 Median:23664.94 stddev:106861.82 (451.6%) stddev-sans-first:107078.90 21:30:51 INFO - PROCESS | 2257 | Values: 602.9 621.7 623.8 630.2 636.3 33919.3 36256.7 43888.6 45085.8 45185.8 47415.5 48030.0 48072.3 48092.3 48094.5 8814.7 8962.1 8986.3 8992.4 8999.5 8837.9 8876.1 8902.6 8930.4 8934.0 8930.1 8977.6 9025.9 9030.5 9036.9 8958.3 8965.1 9004.8 9019.0 9021.3 8811.9 8881.3 8896.2 8897.2 8900.3 43704.8 43953.8 44114.1 44166.1 44171.3 3722.4 3910.2 4293.2 4363.7 4424.2 33277.0 33816.0 34160.3 34209.3 34559.1 4318.3 4339.5 4418.0 4452.5 4597.0 253026.0 253368.0 253578.0 253764.0 254802.0 58717.0 58824.0 58917.7 59186.7 59309.0 62455.4 62495.0 62525.4 62554.4 62591.7 15789.6 15825.3 15906.0 15944.3 15949.9 12227.9 12228.4 12241.6 12253.7 12289.2 16053.8 17256.5 17421.7 17434.7 17440.9 5461.9 6355.1 6364.8 6491.5 6537.6 1016.9 1030.2 1071.4 1101.7 1110.8 32518.7 33668.7 34009.7 34111.3 34199.7 1114.9 1154.5 1158.6 1173.1 1180.8 16785.6 17617.9 17665.4 17772.8 17805.2 503667.0 507295.0 509939.0 514490.0 518238.3 60542.4 60690.4 60743.7 60788.7 60791.4 1198.3 1290.8 1335.5 1345.1 1347.4 33193.8 34753.3 34825.8 34961.5 35092.0 47007.8 47374.8 47390.3 47394.8 47411.3 401596.0 402885.0 403179.0 405005.0 408041.0 29903.4 30740.8 30928.2 31003.1 42820.6 49472.3 49905.8 50474.7 50640.0 50750.7 41815.4 41861.4 41962.8 42641.6 43882.3 42039.6 42610.0 42944.0 42985.0 43803.8 41518.2 42171.0 43011.6 43238.6 43347.3 35283.5 36823.6 37702.2 38365.0 38557.0 28875.9 29155.6 29335.6 29401.4 29449.7 21:30:51 INFO - PROCESS | 2257 | 21:30:51 INFO - PROCESS | 2257 | [#2] jquery.html Cycles:180 Average:28787.70 Median:2465.62 stddev:82192.60 (3333.5%) stddev-sans-first:82395.49 21:30:51 INFO - PROCESS | 2257 | Values: 378.3 397.7 406.2 413.5 424.1 13420.5 19679.3 20167.0 20173.9 20184.6 12863.4 13133.9 13139.0 13153.2 13218.0 3966.9 5241.8 5402.8 5410.2 5636.8 5803.9 5867.4 5929.2 5935.3 5936.8 5772.5 5778.1 5837.8 5841.3 5942.4 5847.9 5865.0 5886.3 5888.9 5893.6 5541.2 5709.5 5739.7 5740.6 5744.7 14382.1 14499.9 18874.6 23351.3 23583.6 2253.2 2301.6 2342.9 2441.4 2489.9 10555.5 10626.6 10969.3 12813.7 14086.5 1897.5 1939.9 1959.7 1983.5 2046.1 65456.7 66623.7 73583.3 80828.6 88502.1 9127.4 9682.7 9687.4 9777.4 10002.1 13565.3 13654.6 13665.2 13667.5 13688.5 7640.7 7766.2 8030.9 8087.0 8136.1 7775.7 7793.9 7939.1 7990.9 8152.0 4201.5 4240.2 4250.8 4253.5 4306.0 1963.0 2009.1 2032.7 2042.6 2078.3 955.4 972.6 1030.4 1035.0 1042.9 19730.9 20464.1 20575.8 20637.0 20648.7 1006.5 1008.6 1026.7 1049.7 1077.5 10817.8 11436.6 11503.8 11535.7 11542.7 487080.0 489706.0 490861.0 492405.0 532632.0 85947.0 89610.6 90323.5 90703.0 92135.0 1006.8 1017.5 1049.8 1050.2 1055.9 17840.0 18269.8 18316.6 18640.4 18741.7 43188.6 43496.0 44223.0 45884.0 46720.0 61135.0 61422.0 61482.7 61785.1 62419.0 8158.7 8298.8 8355.0 8379.1 8784.6 9615.7 12041.2 12086.4 12121.0 12798.2 10489.3 10656.0 10757.0 10959.9 11093.7 10510.1 10699.8 11001.8 11049.1 11207.8 10742.8 11033.5 11441.7 11615.7 11645.4 8216.9 8249.5 8260.9 8369.4 8677.6 8912.4 10771.8 11332.5 11640.8 11651.6 21:30:51 INFO - PROCESS | 2257 | 21:30:51 INFO - PROCESS | 2257 | [#3] mootools.html Cycles:180 Average:5874.44 Median:4812.87 stddev:3304.51 (68.7%) stddev-sans-first:3296.20 21:30:51 INFO - PROCESS | 2257 | Values: 1338.2 1452.0 1502.5 1614.5 1794.5 8349.8 8675.2 8699.3 8975.8 9029.3 8837.9 8901.7 8946.0 8955.3 8964.1 2401.4 2421.2 2423.9 2424.9 2429.1 2412.9 2442.7 2456.7 2463.5 2465.5 2369.6 2387.5 2394.9 2403.8 2419.9 2359.9 2370.6 2391.4 2416.1 2416.1 2366.3 2369.0 2409.5 2409.6 2411.5 8682.4 8973.0 8993.1 8994.2 8996.1 5340.1 5468.8 5487.9 5489.5 5498.7 3422.3 3425.3 3460.0 3470.6 3477.8 1082.9 1097.9 1106.9 1131.9 1146.9 12312.3 12345.4 12360.0 12396.6 12413.1 4503.2 4509.1 4636.8 4645.3 4761.6 9244.2 9251.9 9260.2 9260.4 9291.1 5338.5 5352.2 5356.1 5362.4 5366.7 4428.6 4736.6 4864.2 4907.1 4977.9 3818.4 3868.2 3951.9 3959.3 3990.6 1144.6 1148.9 1156.3 1172.2 1188.6 889.3 926.8 966.6 1007.9 1025.6 6114.2 6119.4 6210.9 6316.6 6409.4 462.3 467.8 471.7 489.1 491.4 4266.4 4366.4 4498.2 4540.4 4551.0 10639.1 10913.8 11006.2 11010.8 11013.4 10908.1 10926.7 10932.2 10938.0 10941.1 8023.3 8305.8 8334.5 8488.7 8514.8 6337.5 6388.3 6428.0 6428.5 6520.5 10166.6 10372.6 10374.0 10490.8 10506.7 9886.4 10259.3 10267.0 10269.9 10445.9 7758.4 7951.8 7980.9 8331.2 8474.5 8352.8 8498.5 8608.3 8655.3 8842.9 7654.8 7780.6 7898.8 7910.9 7946.0 7573.4 7652.7 7687.5 7704.3 7807.5 7083.2 7204.7 7217.4 7221.6 7221.8 5339.8 5455.6 5521.6 5562.4 5659.0 5442.2 5530.6 5568.7 5654.5 5714.0 21:30:51 INFO - PROCESS | 2257 | 21:30:51 INFO - PROCESS | 2257 | [#4] prototype.html Cycles:180 Average:4575.16 Median:5203.21 stddev:1334.48 (25.6%) stddev-sans-first:1299.77 21:30:51 INFO - PROCESS | 2257 | Values: 338.1 346.4 347.2 353.8 354.6 5222.0 5307.0 5313.3 5316.5 5320.8 5251.0 5273.8 5280.8 5281.5 5284.7 3701.0 3990.7 4007.6 4074.5 4138.3 4136.3 4138.2 4142.3 4145.2 4160.2 4124.5 4130.8 4134.4 4146.9 4165.6 3954.5 4036.4 4133.3 4162.7 4176.7 3668.6 3687.8 3689.8 3703.8 3712.2 5072.8 5084.2 5102.7 5114.3 5163.8 4419.6 4646.3 4758.4 4758.7 4761.7 5360.4 5368.5 5373.5 5404.3 5415.5 3935.7 3958.7 3961.6 3962.6 3967.8 5433.9 5583.4 5605.4 5607.7 5618.0 4021.9 4022.8 4024.2 4033.6 4047.5 4092.8 4093.6 4093.7 4100.7 4103.6 4566.3 4666.2 4675.9 4689.0 4701.2 5437.7 5449.8 5461.7 5477.5 5478.9 1391.7 1402.1 1408.7 1410.9 1411.4 854.9 914.8 920.6 922.3 924.7 4671.2 4676.4 4686.2 4687.7 4727.9 4910.3 4974.6 5014.7 5018.8 5025.2 4622.3 4642.4 4678.6 4691.8 4850.0 2923.6 2962.3 2969.5 2969.8 2977.1 5826.4 5835.9 5844.5 5857.6 5859.4 5517.1 5668.3 5684.4 5689.6 5739.6 5496.8 5684.4 5795.9 5830.5 5831.0 5592.6 5605.3 5615.4 5617.2 5618.8 5382.7 5481.5 5506.3 5524.0 5539.3 5803.8 5826.7 5830.4 5869.8 5887.6 3988.9 3994.2 4010.7 4013.7 4023.9 5342.5 5620.8 5660.8 5664.2 5675.8 5494.8 5498.0 5503.8 5510.2 5523.0 5479.9 5495.2 5508.2 5515.2 5536.6 5204.7 5427.7 5429.2 5463.8 5464.8 5542.4 5547.9 5566.9 5573.7 5578.9 5201.7 5432.9 5457.9 5460.5 5479.1 21:30:51 INFO - PROCESS | 2257 | 21:30:51 INFO - PROCESS | 2257 | [#5] yui.html Cycles:180 Average:22691.41 Median:19111.88 stddev:34102.82 (178.4%) stddev-sans-first:34158.57 21:30:51 INFO - PROCESS | 2257 | Values: 713.7 754.5 808.5 820.5 874.8 15057.7 15432.3 15547.9 16304.7 16315.7 14751.9 14932.4 14991.7 14995.7 15009.5 658.3 791.5 810.1 820.0 822.5 814.7 819.4 824.0 824.3 831.4 865.6 867.2 868.8 871.6 871.8 700.7 712.5 869.0 871.3 871.5 523.8 608.3 619.4 620.6 624.7 15023.2 15082.3 15093.7 15106.1 15120.4 14128.2 14773.8 14882.6 14935.4 14968.0 13884.4 13981.2 14017.3 14284.2 14321.6 3841.2 4107.7 4755.9 4842.2 4887.3 79922.6 80337.6 81010.6 81021.2 81096.2 11373.9 11663.2 11817.5 11870.6 12212.6 19061.7 19077.6 19110.3 19113.4 19162.1 8559.3 8704.8 8732.2 8914.7 9010.7 4630.0 4668.5 4789.6 4812.0 4868.6 3684.1 3833.5 3834.7 3835.6 3842.6 620.7 622.1 631.3 631.8 634.3 661.9 690.0 706.9 717.9 797.3 9777.7 9788.4 10064.6 10179.8 10440.5 647.7 700.3 735.8 747.0 763.8 4309.3 4501.9 4631.7 4707.6 4708.2 126123.4 128011.4 130811.0 132986.0 140604.0 112023.4 114239.4 117082.4 118174.4 119657.0 100773.2 102883.5 103757.0 105776.0 108096.0 10183.4 10327.5 10384.9 10453.9 10772.8 52314.0 52431.5 53601.7 53733.0 53781.5 75193.0 75538.0 75544.0 76420.6 76559.2 13394.5 13417.5 13597.2 13747.8 13752.8 15451.9 15479.8 16010.4 16258.2 16688.7 13734.3 14590.3 15013.1 15120.0 15161.6 11590.2 13388.6 13672.2 13693.3 14199.6 13470.3 13524.5 13791.4 13991.0 14546.9 11629.9 11650.8 11887.5 12283.8 12315.2 12156.0 12318.4 12467.5 12688.6 12810.0 21:30:51 INFO - PROCESS | 2257 | -------- Summary: end -------- 21:30:51 INFO - PROCESS | 2257 | 21:30:52 INFO - TEST-INFO | 2257: exit 0 21:30:52 INFO - TEST-OK | dromaeo_css | took 1116815ms 21:30:52 INFO - TEST-START | kraken 21:30:52 INFO - operating with platform_type : linux_ 21:30:52 INFO - Initialising browser for kraken test... 21:30:52 INFO - TEST-INFO | started process 2543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpczgv_t/profile http://localhost:49769/getInfo.html) 21:30:58 INFO - PROCESS | 2543 | __metrics Screen width/height:1600/1200 21:30:58 INFO - PROCESS | 2543 | colorDepth:24 21:30:58 INFO - PROCESS | 2543 | Browser inner width/height: 1024/697 21:30:58 INFO - PROCESS | 2543 | __metrics 21:30:59 INFO - PROCESS | 2543 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:30:59 INFO - PROCESS | 2543 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:30:59 INFO - PROCESS | 2543 | console.error: PushService: 21:30:59 INFO - PROCESS | 2543 | stateChangeProcessEnqueue: Error transitioning state 21:30:59 INFO - PROCESS | 2543 | UnknownError 21:31:00 INFO - TEST-INFO | 2543: exit 0 21:31:00 INFO - Browser initialized. 21:31:00 INFO - Running cycle 1/1 for kraken test... 21:31:00 INFO - TEST-INFO | started process 2623 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpczgv_t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:31:12 INFO - PROCESS | 2623 | RSS: Main: 156078080 21:31:12 INFO - PROCESS | 2623 | 21:31:14 INFO - PROCESS | 2623 | Cycle 1(1): loaded http://localhost:49769/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49769/tests/kraken/driver.html?testName=audio-beat-detection) 21:31:15 INFO - PROCESS | 2623 | RSS: Main: 211886080 21:31:15 INFO - PROCESS | 2623 | 21:31:18 INFO - PROCESS | 2623 | Cycle 1(1): loaded http://localhost:49769/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49769/tests/kraken/driver.html?testName=audio-dft) 21:31:18 INFO - PROCESS | 2623 | RSS: Main: 191324160 21:31:18 INFO - PROCESS | 2623 | 21:31:21 INFO - PROCESS | 2623 | Cycle 1(1): loaded http://localhost:49769/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49769/tests/kraken/driver.html?testName=audio-fft) 21:31:22 INFO - PROCESS | 2623 | RSS: Main: 268451840 21:31:22 INFO - PROCESS | 2623 | 21:31:24 INFO - PROCESS | 2623 | Cycle 1(1): loaded http://localhost:49769/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49769/tests/kraken/driver.html?testName=audio-oscillator) 21:31:25 INFO - PROCESS | 2623 | RSS: Main: 178274304 21:31:25 INFO - PROCESS | 2623 | 21:31:27 INFO - PROCESS | 2623 | Cycle 1(1): loaded http://localhost:49769/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49769/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:31:27 INFO - PROCESS | 2623 | RSS: Main: 182902784 21:31:27 INFO - PROCESS | 2623 | 21:31:30 INFO - PROCESS | 2623 | Cycle 1(1): loaded http://localhost:49769/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49769/tests/kraken/driver.html?testName=imaging-darkroom) 21:31:31 INFO - PROCESS | 2623 | RSS: Main: 220045312 21:31:31 INFO - PROCESS | 2623 | 21:31:34 INFO - PROCESS | 2623 | Cycle 1(1): loaded http://localhost:49769/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49769/tests/kraken/driver.html?testName=imaging-desaturate) 21:31:35 INFO - PROCESS | 2623 | RSS: Main: 218738688 21:31:35 INFO - PROCESS | 2623 | 21:31:38 INFO - PROCESS | 2623 | Cycle 1(1): loaded http://localhost:49769/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49769/tests/kraken/driver.html?testName=json-parse-financial) 21:31:38 INFO - PROCESS | 2623 | RSS: Main: 218566656 21:31:38 INFO - PROCESS | 2623 | 21:31:40 INFO - PROCESS | 2623 | Cycle 1(1): loaded http://localhost:49769/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49769/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:31:41 INFO - PROCESS | 2623 | RSS: Main: 182784000 21:31:41 INFO - PROCESS | 2623 | 21:31:42 INFO - PROCESS | 2623 | Cycle 1(1): loaded http://localhost:49769/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49769/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:31:43 INFO - PROCESS | 2623 | RSS: Main: 188911616 21:31:43 INFO - PROCESS | 2623 | 21:31:45 INFO - PROCESS | 2623 | Cycle 1(1): loaded http://localhost:49769/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49769/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:31:46 INFO - PROCESS | 2623 | RSS: Main: 192856064 21:31:46 INFO - PROCESS | 2623 | 21:31:48 INFO - PROCESS | 2623 | Cycle 1(1): loaded http://localhost:49769/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:31:49 INFO - PROCESS | 2623 | RSS: Main: 187887616 21:31:49 INFO - PROCESS | 2623 | 21:31:51 INFO - PROCESS | 2623 | Cycle 1(1): loaded http://localhost:49769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:31:52 INFO - PROCESS | 2623 | RSS: Main: 191610880 21:31:52 INFO - PROCESS | 2623 | 21:31:54 INFO - PROCESS | 2623 | Cycle 1(1): loaded http://localhost:49769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49769/tests/kraken/driver.html?testName=ai-astar) 21:31:54 INFO - PROCESS | 2623 | RSS: Main: 242655232 21:31:54 INFO - PROCESS | 2623 | 21:31:54 INFO - PROCESS | 2623 | __start_tp_report 21:31:54 INFO - PROCESS | 2623 | _x_x_mozilla_page_load 21:31:54 INFO - PROCESS | 2623 | _x_x_mozilla_page_load_details 21:31:54 INFO - PROCESS | 2623 | |i|pagename|runs| 21:31:54 INFO - PROCESS | 2623 | |0;ai-astar;103;111;114;112;112;113;112;113;113;113 21:31:54 INFO - PROCESS | 2623 | |1;audio-beat-detection;147;117;119;171;119;120;143;117;150;123 21:31:54 INFO - PROCESS | 2623 | |2;audio-dft;161;161;160;160;161;161;160;162;160;160 21:31:54 INFO - PROCESS | 2623 | |3;audio-fft;74;76;74;112;75;75;74;75;114;74 21:31:54 INFO - PROCESS | 2623 | |4;audio-oscillator;85;85;132;84;85;85;120;85;85;129 21:31:54 INFO - PROCESS | 2623 | |5;imaging-gaussian-blur;117;117;117;117;118;116;117;117;117;117 21:31:54 INFO - PROCESS | 2623 | |6;imaging-darkroom;145;145;146;146;145;146;145;145;146;146 21:31:54 INFO - PROCESS | 2623 | |7;imaging-desaturate;94;95;94;95;95;94;95;95;95;95 21:31:54 INFO - PROCESS | 2623 | |8;json-parse-financial;51;50;49;49;50;50;50;50;50;50 21:31:54 INFO - PROCESS | 2623 | |9;json-stringify-tinderbox;62;63;61;62;63;63;63;62;63;63 21:31:54 INFO - PROCESS | 2623 | |10;stanford-crypto-aes;76;76;77;76;75;76;81;75;75;81 21:31:54 INFO - PROCESS | 2623 | |11;stanford-crypto-ccm;122;129;119;126;119;134;142;121;134;128 21:31:54 INFO - PROCESS | 2623 | |12;stanford-crypto-pbkdf2;160;156;159;166;159;156;155;156;155;155 21:31:54 INFO - PROCESS | 2623 | |13;stanford-crypto-sha256-iterative;61;65;63;62;63;63;62;61;61;61 21:31:54 INFO - PROCESS | 2623 | __end_tp_report 21:31:54 INFO - PROCESS | 2623 | __start_cc_report 21:31:54 INFO - PROCESS | 2623 | _x_x_mozilla_cycle_collect,1672 21:31:54 INFO - PROCESS | 2623 | __end_cc_report 21:31:54 INFO - PROCESS | 2623 | __startTimestamp1470803514394__endTimestamp 21:31:54 INFO - PROCESS | 2623 | 21:31:54 INFO - PROCESS | 2623 | ------- Summary: start ------- 21:31:54 INFO - PROCESS | 2623 | Number of tests: 14 21:31:54 INFO - PROCESS | 2623 | 21:31:54 INFO - PROCESS | 2623 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:3.13 (2.8%) stddev-sans-first:0.88 21:31:54 INFO - PROCESS | 2623 | Values: 103.0 111.0 114.0 112.0 112.0 113.0 112.0 113.0 113.0 113.0 21:31:54 INFO - PROCESS | 2623 | 21:31:54 INFO - PROCESS | 2623 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:133.00 stddev:18.86 (14.2%) stddev-sans-first:19.27 21:31:54 INFO - PROCESS | 2623 | Values: 147.0 117.0 119.0 171.0 119.0 120.0 143.0 117.0 150.0 123.0 21:31:54 INFO - PROCESS | 2623 | 21:31:54 INFO - PROCESS | 2623 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 21:31:54 INFO - PROCESS | 2623 | Values: 161.0 161.0 160.0 160.0 161.0 161.0 160.0 162.0 160.0 160.0 21:31:54 INFO - PROCESS | 2623 | 21:31:54 INFO - PROCESS | 2623 | [#3] audio-fft Cycles:10 Average:82.30 Median:74.50 stddev:16.20 (21.7%) stddev-sans-first:16.90 21:31:54 INFO - PROCESS | 2623 | Values: 74.0 76.0 74.0 112.0 75.0 75.0 74.0 75.0 114.0 74.0 21:31:54 INFO - PROCESS | 2623 | 21:31:54 INFO - PROCESS | 2623 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:85.00 stddev:20.57 (24.2%) stddev-sans-first:21.32 21:31:54 INFO - PROCESS | 2623 | Values: 85.0 85.0 132.0 84.0 85.0 85.0 120.0 85.0 85.0 129.0 21:31:54 INFO - PROCESS | 2623 | 21:31:54 INFO - PROCESS | 2623 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 21:31:54 INFO - PROCESS | 2623 | Values: 117.0 117.0 117.0 117.0 118.0 116.0 117.0 117.0 117.0 117.0 21:31:54 INFO - PROCESS | 2623 | 21:31:54 INFO - PROCESS | 2623 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 21:31:54 INFO - PROCESS | 2623 | Values: 145.0 145.0 146.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 21:31:54 INFO - PROCESS | 2623 | 21:31:54 INFO - PROCESS | 2623 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 21:31:54 INFO - PROCESS | 2623 | Values: 94.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 21:31:54 INFO - PROCESS | 2623 | 21:31:54 INFO - PROCESS | 2623 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:50.00 stddev:0.57 (1.1%) stddev-sans-first:0.44 21:31:54 INFO - PROCESS | 2623 | Values: 51.0 50.0 49.0 49.0 50.0 50.0 50.0 50.0 50.0 50.0 21:31:54 INFO - PROCESS | 2623 | 21:31:54 INFO - PROCESS | 2623 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 21:31:54 INFO - PROCESS | 2623 | Values: 62.0 63.0 61.0 62.0 63.0 63.0 63.0 62.0 63.0 63.0 21:31:54 INFO - PROCESS | 2623 | 21:31:54 INFO - PROCESS | 2623 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.00 stddev:2.30 (3.0%) stddev-sans-first:2.42 21:31:54 INFO - PROCESS | 2623 | Values: 76.0 76.0 77.0 76.0 75.0 76.0 81.0 75.0 75.0 81.0 21:31:54 INFO - PROCESS | 2623 | 21:31:54 INFO - PROCESS | 2623 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:128.50 stddev:7.57 (5.9%) stddev-sans-first:7.78 21:31:54 INFO - PROCESS | 2623 | Values: 122.0 129.0 119.0 126.0 119.0 134.0 142.0 121.0 134.0 128.0 21:31:54 INFO - PROCESS | 2623 | 21:31:54 INFO - PROCESS | 2623 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:157.50 stddev:3.47 (2.2%) stddev-sans-first:3.57 21:31:54 INFO - PROCESS | 2623 | Values: 160.0 156.0 159.0 166.0 159.0 156.0 155.0 156.0 155.0 155.0 21:31:54 INFO - PROCESS | 2623 | 21:31:54 INFO - PROCESS | 2623 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.50 stddev:1.32 (2.1%) stddev-sans-first:1.32 21:31:54 INFO - PROCESS | 2623 | Values: 61.0 65.0 63.0 62.0 63.0 63.0 62.0 61.0 61.0 61.0 21:31:54 INFO - PROCESS | 2623 | -------- Summary: end -------- 21:31:54 INFO - PROCESS | 2623 | 21:31:55 INFO - TEST-INFO | 2623: exit 0 21:31:55 INFO - TEST-OK | kraken | took 62845ms 21:31:55 INFO - SUITE-END | took 1179s 21:31:55 INFO - Completed test suite (00:19:39) 21:31:55 INFO - javascript benchmark 21:31:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2948.24819670984, 2997.8051426657253, 3012.8041677290976, 3092.026011806281, 3093.814371137731, 5308.946910530904, 5338.172583249593, 5351.197320401941, 5440.727963601819, 5456.9181462278, 5368.946310536893, 5371.623986320959, 5427.0, 5432.076546987012, 5445.646033007852, 4821.638377121712, 4884.951150488485, 4905.509449055084, 4929.556339929406, 5086.796528138889, 4960.032793605248, 4995.075910956485, 5008.048470790538, 5015.0972824891505, 5017.498250174972, 4802.4237091548885, 4838.758062096898, 4845.563899249049, 4874.073925954093, 4968.875778105558, 4871.025794841011, 4877.561019508225, 4879.804807807684, 4934.777934992934, 4977.054359671651, 4874.512548745132, 4904.4605093439695, 4904.5340692634145, 4923.335349727777, 4957.553820156168, 5268.209768534713, 5333.839984800462, 5383.4616538346245, 5404.1083221268445, 5418.376886658006, 5817.738201780888, 5861.794837180678, 5875.764969401219, 5883.529317654577, 5886.175935369009, 5843.795467158671, 5867.823965281048, 5883.79406720767, 5896.351401345849, 5909.4090590941, 5289.86775330616, 5298.09932311508, 5353.866153346197, 5357.598180136505, 5434.945650543523, 5987.161797348374, 6057.0, 6059.575829691968, 6060.969695151496, 6061.878762424727, 5786.189933409326, 5796.1595568642315, 5800.071988481823, 5803.564732645069, 5805.216295800013, 5664.26364572603, 5707.343655479673, 5762.9135562966585, 5769.711514424262, 5856.765729370863, 5752.9424705753245, 5759.913601295984, 5763.9135412968835, 5769.8557536061935, 5805.448482394166, 5737.254156959569, 5745.195672605839, 5803.7968671096305, 5805.651660900359, 5807.0, 4284.143171365739, 4317.136572685476, 4317.201317756162, 4374.518802931675, 4376.6498680105515, 3897.3179693553516, 3915.7454765440157, 3919.1769728357363, 3926.155876486569, 3959.9604003960167, 5436.864078398072, 5444.972775136099, 5481.177823326453, 5488.423715509894, 5491.039068163055, 5847.44449277318, 5851.385604511465, 5852.882942341129, 5861.20873682056, 5868.501177399969, 5226.555742761908, 5371.597130215249, 5381.30043094403, 5439.646422982493, 5452.536534394541, 5056.620753443506, 5061.848144555669, 5063.240513922941, 5065.341505604248, 5109.08036553424, 6103.725332360054, 6117.449429551273, 6124.387561243929, 6124.969375153096, 6126.08108783686, 5569.526590239875, 5762.4525670061275, 5788.957987562279, 5869.00226961409, 5878.382769809279, 6094.5014626406155, 6099.563179733188, 6102.901477734051, 6104.9139292562195, 6143.477804386677, 5714.399988001366, 5743.8851222976145, 5758.654480731169, 5786.392428795084, 5808.21589085485, 5561.63849349791, 5662.980663480448, 5859.589828711949, 5876.559258055749, 5880.676562789087, 5600.60795744294, 5665.603407761417, 5666.2350582670815, 5702.429757024264, 5720.456556627114, 5611.8877622448135, 5649.491545760901, 5650.0677388232125, 5652.2086907833755, 5655.830325090254, 5436.755346009518, 5523.0, 5538.280023597068, 5591.18927755465, 5600.103983362643, 5654.660720356792, 5691.174779657009, 5709.22925405065, 5738.1679656450415, 5751.166080918327, 5537.031019571639, 5573.331200255995, 5588.497035266845, 5589.776408943597, 5591.133374326986], "value": 5339.45152190359, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.8673691787807, 621.7140115546848, 623.8284471770263, 630.2153818495973, 636.2682914648157, 33919.32161356774, 36256.7368936796, 43888.56111438889, 45085.77457112718, 45185.77407112968, 47415.52584474154, 48030.0, 48072.278915816205, 48092.2786158207, 48094.51905480944, 8814.691485798, 8962.058983806704, 8986.326025548078, 8992.370534062618, 8999.5050272235, 8837.851079359674, 8876.112388761105, 8902.599383027748, 8930.419522731034, 8933.95533022334, 8930.062343453941, 8977.640894364251, 9025.864612030824, 9030.548472576378, 9036.909630903705, 8958.328125390557, 8965.148310910454, 9004.81990360189, 9019.0, 9021.323400744937, 8811.911880881173, 8881.289496840238, 8896.154865287788, 8897.199252067345, 8900.287976961827, 43704.781476092736, 43953.78023109896, 44114.117717645786, 44166.116677666585, 44171.337429938576, 3722.3671975764187, 3910.2179564087296, 4293.205756934945, 4363.694541382105, 4424.247877860771, 33277.0, 33816.0, 34160.31679366399, 34209.31581368384, 34559.13602159941, 4318.3090705486975, 4339.500957389909, 4417.955820441786, 4452.465704115527, 4597.0116424968455, 253026.0, 253368.0, 253578.0, 253764.0, 254802.0, 58717.0, 58824.0, 58917.70541147267, 59186.70406647939, 59309.0, 62455.37544624496, 62495.0, 62525.37474625195, 62554.37445625576, 62591.6870415645, 15789.605259868365, 15825.287862046236, 15906.0, 15944.2825072872, 15949.88350815455, 12227.877721222674, 12228.449719762632, 12241.632751017483, 12253.693657658452, 12289.201201921847, 16053.839461605468, 17256.482305530855, 17421.738673919903, 17434.738478922827, 17440.912795436194, 5461.9453805462235, 6355.1420558224045, 6364.840878978062, 6491.480681545465, 6537.607743535403, 1016.9135623472088, 1030.2177233386283, 1071.3946620159586, 1101.7245688577855, 1110.8111621024284, 32518.674813252037, 33668.66331336655, 34009.659903401145, 34111.31777364439, 34199.658003419645, 1114.9163812713916, 1154.5324143721807, 1158.6060739348661, 1173.0908545877014, 1180.7520420711576, 16785.58036049084, 17617.885853697637, 17665.38171164003, 17772.822271777375, 17805.198766055557, 503667.0, 507295.0, 509939.0, 514490.0, 518238.270469177, 60542.394576054554, 60690.393096068474, 60743.69628151831, 60788.69605652032, 60791.39208607857, 1198.3049831097942, 1290.8450985881566, 1335.5325636027508, 1345.065179700099, 1347.4408120629828, 33193.83403082969, 34753.30493390169, 34825.8258708715, 34961.47557786686, 35092.0, 47007.76496117497, 47374.76312618553, 47390.28914566353, 47394.76302618465, 47411.28883066826, 401596.0, 402885.0, 403179.0, 405005.0, 408041.0, 29903.401931960805, 30740.846295768377, 30928.226794330323, 31003.069907902798, 42820.571794281655, 49472.25791613057, 49905.75047124741, 50474.74762626163, 50640.0, 50750.74624626853, 41815.37276940788, 41861.37207941822, 41962.79018604887, 42641.573584265, 43882.34176487419, 42039.579604203565, 42610.0, 42944.0, 42985.0, 43803.78098109489, 41518.16963660649, 42171.0, 43011.56988430201, 43238.56761432345, 43347.34978975381, 35283.470747938285, 36823.63176368309, 37702.24595508129, 38365.0, 38557.0, 28875.855620721763, 29155.562666559596, 29335.559966600944, 29401.41197176002, 29449.705502944696], "value": 20224.211502667713, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.2548379692006, 397.73351854257663, 406.2200574896199, 413.46662804981577, 424.11995110146455, 13420.482328028687, 19679.311224107158, 20166.999999999964, 20173.899130504327, 20184.59630807383, 12863.356832158379, 13133.868661313383, 13138.963460663588, 13153.210807351566, 13218.0, 3966.8809935701975, 5241.816536421226, 5402.837914862561, 5410.215518749779, 5636.830895073133, 5803.883922321551, 5867.41325867412, 5929.169916211712, 5935.317438494563, 5936.792212272571, 5772.451617096369, 5778.075507918734, 5837.824865254049, 5841.299044114712, 5942.435468630495, 5847.853803654922, 5865.0, 5886.323072846613, 5888.941110588882, 5893.5874488785585, 5541.168824676291, 5709.45760152789, 5739.713014349266, 5740.569457290678, 5744.6840423776675, 14382.137071775622, 14499.927500362535, 18874.62250754991, 23351.299461016028, 23583.646245306336, 2253.2339004738305, 2301.643245296965, 2342.8711420871846, 2441.389652586853, 2489.850608963468, 10555.525001374957, 10626.574937002511, 10969.341839489656, 12813.679658008532, 14086.506972256024, 1897.4592241211326, 1939.93210237641, 1959.6864501679663, 1983.514039060425, 2046.0588129460466, 65456.67271663659, 66623.66688166528, 73583.2641673587, 80828.59585702093, 88502.11497885003, 9127.406718563272, 9682.70951871431, 9687.370320929118, 9777.364471309342, 10002.149817265614, 13565.253911034988, 13654.590362289147, 13665.18008919468, 13667.521636742666, 13688.52090176859, 7640.69437222516, 7766.184550622216, 8030.879536806952, 8086.959565202136, 8136.064352599408, 7775.727849525239, 7793.883091753628, 7939.126696063428, 7990.920090799018, 8151.959240203761, 4201.516825565038, 4240.236757383639, 4250.766207858597, 4253.532111467736, 4305.9569404306185, 1962.9705554416696, 2009.1260301768777, 2032.6950957356514, 2042.588009898612, 2078.2622169130045, 955.3646824861528, 972.601233494264, 1030.4384110659707, 1035.0322448510667, 1042.8696412948382, 19730.90134549318, 20464.079116439498, 20575.794242057687, 20637.0, 20648.690269645966, 1006.5470538257813, 1008.5965613754411, 1026.7381817636456, 1049.6798476464598, 1077.4881931082673, 10817.83773243402, 11436.599719009795, 11503.827442588368, 11535.71160720972, 11542.711432214262, 487080.0, 489706.0, 490861.0, 492405.0, 532632.0, 85947.0, 89610.55194723984, 90323.54838225766, 90703.0, 92135.0, 1006.8137394582026, 1017.5217647705566, 1049.753307972641, 1050.1703654113317, 1055.9155267578576, 17840.0, 18269.81730182681, 18316.633667326845, 18640.440786776417, 18741.718874216625, 43188.568114319714, 43496.0, 44223.0, 45884.0, 46720.0, 61135.0, 61422.0, 61482.69258653678, 61785.073223902575, 62419.0, 8158.673653053811, 8298.834023319621, 8355.0, 8379.120192379956, 8784.648614055366, 9615.663451779154, 12041.19382092658, 12086.39568021613, 12121.030317574396, 12798.16811907223, 10489.265751397328, 10656.0, 10757.0, 10959.945200273947, 11093.722656933642, 10510.106640935606, 10699.839502407625, 11001.834972475259, 11049.116070714485, 11207.831882521605, 10742.83885741699, 11033.503492343025, 11441.656750297505, 11615.709607259887, 11645.41772911368, 8216.917830821616, 8249.546274954935, 8260.917390826015, 8369.414141010315, 8677.566121693764, 8912.376133670581, 10771.787370390248, 11332.546698132312, 11640.767184656428, 11651.59219427316], "value": 8994.452232156778, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.2128576129555, 1452.027141814984, 1502.4666243483562, 1614.4510866305454, 1794.4706311638074, 8349.833003339938, 8675.219230269282, 8699.260562852158, 8975.775605609846, 9029.277657787377, 8837.911620883806, 8901.732948011553, 8946.0, 8955.328350373715, 8964.058773828736, 2401.4476670365825, 2421.225207933462, 2423.9394015149674, 2424.903003879843, 2429.0890915906534, 2412.9034838606435, 2442.7435119312395, 2456.6806315179, 2463.5072985402903, 2465.543874383236, 2369.609014512612, 2387.510560335127, 2394.916177933773, 2403.795677367426, 2419.854808711474, 2359.9410014749596, 2370.5969985102574, 2391.354334329721, 2416.081888882231, 2416.1301931304715, 2366.3019409274307, 2368.97631023691, 2409.506051259505, 2409.590369637166, 2411.5056413435204, 8682.392232543725, 8972.955135224347, 8993.100689930954, 8994.235489983359, 8996.100389961017, 5340.092184328634, 5468.835934921959, 5487.890242195173, 5489.478499542537, 5498.670079795185, 3422.26421319415, 3425.3320602482277, 3459.9654003459896, 3470.583529976394, 3477.8087205203706, 1082.8971247731454, 1097.8847221041756, 1106.8671759388844, 1131.8868113188698, 1146.9483873225724, 12312.26126432408, 12345.444454999546, 12360.0, 12396.566120185751, 12413.131080824345, 4503.234450143484, 4509.098180363941, 4636.83771068011, 4645.256758918556, 4761.571458568746, 9244.214241789388, 9251.907480925105, 9260.21288190498, 9260.444373337621, 9291.117343852324, 5338.519533242027, 5352.223927530486, 5356.0894647909945, 5362.383325917492, 5366.651167674088, 4428.623566996777, 4736.550027747358, 4864.173090574611, 4907.067657145131, 4977.925331120036, 3818.3699689550913, 3868.207017561393, 3951.940720889189, 3959.3269144245546, 3990.6009399060445, 1144.5993902134353, 1148.9310641361544, 1156.3004382348727, 1172.1853311948284, 1188.6255829413708, 889.2841262783392, 926.786839027014, 966.5747071288611, 1007.9193664506822, 1025.5590096258532, 6114.2357205349335, 6119.418655227746, 6210.875782484325, 6316.589421687576, 6409.4231519163495, 462.3065401897154, 467.7661169415292, 471.7028272188568, 489.10249691815915, 491.3882216640306, 4266.360045993064, 4366.410534577792, 4498.212812757754, 4540.387047748578, 4551.0442807010895, 10639.148868090535, 10913.781724365468, 11006.229563930608, 11010.779784404427, 11013.449327533592, 10908.127349811995, 10926.672199834018, 10932.234743568033, 10938.0, 10941.070009049161, 8023.277904988579, 8305.792355191048, 8334.541600211925, 8488.702895398756, 8514.78713032179, 6337.524685648687, 6388.265349484683, 6427.967860160669, 6428.517861160525, 6520.478361731145, 10166.644167454104, 10372.636957706443, 10374.0, 10490.790184196121, 10506.737331566772, 9886.406815590799, 10259.333143345659, 10267.024632659886, 10269.897301026895, 10445.895541044492, 7758.4181186410115, 7951.761447156595, 7980.880286795818, 8331.166883311862, 8474.491530508189, 8352.83294334122, 8498.490090594583, 8608.268297194558, 8655.30757539408, 8842.911570884466, 7654.770356889302, 7780.610969451618, 7898.802529936797, 7910.864066702074, 7946.046474423106, 7573.394128469599, 7652.73215437457, 7687.461877668733, 7704.345130663956, 7807.531548107132, 7083.150021997187, 7204.675789589376, 7217.350438460354, 7221.566705997657, 7221.819454513679, 5339.759710812945, 5455.563554915677, 5521.558275338044, 5562.3881373048125, 5659.03796354629, 5442.197119653973, 5530.55755539564, 5568.721563921707, 5654.547636189012, 5714.0], "value": 4628.246578066908, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.1411215512598, 346.3938108310457, 347.1754582865695, 353.8054070261357, 354.6418117701121, 5221.973890130549, 5306.973465132679, 5313.309269794921, 5316.5215130638235, 5320.760565774535, 5251.0, 5273.815416460425, 5280.762365693543, 5281.471852814717, 5284.656497327671, 3700.962990370089, 3990.7206495545324, 4007.5591684914634, 4074.5314288856716, 4138.296489596776, 4136.31750761124, 4138.151678905832, 4142.275101857178, 4145.191687620915, 4160.230357383879, 4124.52567954686, 4130.822715526076, 4134.37984302354, 4146.854860079898, 4165.645920096796, 3954.4661470701376, 4036.4147198656324, 4133.276676581586, 4162.667946257199, 4176.68674849386, 3668.6147954464664, 3687.8340474678703, 3689.815509224528, 3703.7962912039825, 3712.1833196696684, 5072.797088116471, 5084.186530155194, 5102.744862756885, 5114.33513643224, 5163.8192663256605, 4419.62433193179, 4646.3495110684535, 4758.405199350082, 4758.690685105457, 4761.738104404257, 5360.437154098841, 5368.516833485005, 5373.516383525502, 5404.297441332602, 5415.512603865671, 3935.6851451884068, 3958.6635136013474, 3961.564227934925, 3962.583928687504, 3967.841286348543, 5433.918491222635, 5583.441655834384, 5605.383407825136, 5607.691576963265, 5618.0449323614675, 4021.8537716750584, 4022.778747168934, 4024.2353952748886, 4033.596640335943, 4047.494063242095, 4092.7748973806133, 4093.6256970956774, 4093.7339072960162, 4100.65144462718, 4103.5691252418665, 4566.315052742115, 4666.160091183551, 4675.883102922454, 4689.015306785545, 4701.177293973541, 5437.728113594305, 5449.754761035763, 5461.726913654302, 5477.507024367826, 5478.931608336416, 1391.7355702416507, 1402.1236727045596, 1408.7323408552343, 1410.9435622574981, 1411.371939486939, 854.9273311768569, 914.7804526913493, 920.5535315372039, 922.3220932614523, 924.7179610218814, 4671.182543054952, 4676.386646606983, 4686.179918514246, 4687.695299805502, 4727.858164255078, 4910.288008238786, 4974.562464392422, 5014.749262536859, 5018.820577164363, 5025.246213067996, 4622.2604383299185, 4642.398372561461, 4678.555537223959, 4691.771408580965, 4850.0, 2923.640507164179, 2962.333474968115, 2969.5248760198265, 2969.8171843694868, 2977.1217490840254, 5826.417358264224, 5835.912461313083, 5844.47399734026, 5857.560682948796, 5859.414058594191, 5517.063773097127, 5668.319801623749, 5684.403137670568, 5689.601727879009, 5739.5695322850115, 5496.7526461309335, 5684.442001099522, 5795.88408231833, 5830.47525722687, 5830.96789669378, 5592.601849537616, 5605.290386432014, 5615.410381909841, 5617.185508101221, 5618.780581670136, 5382.703951282717, 5481.506664400223, 5506.311711036121, 5523.978064058162, 5539.25220095282, 5803.763252825545, 5826.650400975955, 5830.416958304136, 5869.7945571904775, 5887.58786884931, 3988.8603898863403, 3994.2211268802303, 4010.733935326531, 4013.7190396673122, 4023.93964090533, 5342.519173274424, 5620.831375058755, 5660.801871934463, 5664.150377443417, 5675.829725108253, 5494.80768173128, 5497.972510137423, 5503.807366742145, 5510.173473978935, 5523.0, 5479.917801232905, 5495.175723641486, 5508.20131080999, 5515.172724091419, 5536.584756143225, 5204.739763011758, 5427.6661035755005, 5429.212764149097, 5463.759858458013, 5464.808731694372, 5542.3626282977975, 5547.8890422190525, 5566.888662226814, 5573.665580065047, 5578.9163162553405, 5201.6735732388, 5432.945670543402, 5457.890842183214, 5460.481254280996, 5479.109707151027], "value": 4155.651213841803, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.7109470664379, 754.5397307642337, 808.4946908182386, 820.478995837643, 874.7987962768563, 15057.698846023073, 15432.305546250418, 15547.92226038871, 16304.673906521863, 16315.673686526277, 14751.926240368783, 14932.40270389186, 14991.700165996674, 14995.700085998273, 15009.474668386609, 658.3383699382114, 791.5369508837337, 810.088650268448, 819.9918000819976, 822.5475988206492, 814.7392834293029, 819.4018366592392, 823.983520329593, 824.3364091906013, 831.3847752663016, 865.6061492021115, 867.2281669314315, 868.8045189832269, 871.6077765005773, 871.8038441350709, 700.7337211859511, 712.5261700968849, 869.0483920107504, 871.2681347667958, 871.507598207011, 523.8035736598775, 608.3126067543692, 619.4177473175201, 620.5873094392224, 624.6626821516376, 15023.248837558078, 15082.321295541728, 15093.698126037527, 15106.093634381863, 15120.39518419262, 14128.152310861278, 14773.778393324108, 14882.553523394316, 14935.402583896739, 14968.0, 13884.4446222151, 13981.231032293219, 14017.299135043208, 14284.214368209745, 14321.57035288943, 3841.2125514269505, 4107.671386289119, 4755.904881902343, 4842.15262329091, 4887.266909963499, 79922.60038699828, 80337.59831200865, 81010.59494702489, 81021.18978810195, 81096.18903810946, 11373.943130284295, 11663.183577149688, 11817.468213930393, 11870.584529541424, 12212.618539384735, 19061.714074288895, 19077.61844763125, 19110.33113841009, 19113.426597202106, 19162.137703803084, 8559.272461840814, 8704.78238044054, 8732.214100730966, 8914.687985920462, 9010.729678109667, 4630.0, 4668.486466488684, 4789.592884604778, 4811.975940120277, 4868.634852386085, 3684.09739613791, 3833.463315135883, 3834.6740527055513, 3835.6356146166067, 3842.558105817867, 620.7423919073624, 622.0979579609494, 631.2677294338637, 631.7915088020942, 634.3086036220542, 661.890788019981, 689.9719418067044, 706.8833642449041, 717.9338682057141, 797.3461761355633, 9777.706668799947, 9788.363756355815, 10064.647737329306, 10179.84730229047, 10440.477976101316, 647.6935245571384, 700.2752151523149, 735.7866218796596, 747.0379943523953, 763.8472305538914, 4309.332053531708, 4501.88745281364, 4631.745254011062, 4707.6233901287815, 4708.223143181405, 126123.3693831525, 128011.35994320155, 130811.0, 132986.0, 140604.0, 112023.43988280007, 114239.42880285712, 117082.41458792651, 118174.40912795381, 119657.0, 100773.16498181946, 102883.48558257161, 103757.0, 105776.0, 108096.0, 10183.439910804977, 10327.48362581853, 10384.876567867845, 10453.9477302613, 10772.838407423738, 52314.0, 52431.47568524266, 53601.73199134135, 53733.0, 53781.46218537921, 75193.0, 75538.0, 75544.0, 76420.61789691016, 76559.23440765744, 13394.531191408643, 13417.463301468222, 13597.184168949894, 13747.793783093062, 13752.793708094187, 15451.922740386226, 15479.767803482731, 16010.359585616445, 16258.187090645657, 16688.666226675643, 13734.313284335944, 14590.343434545259, 15013.099214047192, 15120.0, 15161.617769993285, 11590.246633968765, 13388.598342049754, 13672.248026358247, 13693.31533423305, 14199.630093669779, 13470.326483675974, 13524.526641567498, 13791.448342066205, 13991.0, 14546.854531454974, 11629.941850291032, 11650.825237621611, 11887.524499019943, 12283.754324913272, 12315.19951203169, 12156.0, 12318.384080795746, 12467.5012999479, 12688.555900543437, 12810.0], "value": 7870.738559479373, "unit": "score"}], "name": "dromaeo_css", "value": 7265.128964936584, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 114.0, 112.0, 112.0, 113.0, 112.0, 113.0, 113.0, 113.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 119.0, 171.0, 119.0, 120.0, 143.0, 117.0, 150.0, 123.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 161.0, 161.0, 160.0, 162.0, 160.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 112.0, 75.0, 75.0, 74.0, 75.0, 114.0, 74.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 132.0, 84.0, 85.0, 85.0, 120.0, 85.0, 85.0, 129.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 49.0, 49.0, 50.0, 50.0, 50.0, 50.0, 50.0, 50.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 76.0, 75.0, 76.0, 81.0, 75.0, 75.0, 81.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 129.0, 119.0, 126.0, 119.0, 134.0, 142.0, 121.0, 134.0, 128.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 156.0, 159.0, 166.0, 159.0, 156.0, 155.0, 156.0, 155.0, 155.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 63.0, 62.0, 63.0, 63.0, 62.0, 61.0, 61.0, 61.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1478.3, "alertThreshold": 2.0}]} 21:31:55 INFO - Return code: 0 21:31:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:31:55 INFO - # TBPL SUCCESS # 21:31:55 INFO - Running post-action listener: _resource_record_post_action 21:31:55 INFO - [mozharness: 2016-08-10 04:31:55.682885Z] Finished run-tests step (success) 21:31:55 INFO - Running post-run listener: _resource_record_post_run 21:31:55 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553795584; Read time: 100; Write time: 2249844 21:31:55 INFO - TinderboxPrint: CPU usage
13.2% 21:31:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 100 21:31:55 INFO - TinderboxPrint: I/O write bytes / time
553,795,584 / 2,249,844 21:31:55 INFO - TinderboxPrint: CPU idle
8,302.7 (86.8%) 21:31:55 INFO - TinderboxPrint: CPU user
1,188.4 (12.4%) 21:31:55 INFO - TinderboxPrint: Swap in / out
0 / 0 21:31:55 INFO - install - Wall time: 17s; CPU: 21.0%; Read bytes: 0; Write bytes: 230895616; Read time: 0; Write time: 1180912 21:31:55 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295440384; Read time: 100; Write time: 799760 21:31:56 INFO - Running post-run listener: _upload_blobber_files 21:31:56 INFO - Blob upload gear active. 21:31:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:31:56 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 21:31:56 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:31:56 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:31:56 INFO - (blobuploader) - INFO - Open directory for files ... 21:31:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:31:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:31:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:32:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:32:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:32:00 INFO - (blobuploader) - INFO - Done attempting. 21:32:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:32:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:32:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:32:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:32:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:32:01 INFO - (blobuploader) - INFO - Done attempting. 21:32:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:32:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:32:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:32:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:32:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:32:02 INFO - (blobuploader) - INFO - Done attempting. 21:32:02 INFO - (blobuploader) - INFO - Iteration through files over. 21:32:02 INFO - Return code: 0 21:32:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:32:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:32:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f6be6719e45a73aec994acb9b3b46faad4034a36853afd2db439d9f7da0741b7284aed8fa37f5df1545558f96456cdf205922302fd6bcb577e3459221e1878d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/82502ff6efb8de40a1261cd9ad1cf4986adedbdf28a187bc5af56406c712f4ed5e9c594aad410f8c784b2983b35625d5880f096ba5042da175ea262d50dc67c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1f83ac4e16dbe472ea61709a3635526f284557f227def820a8fb7d5202f0e2c06d5d89e2349aa87e8974143e7e31a333014d58bf1bd6c3d3517b9f2be9abc4a9"} 21:32:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:32:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:32:02 INFO - Contents: 21:32:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f6be6719e45a73aec994acb9b3b46faad4034a36853afd2db439d9f7da0741b7284aed8fa37f5df1545558f96456cdf205922302fd6bcb577e3459221e1878d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/82502ff6efb8de40a1261cd9ad1cf4986adedbdf28a187bc5af56406c712f4ed5e9c594aad410f8c784b2983b35625d5880f096ba5042da175ea262d50dc67c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1f83ac4e16dbe472ea61709a3635526f284557f227def820a8fb7d5202f0e2c06d5d89e2349aa87e8974143e7e31a333014d58bf1bd6c3d3517b9f2be9abc4a9"} 21:32:02 INFO - Running post-run listener: copy_logs_to_upload_dir 21:32:02 INFO - Copying logs to upload dir... 21:32:02 INFO - mkdir: /builds/slave/test/build/upload/logs 21:32:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.325626 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-09 21:32:02.390359) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 21:32:02.393701) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1470802119.966445-492577301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f6be6719e45a73aec994acb9b3b46faad4034a36853afd2db439d9f7da0741b7284aed8fa37f5df1545558f96456cdf205922302fd6bcb577e3459221e1878d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/82502ff6efb8de40a1261cd9ad1cf4986adedbdf28a187bc5af56406c712f4ed5e9c594aad410f8c784b2983b35625d5880f096ba5042da175ea262d50dc67c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1f83ac4e16dbe472ea61709a3635526f284557f227def820a8fb7d5202f0e2c06d5d89e2349aa87e8974143e7e31a333014d58bf1bd6c3d3517b9f2be9abc4a9"} build_url:https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011257 build_url: 'https://queue.taskcluster.net/v1/task/YC6M8UU1QpqZ0xPS4tzhew/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f6be6719e45a73aec994acb9b3b46faad4034a36853afd2db439d9f7da0741b7284aed8fa37f5df1545558f96456cdf205922302fd6bcb577e3459221e1878d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/82502ff6efb8de40a1261cd9ad1cf4986adedbdf28a187bc5af56406c712f4ed5e9c594aad410f8c784b2983b35625d5880f096ba5042da175ea262d50dc67c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1f83ac4e16dbe472ea61709a3635526f284557f227def820a8fb7d5202f0e2c06d5d89e2349aa87e8974143e7e31a333014d58bf1bd6c3d3517b9f2be9abc4a9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 21:32:02.419364) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 21:32:02.419691) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1470802119.966445-492577301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 21:32:02.506341) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 21:32:02.506766) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 21:32:02.507193) ========= ========= Total master_lag: 0.19 =========