builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1471036251.57 results: success (0) buildid: 20160812113016 builduid: 13afb3c1b6cf45289dec2447b1fde441 revision: 8725f14625e0c87776f9acf66e6712ceca301000 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 14:10:51.567768) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 14:10:51.568297) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 14:10:51.568628) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 14:10:51.610450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 14:10:51.610740) ========= 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=232498196343f89f466a4a9a000001c8-1471034741.257538-185105996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-12 14:10:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-08-12 14:10:52 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104743 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 14:10:51.733472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 14:10:51.733778) ========= 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=232498196343f89f466a4a9a000001c8-1471034741.257538-185105996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015615 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 14:10:51.783028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 14:10:51.783434) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8725f14625e0c87776f9acf66e6712ceca301000 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8725f14625e0c87776f9acf66e6712ceca301000 --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=232498196343f89f466a4a9a000001c8-1471034741.257538-185105996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-12 14:10:52,402 truncating revision to first 12 chars 2016-08-12 14:10:52,402 Setting DEBUG logging. 2016-08-12 14:10:52,402 attempt 1/10 2016-08-12 14:10:52,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8725f14625e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 14:10:52,699 unpacking tar archive at: fx-team-8725f14625e0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637108 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 14:10:52.433788) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 14:10:52.434064) ========= script_repo_revision: 8725f14625e0c87776f9acf66e6712ceca301000 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 14:10:52.434482) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 14:10:52.434770) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 14:10:52.482559) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-12 14:10:52.482898) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1471034741.257538-185105996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:10:53 INFO - MultiFileLogger online at 20160812 14:10:53 in /builds/slave/test 14:10:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:10:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:10:53 INFO - {'append_to_log': False, 14:10:53 INFO - 'base_work_dir': '/builds/slave/test', 14:10:53 INFO - 'blob_upload_branch': 'Fx-Team', 14:10:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:10:53 INFO - 'branch': 'Fx-Team', 14:10:53 INFO - 'buildbot_json_path': 'buildprops.json', 14:10:53 INFO - 'config_files': ('talos/linux_config.py',), 14:10:53 INFO - 'default_actions': ('clobber', 14:10:53 INFO - 'read-buildbot-config', 14:10:53 INFO - 'download-and-extract', 14:10:53 INFO - 'populate-webroot', 14:10:53 INFO - 'create-virtualenv', 14:10:53 INFO - 'install', 14:10:53 INFO - 'run-tests'), 14:10:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:10:53 INFO - 'download_minidump_stackwalk': True, 14:10:53 INFO - 'download_symbols': 'ondemand', 14:10:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:10:53 INFO - 'tooltool.py': '/tools/tooltool.py', 14:10:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:10:53 INFO - '/tools/misc-python/virtualenv.py')}, 14:10:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:10:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:10:53 INFO - 'installer_path': 'installer.exe', 14:10:53 INFO - 'log_level': 'info', 14:10:53 INFO - 'log_name': 'talos', 14:10:53 INFO - 'log_to_console': True, 14:10:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:10:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:10:53 INFO - 'opt_config_files': (), 14:10:53 INFO - 'pip_index': False, 14:10:53 INFO - 'sps_profile': False, 14:10:53 INFO - 'sps_profile_interval': 0, 14:10:53 INFO - 'suite': 'dromaeojs-e10s', 14:10:53 INFO - 'system_bits': '32', 14:10:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:10:53 INFO - 'title': 'talos-linux64-ix-025', 14:10:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:10:53 INFO - 'use_talos_json': True, 14:10:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:10:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:10:53 INFO - 'work_dir': 'build'} 14:10:53 INFO - [mozharness: 2016-08-12 21:10:53.201770Z] Running clobber step. 14:10:53 INFO - Running pre-action listener: _resource_record_pre_action 14:10:53 INFO - Running main action method: clobber 14:10:53 INFO - rmtree: /builds/slave/test/build 14:10:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:10:53 INFO - Running post-action listener: _resource_record_post_action 14:10:53 INFO - [mozharness: 2016-08-12 21:10:53.661881Z] Finished clobber step (success) 14:10:53 INFO - [mozharness: 2016-08-12 21:10:53.661982Z] Running read-buildbot-config step. 14:10:53 INFO - Running pre-action listener: _resource_record_pre_action 14:10:53 INFO - Running main action method: read_buildbot_config 14:10:53 INFO - Using buildbot properties: 14:10:53 INFO - { 14:10:53 INFO - "project": "", 14:10:53 INFO - "product": "firefox", 14:10:53 INFO - "script_repo_revision": "production", 14:10:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:10:53 INFO - "repository": "", 14:10:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:10:53 INFO - "buildid": "20160812113016", 14:10:53 INFO - "pgo_build": "True", 14:10:53 INFO - "basedir": "/builds/slave/test", 14:10:53 INFO - "buildnumber": 695, 14:10:53 INFO - "slavename": "talos-linux64-ix-025", 14:10:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:10:53 INFO - "platform": "ubuntu64_hw", 14:10:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:10:53 INFO - "branch": "fx-team", 14:10:53 INFO - "repo_path": "integration/fx-team", 14:10:53 INFO - "revision": "8725f14625e0c87776f9acf66e6712ceca301000", 14:10:53 INFO - "stage_platform": "linux64-pgo", 14:10:53 INFO - "builduid": "13afb3c1b6cf45289dec2447b1fde441", 14:10:53 INFO - "slavebuilddir": "test" 14:10:53 INFO - } 14:10:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 14:10:53 INFO - Running post-action listener: _resource_record_post_action 14:10:53 INFO - [mozharness: 2016-08-12 21:10:53.664408Z] Finished read-buildbot-config step (success) 14:10:53 INFO - [mozharness: 2016-08-12 21:10:53.664497Z] Running download-and-extract step. 14:10:53 INFO - Running pre-action listener: _resource_record_pre_action 14:10:53 INFO - Running main action method: download_and_extract 14:10:53 INFO - mkdir: /builds/slave/test/build/tests 14:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:53 INFO - trying https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:10:53 INFO - Downloading https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/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 14:10:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/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 14:10:54 INFO - Downloaded 1361 bytes. 14:10:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:10:54 INFO - Using the following test package requirements: 14:10:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:10:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:10:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:10:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:54 INFO - u'jsshell-linux-x86_64.zip'], 14:10:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:10:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:10:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:10:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:10:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:10:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:10:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:54 INFO - trying https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:10:54 INFO - Downloading https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/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 14:10:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/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 14:10:55 INFO - Downloaded 21832433 bytes. 14:10:55 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'] 14:10:55 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 14:10:56 INFO - Return code: 0 14:10:56 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 14:10: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')]} 14:10:56 INFO - trying https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:10:56 INFO - Downloading https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/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 14:10:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/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 14:10:57 INFO - Downloaded 21832433 bytes. 14:10:57 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'] 14:10:57 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 14:10:58 INFO - Return code: 0 14:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:58 INFO - trying https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:10:58 INFO - Downloading https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/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 14:10:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/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 14:10:59 INFO - Downloaded 14413719 bytes. 14:10:59 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'] 14:10:59 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 14:11:00 INFO - Return code: 0 14:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:00 INFO - trying https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:11:00 INFO - Downloading https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/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 14:11:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/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 14:11:03 INFO - Downloaded 59339013 bytes. 14:11:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:11:03 INFO - mkdir: /builds/slave/test/properties 14:11:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:11:03 INFO - Writing to file /builds/slave/test/properties/build_url 14:11:03 INFO - Contents: 14:11:03 INFO - build_url:https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:11:04 INFO - Running post-action listener: _resource_record_post_action 14:11:04 INFO - Running post-action listener: set_extra_try_arguments 14:11:04 INFO - [mozharness: 2016-08-12 21:11:04.362460Z] Finished download-and-extract step (success) 14:11:04 INFO - [mozharness: 2016-08-12 21:11:04.362693Z] Running populate-webroot step. 14:11:04 INFO - Running pre-action listener: _resource_record_pre_action 14:11:04 INFO - Running main action method: populate_webroot 14:11:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:11:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:11:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:11:04 INFO - '--tppagecycles', 14:11:04 INFO - '7'], 14:11:04 INFO - 'tests': ['tsvgm']}}, 14:11:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:11:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:11:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:11:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:11:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:11:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:11:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:04 INFO - 'talos_options': ['--disable-e10s'], 14:11:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:04 INFO - 'talos_options': ['--disable-e10s'], 14:11:04 INFO - 'tests': ['damp', 'tps']}, 14:11:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:04 INFO - 'tests': ['damp', 'tps']}, 14:11:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:11:04 INFO - 'tests': ['dromaeo_dom']}, 14:11:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:11:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:11:04 INFO - 'tests': ['basic_compositor_video']}, 14:11:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:11:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:11:04 INFO - 'tests': ['a11yr', 14:11:04 INFO - 'ts_paint', 14:11:04 INFO - 'tpaint', 14:11:04 INFO - 'sessionrestore', 14:11:04 INFO - 'sessionrestore_no_auto_restore', 14:11:04 INFO - 'tabpaint']}, 14:11:04 INFO - 'other-e10s': {'tests': ['a11yr', 14:11:04 INFO - 'ts_paint', 14:11:04 INFO - 'tpaint', 14:11:04 INFO - 'sessionrestore', 14:11:04 INFO - 'sessionrestore_no_auto_restore', 14:11:04 INFO - 'tabpaint']}, 14:11:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:11:04 INFO - 'ts_paint', 14:11:04 INFO - 'tpaint', 14:11:04 INFO - 'sessionrestore', 14:11:04 INFO - 'sessionrestore_no_auto_restore', 14:11:04 INFO - 'tabpaint']}, 14:11:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:11:04 INFO - 'ts_paint', 14:11:04 INFO - 'tpaint', 14:11:04 INFO - 'sessionrestore', 14:11:04 INFO - 'sessionrestore_no_auto_restore', 14:11:04 INFO - 'tabpaint']}, 14:11:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:11:04 INFO - 'tests': ['a11yr', 14:11:04 INFO - 'ts_paint', 14:11:04 INFO - 'tpaint', 14:11:04 INFO - 'sessionrestore', 14:11:04 INFO - 'sessionrestore_no_auto_restore', 14:11:04 INFO - 'tabpaint']}, 14:11:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:11:04 INFO - 'tests': ['a11yr', 14:11:04 INFO - 'ts_paint', 14:11:04 INFO - 'tpaint', 14:11:04 INFO - 'sessionrestore', 14:11:04 INFO - 'sessionrestore_no_auto_restore', 14:11:04 INFO - 'tabpaint']}, 14:11:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:11:04 INFO - 'tests': ['tsvgx', 14:11:04 INFO - 'tsvgr_opacity', 14:11:04 INFO - 'tart', 14:11:04 INFO - 'tscrollx', 14:11:04 INFO - 'cart']}, 14:11:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:11:04 INFO - 'tsvgr_opacity', 14:11:04 INFO - 'tart', 14:11:04 INFO - 'tscrollx', 14:11:04 INFO - 'cart']}, 14:11:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:04 INFO - 'talos_options': ['--disable-e10s'], 14:11:04 INFO - 'tests': ['tp5o']}, 14:11:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:04 INFO - 'tests': ['tp5o']}, 14:11:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:04 INFO - 'talos_options': ['--disable-e10s', 14:11:04 INFO - '--xperf_path', 14:11:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:04 INFO - 'tests': ['tp5n']}, 14:11:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:04 INFO - 'talos_options': ['--xperf_path', 14:11:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:04 INFO - 'tests': ['tp5n']}}, 14:11:04 INFO - 'talos.zip': {'path': '', 14:11:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:11:04 INFO - Running post-action listener: _resource_record_post_action 14:11:04 INFO - [mozharness: 2016-08-12 21:11:04.380221Z] Finished populate-webroot step (success) 14:11:04 INFO - [mozharness: 2016-08-12 21:11:04.380310Z] Running create-virtualenv step. 14:11:04 INFO - Running pre-action listener: _resource_record_pre_action 14:11:04 INFO - Running main action method: create_virtualenv 14:11:04 INFO - Creating virtualenv /builds/slave/test/build/venv 14:11:04 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 14:11:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:11:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:11:04 INFO - Using real prefix '/usr' 14:11:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:11:04 INFO - Installing distribute.............................................................................................................................................................................................done. 14:11:06 INFO - Installing pip.................done. 14:11:06 INFO - Return code: 0 14:11:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:06 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 0x2746030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a053b0>, '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 0x2a062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06740>, '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': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', '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 14:11:06 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 14:11:06 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 14:11:06 INFO - Using env: {'DISPLAY': ':0', 14:11:06 INFO - 'HOME': '/home/cltbld', 14:11:06 INFO - 'LANG': 'en_US.UTF-8', 14:11:06 INFO - 'LANGUAGE': 'en_US:en', 14:11:06 INFO - 'LOGNAME': 'cltbld', 14:11:06 INFO - 'MAIL': '/var/mail/cltbld', 14:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:06 INFO - 'MOZ_NO_REMOTE': '1', 14:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:06 INFO - 'NO_EM_RESTART': '1', 14:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:06 INFO - 'PWD': '/builds/slave/test', 14:11:06 INFO - 'SHELL': '/bin/bash', 14:11:06 INFO - 'SHLVL': '1', 14:11:06 INFO - 'TERM': 'linux', 14:11:06 INFO - 'TMOUT': '86400', 14:11:06 INFO - 'USER': 'cltbld', 14:11:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', 14:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:06 INFO - '_': '/tools/buildbot/bin/python'} 14:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:11:07 INFO - Cleaning up... 14:11:07 INFO - Return code: 0 14:11:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2746030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a053b0>, '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 0x2a062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06740>, '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': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', '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 14:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:11:07 INFO - Using env: {'DISPLAY': ':0', 14:11:07 INFO - 'HOME': '/home/cltbld', 14:11:07 INFO - 'LANG': 'en_US.UTF-8', 14:11:07 INFO - 'LANGUAGE': 'en_US:en', 14:11:07 INFO - 'LOGNAME': 'cltbld', 14:11:07 INFO - 'MAIL': '/var/mail/cltbld', 14:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:07 INFO - 'MOZ_NO_REMOTE': '1', 14:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:07 INFO - 'NO_EM_RESTART': '1', 14:11:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:07 INFO - 'PWD': '/builds/slave/test', 14:11:07 INFO - 'SHELL': '/bin/bash', 14:11:07 INFO - 'SHLVL': '1', 14:11:07 INFO - 'TERM': 'linux', 14:11:07 INFO - 'TMOUT': '86400', 14:11:07 INFO - 'USER': 'cltbld', 14:11:07 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', 14:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:07 INFO - '_': '/tools/buildbot/bin/python'} 14:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:07 INFO - Downloading/unpacking psutil>=3.1.1 14:11:07 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 14:11:07 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 14:11:07 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 14:11:07 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 14:11:07 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 14:11:07 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 14:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:11:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:09 INFO - Installing collected packages: psutil 14:11:09 INFO - Running setup.py install for psutil 14:11:09 INFO - building 'psutil._psutil_linux' extension 14:11:09 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 14:11:09 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 14:11:09 INFO - building 'psutil._psutil_posix' extension 14:11:09 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 14:11:09 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 14:11:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:09 INFO - Successfully installed psutil 14:11:09 INFO - Cleaning up... 14:11:09 INFO - Return code: 0 14:11:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:09 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 0x2746030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a053b0>, '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 0x2a062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06740>, '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': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', '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 14:11:09 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 14:11:09 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 14:11:09 INFO - Using env: {'DISPLAY': ':0', 14:11:09 INFO - 'HOME': '/home/cltbld', 14:11:09 INFO - 'LANG': 'en_US.UTF-8', 14:11:09 INFO - 'LANGUAGE': 'en_US:en', 14:11:09 INFO - 'LOGNAME': 'cltbld', 14:11:09 INFO - 'MAIL': '/var/mail/cltbld', 14:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:09 INFO - 'MOZ_NO_REMOTE': '1', 14:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:09 INFO - 'NO_EM_RESTART': '1', 14:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:09 INFO - 'PWD': '/builds/slave/test', 14:11:09 INFO - 'SHELL': '/bin/bash', 14:11:09 INFO - 'SHLVL': '1', 14:11:09 INFO - 'TERM': 'linux', 14:11:09 INFO - 'TMOUT': '86400', 14:11:09 INFO - 'USER': 'cltbld', 14:11:09 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', 14:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:09 INFO - '_': '/tools/buildbot/bin/python'} 14:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:11:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:11:12 INFO - Installing collected packages: mozsystemmonitor 14:11:12 INFO - Running setup.py install for mozsystemmonitor 14:11:12 INFO - Successfully installed mozsystemmonitor 14:11:12 INFO - Cleaning up... 14:11:12 INFO - Return code: 0 14:11:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2746030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a053b0>, '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 0x2a062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06740>, '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': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', '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 14:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:11:12 INFO - Using env: {'DISPLAY': ':0', 14:11:12 INFO - 'HOME': '/home/cltbld', 14:11:12 INFO - 'LANG': 'en_US.UTF-8', 14:11:12 INFO - 'LANGUAGE': 'en_US:en', 14:11:12 INFO - 'LOGNAME': 'cltbld', 14:11:12 INFO - 'MAIL': '/var/mail/cltbld', 14:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:12 INFO - 'MOZ_NO_REMOTE': '1', 14:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:12 INFO - 'NO_EM_RESTART': '1', 14:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:12 INFO - 'PWD': '/builds/slave/test', 14:11:12 INFO - 'SHELL': '/bin/bash', 14:11:12 INFO - 'SHLVL': '1', 14:11:12 INFO - 'TERM': 'linux', 14:11:12 INFO - 'TMOUT': '86400', 14:11:12 INFO - 'USER': 'cltbld', 14:11:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', 14:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:12 INFO - '_': '/tools/buildbot/bin/python'} 14:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:12 INFO - Downloading/unpacking jsonschema==2.5.1 14:11:12 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 14:11:12 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 14:11:12 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 14:11:12 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 14:11:12 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 14:11:12 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 14:11:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:11:14 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 14:11:14 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 14:11:14 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 14:11:14 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 14:11:14 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 14:11:14 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 14:11:14 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:14 INFO - warning: no files found matching '*.txt' 14:11:14 INFO - no previously-included directories found matching 'build' 14:11:14 INFO - no previously-included directories found matching 'dist' 14:11:14 INFO - no previously-included directories found matching '.git*' 14:11:14 INFO - Installing collected packages: jsonschema, functools32 14:11:14 INFO - Running setup.py install for functools32 14:11:14 INFO - warning: no files found matching '*.txt' 14:11:14 INFO - no previously-included directories found matching 'build' 14:11:14 INFO - no previously-included directories found matching 'dist' 14:11:14 INFO - no previously-included directories found matching '.git*' 14:11:14 INFO - Successfully installed jsonschema functools32 14:11:14 INFO - Cleaning up... 14:11:14 INFO - Return code: 0 14:11:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:14 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 0x2746030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a053b0>, '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 0x2a062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06740>, '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': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', '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 14:11:14 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 14:11:14 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 14:11:14 INFO - Using env: {'DISPLAY': ':0', 14:11:14 INFO - 'HOME': '/home/cltbld', 14:11:14 INFO - 'LANG': 'en_US.UTF-8', 14:11:14 INFO - 'LANGUAGE': 'en_US:en', 14:11:14 INFO - 'LOGNAME': 'cltbld', 14:11:14 INFO - 'MAIL': '/var/mail/cltbld', 14:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:14 INFO - 'MOZ_NO_REMOTE': '1', 14:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:14 INFO - 'NO_EM_RESTART': '1', 14:11:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:14 INFO - 'PWD': '/builds/slave/test', 14:11:14 INFO - 'SHELL': '/bin/bash', 14:11:14 INFO - 'SHLVL': '1', 14:11:14 INFO - 'TERM': 'linux', 14:11:14 INFO - 'TMOUT': '86400', 14:11:14 INFO - 'USER': 'cltbld', 14:11:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', 14:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:14 INFO - '_': '/tools/buildbot/bin/python'} 14:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:11:14 INFO - Cleaning up... 14:11:14 INFO - Return code: 0 14:11:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:14 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 0x2746030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a053b0>, '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 0x2a062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06740>, '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': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', '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 14:11:14 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 14:11:14 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 14:11:14 INFO - Using env: {'DISPLAY': ':0', 14:11:14 INFO - 'HOME': '/home/cltbld', 14:11:14 INFO - 'LANG': 'en_US.UTF-8', 14:11:14 INFO - 'LANGUAGE': 'en_US:en', 14:11:14 INFO - 'LOGNAME': 'cltbld', 14:11:14 INFO - 'MAIL': '/var/mail/cltbld', 14:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:14 INFO - 'MOZ_NO_REMOTE': '1', 14:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:14 INFO - 'NO_EM_RESTART': '1', 14:11:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:14 INFO - 'PWD': '/builds/slave/test', 14:11:14 INFO - 'SHELL': '/bin/bash', 14:11:14 INFO - 'SHLVL': '1', 14:11:14 INFO - 'TERM': 'linux', 14:11:14 INFO - 'TMOUT': '86400', 14:11:14 INFO - 'USER': 'cltbld', 14:11:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', 14:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:14 INFO - '_': '/tools/buildbot/bin/python'} 14:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:15 INFO - Downloading/unpacking blobuploader==1.2.4 14:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:16 INFO - Downloading blobuploader-1.2.4.tar.gz 14:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:11:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:11:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:17 INFO - Downloading docopt-0.6.1.tar.gz 14:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:11:17 INFO - Installing collected packages: blobuploader, requests, docopt 14:11:17 INFO - Running setup.py install for blobuploader 14:11:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:11:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:11:17 INFO - Running setup.py install for requests 14:11:18 INFO - Running setup.py install for docopt 14:11:18 INFO - Successfully installed blobuploader requests docopt 14:11:18 INFO - Cleaning up... 14:11:18 INFO - Return code: 0 14:11:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:18 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')]} 14:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:18 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')]} 14:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:18 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 0x2746030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a053b0>, '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 0x2a062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06740>, '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': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', '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 14:11:18 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 14:11:18 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 14:11:18 INFO - Using env: {'DISPLAY': ':0', 14:11:18 INFO - 'HOME': '/home/cltbld', 14:11:18 INFO - 'LANG': 'en_US.UTF-8', 14:11:18 INFO - 'LANGUAGE': 'en_US:en', 14:11:18 INFO - 'LOGNAME': 'cltbld', 14:11:18 INFO - 'MAIL': '/var/mail/cltbld', 14:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:18 INFO - 'MOZ_NO_REMOTE': '1', 14:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:18 INFO - 'NO_EM_RESTART': '1', 14:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:18 INFO - 'PWD': '/builds/slave/test', 14:11:18 INFO - 'SHELL': '/bin/bash', 14:11:18 INFO - 'SHLVL': '1', 14:11:18 INFO - 'TERM': 'linux', 14:11:18 INFO - 'TMOUT': '86400', 14:11:18 INFO - 'USER': 'cltbld', 14:11:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', 14:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:18 INFO - '_': '/tools/buildbot/bin/python'} 14:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:18 INFO - Running setup.py (path:/tmp/pip-gRiAMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:18 INFO - Running setup.py (path:/tmp/pip-57V9oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:18 INFO - Running setup.py (path:/tmp/pip-ErKm5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:18 INFO - Running setup.py (path:/tmp/pip-tYimGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:18 INFO - Running setup.py (path:/tmp/pip-V2sPkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:18 INFO - Running setup.py (path:/tmp/pip-F4DTlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:19 INFO - Running setup.py (path:/tmp/pip-XU1hkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:19 INFO - Running setup.py (path:/tmp/pip-xSUIw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:19 INFO - Running setup.py (path:/tmp/pip-jpWdhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:19 INFO - Running setup.py (path:/tmp/pip-EIrgEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:19 INFO - Running setup.py (path:/tmp/pip-tF39Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:19 INFO - Running setup.py (path:/tmp/pip-uB75aD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:19 INFO - Running setup.py (path:/tmp/pip-Cx8rqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:19 INFO - Running setup.py (path:/tmp/pip-q_s1lR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:19 INFO - Running setup.py (path:/tmp/pip-ep3qgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:19 INFO - Running setup.py (path:/tmp/pip-OFS7wA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:19 INFO - Running setup.py (path:/tmp/pip-dPZi3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:11:19 INFO - Running setup.py install for manifestparser 14:11:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:11:19 INFO - Running setup.py install for mozcrash 14:11:20 INFO - Running setup.py install for mozdebug 14:11:20 INFO - Running setup.py install for mozdevice 14:11:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:11:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:11:20 INFO - Running setup.py install for mozfile 14:11:20 INFO - Running setup.py install for mozhttpd 14:11:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:11:20 INFO - Running setup.py install for mozinfo 14:11:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:11:20 INFO - Running setup.py install for mozInstall 14:11:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:11:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:11:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:11:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:11:20 INFO - Running setup.py install for mozleak 14:11:20 INFO - Running setup.py install for mozlog 14:11:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:11:20 INFO - Running setup.py install for moznetwork 14:11:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:11:20 INFO - Running setup.py install for mozprocess 14:11:21 INFO - Running setup.py install for mozprofile 14:11:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:11:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:11:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:11:21 INFO - Running setup.py install for mozrunner 14:11:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:11:21 INFO - Running setup.py install for mozscreenshot 14:11:21 INFO - Running setup.py install for moztest 14:11:21 INFO - Running setup.py install for mozversion 14:11:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:11:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:11:21 INFO - Cleaning up... 14:11:21 INFO - Return code: 0 14:11:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:21 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 0x2746030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a053b0>, '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 0x2a062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06740>, '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': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', '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 14:11:21 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 14:11:21 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 14:11:21 INFO - Using env: {'DISPLAY': ':0', 14:11:21 INFO - 'HOME': '/home/cltbld', 14:11:21 INFO - 'LANG': 'en_US.UTF-8', 14:11:21 INFO - 'LANGUAGE': 'en_US:en', 14:11:21 INFO - 'LOGNAME': 'cltbld', 14:11:21 INFO - 'MAIL': '/var/mail/cltbld', 14:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:21 INFO - 'MOZ_NO_REMOTE': '1', 14:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:21 INFO - 'NO_EM_RESTART': '1', 14:11:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:21 INFO - 'PWD': '/builds/slave/test', 14:11:21 INFO - 'SHELL': '/bin/bash', 14:11:21 INFO - 'SHLVL': '1', 14:11:21 INFO - 'TERM': 'linux', 14:11:21 INFO - 'TMOUT': '86400', 14:11:21 INFO - 'USER': 'cltbld', 14:11:21 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', 14:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:21 INFO - '_': '/tools/buildbot/bin/python'} 14:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:21 INFO - Running setup.py (path:/tmp/pip-E7p9Hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:21 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)) 14:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:21 INFO - Running setup.py (path:/tmp/pip-HNHXTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:21 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)) 14:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:21 INFO - Running setup.py (path:/tmp/pip-Inyrmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:22 INFO - Running setup.py (path:/tmp/pip-9HkyL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:22 INFO - Running setup.py (path:/tmp/pip-jrzYAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:22 INFO - Running setup.py (path:/tmp/pip-r35MRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:22 INFO - Running setup.py (path:/tmp/pip-7eA00p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:22 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)) 14:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:22 INFO - Running setup.py (path:/tmp/pip-dHykqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:22 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)) 14:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:22 INFO - Running setup.py (path:/tmp/pip-C1o3xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:22 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)) 14:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:22 INFO - Running setup.py (path:/tmp/pip-zvYx2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:22 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)) 14:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:22 INFO - Running setup.py (path:/tmp/pip-eKj4XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:22 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)) 14:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:22 INFO - Running setup.py (path:/tmp/pip-Elkhfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:22 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)) 14:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:22 INFO - Running setup.py (path:/tmp/pip-NlpiQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:22 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)) 14:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:22 INFO - Running setup.py (path:/tmp/pip-_EMxjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:22 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)) 14:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:22 INFO - Running setup.py (path:/tmp/pip-xI6GjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:22 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)) 14:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:22 INFO - Running setup.py (path:/tmp/pip-MVvdhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:23 INFO - Running setup.py (path:/tmp/pip-_ymSKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:11:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:24 INFO - Downloading blessings-1.6.tar.gz 14:11:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:11:25 INFO - Installing collected packages: blessings 14:11:25 INFO - Running setup.py install for blessings 14:11:25 INFO - Successfully installed blessings 14:11:25 INFO - Cleaning up... 14:11:25 INFO - Return code: 0 14:11:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:11:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:25 INFO - Reading from file tmpfile_stdout 14:11:25 INFO - Current package versions: 14:11:25 INFO - argparse == 1.2.1 14:11:25 INFO - blessings == 1.6 14:11:25 INFO - blobuploader == 1.2.4 14:11:25 INFO - docopt == 0.6.1 14:11:25 INFO - functools32 == 3.2.3-2 14:11:25 INFO - jsonschema == 2.5.1 14:11:25 INFO - manifestparser == 1.1 14:11:25 INFO - mozInstall == 1.12 14:11:25 INFO - mozcrash == 0.17 14:11:25 INFO - mozdebug == 0.1 14:11:25 INFO - mozdevice == 0.48 14:11:25 INFO - mozfile == 1.2 14:11:25 INFO - mozhttpd == 0.7 14:11:25 INFO - mozinfo == 0.9 14:11:25 INFO - mozleak == 0.1 14:11:25 INFO - mozlog == 3.3 14:11:25 INFO - moznetwork == 0.27 14:11:25 INFO - mozprocess == 0.23 14:11:25 INFO - mozprofile == 0.28 14:11:25 INFO - mozrunner == 6.12 14:11:25 INFO - mozscreenshot == 0.1 14:11:25 INFO - mozsystemmonitor == 0.3 14:11:25 INFO - moztest == 0.7 14:11:25 INFO - mozversion == 1.4 14:11:25 INFO - psutil == 3.1.1 14:11:25 INFO - requests == 1.2.3 14:11:25 INFO - wsgiref == 0.1.2 14:11:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:25 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')]} 14:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:25 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')]} 14:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:25 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 0x2746030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a053b0>, '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 0x2a062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06740>, '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': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', '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 14:11:25 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 14:11:25 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 14:11:25 INFO - Using env: {'DISPLAY': ':0', 14:11:25 INFO - 'HOME': '/home/cltbld', 14:11:25 INFO - 'LANG': 'en_US.UTF-8', 14:11:25 INFO - 'LANGUAGE': 'en_US:en', 14:11:25 INFO - 'LOGNAME': 'cltbld', 14:11:25 INFO - 'MAIL': '/var/mail/cltbld', 14:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:25 INFO - 'MOZ_NO_REMOTE': '1', 14:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:25 INFO - 'NO_EM_RESTART': '1', 14:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:25 INFO - 'PWD': '/builds/slave/test', 14:11:25 INFO - 'SHELL': '/bin/bash', 14:11:25 INFO - 'SHLVL': '1', 14:11:25 INFO - 'TERM': 'linux', 14:11:25 INFO - 'TMOUT': '86400', 14:11:25 INFO - 'USER': 'cltbld', 14:11:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', 14:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:25 INFO - '_': '/tools/buildbot/bin/python'} 14:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:25 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)) 14:11:25 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)) 14:11:25 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)) 14:11:25 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)) 14:11:25 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)) 14:11:25 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)) 14:11:25 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)) 14:11:25 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)) 14:11:25 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)) 14:11:25 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)) 14:11:25 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)) 14:11:25 INFO - Cleaning up... 14:11:25 INFO - Return code: 0 14:11:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:11:25 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')]} 14:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:25 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')]} 14:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:25 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 0x2746030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a053b0>, '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 0x2a062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06740>, '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': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', '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 14:11:25 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 14:11:25 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 14:11:25 INFO - Using env: {'DISPLAY': ':0', 14:11:25 INFO - 'HOME': '/home/cltbld', 14:11:25 INFO - 'LANG': 'en_US.UTF-8', 14:11:25 INFO - 'LANGUAGE': 'en_US:en', 14:11:25 INFO - 'LOGNAME': 'cltbld', 14:11:25 INFO - 'MAIL': '/var/mail/cltbld', 14:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:25 INFO - 'MOZ_NO_REMOTE': '1', 14:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:25 INFO - 'NO_EM_RESTART': '1', 14:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:25 INFO - 'PWD': '/builds/slave/test', 14:11:25 INFO - 'SHELL': '/bin/bash', 14:11:25 INFO - 'SHLVL': '1', 14:11:25 INFO - 'TERM': 'linux', 14:11:25 INFO - 'TMOUT': '86400', 14:11:25 INFO - 'USER': 'cltbld', 14:11:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', 14:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:25 INFO - '_': '/tools/buildbot/bin/python'} 14:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:11:25 INFO - Cleaning up... 14:11:25 INFO - Return code: 0 14:11:25 INFO - Running post-action listener: _resource_record_post_action 14:11:25 INFO - Running post-action listener: _start_resource_monitoring 14:11:25 INFO - Starting resource monitoring. 14:11:25 INFO - [mozharness: 2016-08-12 21:11:25.922175Z] Finished create-virtualenv step (success) 14:11:25 INFO - [mozharness: 2016-08-12 21:11:25.922611Z] Running install step. 14:11:25 INFO - Running pre-action listener: _resource_record_pre_action 14:11:25 INFO - Running main action method: install 14:11:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:26 INFO - Reading from file tmpfile_stdout 14:11:26 INFO - Detecting whether we're running mozinstall >=1.0... 14:11:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:11:26 INFO - Reading from file tmpfile_stdout 14:11:26 INFO - Output received: 14:11:26 INFO - Usage: mozinstall [options] installer 14:11:26 INFO - Options: 14:11:26 INFO - -h, --help show this help message and exit 14:11:26 INFO - -d DEST, --destination=DEST 14:11:26 INFO - Directory to install application into. [default: 14:11:26 INFO - "/builds/slave/test"] 14:11:26 INFO - --app=APP Application being installed. [default: firefox] 14:11:26 INFO - mkdir: /builds/slave/test/build/application 14:11:26 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'] 14:11:26 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 14:11:43 INFO - Reading from file tmpfile_stdout 14:11:43 INFO - Output received: 14:11:43 INFO - /builds/slave/test/build/application/firefox/firefox 14:11:43 INFO - Running post-action listener: _resource_record_post_action 14:11:43 INFO - [mozharness: 2016-08-12 21:11:43.324663Z] Finished install step (success) 14:11:43 INFO - [mozharness: 2016-08-12 21:11:43.324914Z] Running run-tests step. 14:11:43 INFO - Running pre-action listener: _resource_record_pre_action 14:11:43 INFO - Running main action method: run_tests 14:11:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:11:43 INFO - Python 2.7.3 14:11:43 INFO - Return code: 0 14:11:43 INFO - grabbing minidump binary from tooltool 14: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')]} 14:11:43 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a053b0>, '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 0x2a062b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:11:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:11:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:11:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:11:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:11:43 INFO - Return code: 0 14:11:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:11:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:11:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:11:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:11:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:11:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:11:43 INFO - Using env: {'DISPLAY': ':0', 14:11:43 INFO - 'HOME': '/home/cltbld', 14:11:43 INFO - 'LANG': 'en_US.UTF-8', 14:11:43 INFO - 'LANGUAGE': 'en_US:en', 14:11:43 INFO - 'LOGNAME': 'cltbld', 14:11:43 INFO - 'MAIL': '/var/mail/cltbld', 14:11:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:11:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:43 INFO - 'MOZ_NO_REMOTE': '1', 14:11:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:43 INFO - 'NO_EM_RESTART': '1', 14:11:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:43 INFO - 'PWD': '/builds/slave/test', 14:11:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:11:43 INFO - 'SHELL': '/bin/bash', 14:11:43 INFO - 'SHLVL': '1', 14:11:43 INFO - 'TERM': 'linux', 14:11:43 INFO - 'TMOUT': '86400', 14:11:43 INFO - 'USER': 'cltbld', 14:11:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471034741.257538-185105996', 14:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:43 INFO - '_': '/tools/buildbot/bin/python'} 14:11:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:11:43 INFO - mozversion application_buildid: 20160812113016 14:11:43 INFO - mozversion application_changeset: 8725f14625e0c87776f9acf66e6712ceca301000 14:11:43 INFO - mozversion application_display_name: Nightly 14:11:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:11:43 INFO - mozversion application_name: Firefox 14:11:43 INFO - mozversion application_remotingname: firefox 14:11:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:11:43 INFO - mozversion application_vendor: Mozilla 14:11:43 INFO - mozversion application_version: 51.0a1 14:11:43 INFO - mozversion platform_buildid: 20160812113016 14:11:43 INFO - mozversion platform_changeset: 8725f14625e0c87776f9acf66e6712ceca301000 14:11:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:11:43 INFO - mozversion platform_version: 51.0a1 14:11:43 INFO - using testdate: 1471036303 14:11:43 INFO - actual date: 1471036303 14:11:43 INFO - starting webserver on 'localhost:59214' 14:11:43 INFO - SUITE-START | Running 2 tests 14:11:43 INFO - TEST-START | dromaeo_css 14:11:43 INFO - operating with platform_type : linux_ 14:11:43 INFO - Initialising browser for dromaeo_css test... 14:11:43 INFO - TEST-INFO | started process 23902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvJWj2Q/profile http://localhost:59214/getInfo.html) 14:11:47 INFO - PROCESS | 23902 | __metrics Screen width/height:1600/1200 14:11:47 INFO - PROCESS | 23902 | colorDepth:24 14:11:47 INFO - PROCESS | 23902 | Browser inner width/height: 1024/697 14:11:47 INFO - PROCESS | 23902 | __metrics 14:11:48 ERROR - PROCESS | 23902 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 14:11:49 INFO - TEST-INFO | 23902: exit 0 14:11:49 INFO - Browser initialized. 14:11:49 INFO - Running cycle 1/1 for dromaeo_css test... 14:11:49 INFO - TEST-INFO | started process 24022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvJWj2Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:01 INFO - PROCESS | 24022 | RSS: Main: 162705408 14:12:01 INFO - PROCESS | 24022 | 14:12:50 INFO - PROCESS | 24022 | 1471036370925 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] 14:15:00 INFO - PROCESS | 24022 | Cycle 1(1): loaded http://localhost:59214/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59214/tests/dromaeo/cssquery-ext.html) 14:15:01 INFO - PROCESS | 24022 | RSS: Main: 164544512 14:15:01 INFO - PROCESS | 24022 | 14:18:04 INFO - PROCESS | 24022 | Cycle 1(1): loaded http://localhost:59214/tests/dromaeo/cssquery-ext.html (next: http://localhost:59214/tests/dromaeo/cssquery-jquery.html) 14:18:04 INFO - PROCESS | 24022 | RSS: Main: 164589568 14:18:04 INFO - PROCESS | 24022 | 14:21:06 INFO - PROCESS | 24022 | Cycle 1(1): loaded http://localhost:59214/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59214/tests/dromaeo/cssquery-mootools.html) 14:21:07 INFO - PROCESS | 24022 | RSS: Main: 168595456 14:21:07 INFO - PROCESS | 24022 | 14:24:09 INFO - PROCESS | 24022 | Cycle 1(1): loaded http://localhost:59214/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59214/tests/dromaeo/cssquery-prototype.html) 14:24:09 INFO - PROCESS | 24022 | RSS: Main: 163209216 14:24:09 INFO - PROCESS | 24022 | 14:27:12 INFO - PROCESS | 24022 | Cycle 1(1): loaded http://localhost:59214/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59214/tests/dromaeo/cssquery-yui.html) 14:27:12 INFO - PROCESS | 24022 | RSS: Main: 165130240 14:27:12 INFO - PROCESS | 24022 | 14:30:15 INFO - PROCESS | 24022 | Cycle 1(1): loaded http://localhost:59214/tests/dromaeo/cssquery-yui.html (next: http://localhost:59214/tests/dromaeo/cssquery-dojo.html) 14:30:16 INFO - PROCESS | 24022 | RSS: Main: 168869888 14:30:16 INFO - PROCESS | 24022 | 14:30:16 INFO - PROCESS | 24022 | __start_tp_report 14:30:16 INFO - PROCESS | 24022 | _x_x_mozilla_page_load 14:30:16 INFO - PROCESS | 24022 | _x_x_mozilla_page_load_details 14:30:16 INFO - PROCESS | 24022 | |i|pagename|runs| 14:30:16 INFO - PROCESS | 24022 | |0;dojo.html;3084.8611812468434;3086.6913308669123;3122.594062771839;3124.156477751007;3127.405792899349;5345.518903298703;5399.5680345572355;5460.78156873725;5495.560355171587;5498.120300751875;5362.624616276862;5465.836024919249;5490.80782172624;5500.339959204891;5524.640898341605;4956.40523137224;5040.6471546991725;5075;5114.590832733373;5182.896342073156;5114.974425127869;5158.845234642948;5161.122609156452;5203.193505006711;5232.581393488531;4830.178869592178;4950.554450099508;4981.103401387731;5012.972340670154;5055.064813009605;4999.725015124167;5050.217216331474;5060.367454068241;5097.082525145473;5104.489551044903;5002.774875130592;5010.148274793294;5019.949800501985;5022.824201152978;5037.823676171353;5196.272521846944;5346.91979620306;5490.780368785244;5491.093969495028;5530.446955304477;5745.54035677149;5784.103463963051;5788.6816225107605;5790.7683692652245;5845.678487683176;5861.85345366365;5890.528757699417;5891.410858914117;5895.410458954113;5911.29064512257;5343.145096784496;5483.369412517612;5490.231367608498;5502.697351645658;5528.253685752412;6014.188084608521;6089.025478338473;6094.487876503085;6095.438338978099;6133.172021777003;5807.651540907559;5851.32709738377;5853.180554722342;5868.941310586925;5881.059030555176;5603.187537806995;5795.681237531892;5936.347001829795;5946.910796338058;5947.226860508106;5801.564882633819;5878.088896221093;5918.348981612019;5923.259592550931;5941.70291485424;5878.617889837147;5900.085486749561;5905.232319798399;5906.232189815297;5909.674967876722;4372.278574035312;4423.0048239145935;4494.348319493721;4517.322401639714;4543.54564543543;3957.4261732049267;4001.8999525011527;4022.054817117975;4050.837966481308;4079.224947260011;5605.215269862222;5627.746751396197;5643;5653.23681303027;5658.292713410824;5658.207850900877;5832.679202643895;5867.735951882176;5909.881802363929;5918.970405148033;5603;5687.544996400278;5696.544276457874;5710.5717071219;5714.571407144397;5076.111680455905;5076.593872490192;5079.263506791494;5098.847034588968;5127.07712611726;5937.376575459514;6000.639961602318;6154.046122850965;6206.875862482725;6217;5750.5112065474905;5806.187133801355;5811.651300921958;5820.359760426434;5843.415658434293;6076.8784624308155;6094.329623741296;6110.297315808739;6120.510359171345;6135.938640613536;5630.324361076697;5690.061139911868;5759.481646651821;5765.106408506688;5784.987627165145;5821.970890145522;5876.647401155944;5881.235439392852;5881.705914704333;5947.464728174485;5755.942440575708;5762.193292939076;5764.769409223584;5768.1636162757;5777.942220577908;5493.423190564933;5697.54419646419;5718.51392631631;5734.483896449339;5743.856403589776;5723.399043100581;5728.341240757366;5738.942610573841;5762.94237057624;5786.392428795084;5790.189373487631;5794.797182098607;5803.767849285981;5856.882862342644;5858.179854820243;5475.972620136874;5584.301962254718;5626.212330273683;5706.029974904359;5715.457031581993 14:30:16 INFO - PROCESS | 24022 | |1;ext.html;568.7326956330525;592.6473748119868;593.2762030323005;599.6971529377666;605.4278706622243;38424.231515369676;42765.78617106918;42789.14421711564;42856.14287714244;42921;42759.57240427595;43410.34884476735;43507.34738978918;43654.78172609132;43699.781501092526;8816.250618697419;9010.639574417048;9014.233790127848;9020.548972551345;9028.32287578431;9000.549972501381;9018.954905225464;9064.592093355783;9067.954660226722;9080.40977336471;9113.134252246025;9133.588988495501;9134.634614615408;9163.770905727344;9166.633334666605;9075.95462022689;9103;9104.453732776055;9120.908790912072;9127.543622818866;8842.5136617486;8843;8881.600327985256;8888.155625215593;8943.955280223558;40954.795226023976;41231.58768412308;41250.58749412528;41425.585744142474;41488;2759.65504311961;3403.3193361327585;3548.609652938175;3657.7073834093208;3704.85180592776;30881.845590772125;33013.83493082519;33827.4925876112;34548.65451345479;34605.82697086524;4090.877273681794;4127.071408932996;4136.420901073852;4280.657547396201;4292.892677683051;344735;348021;348441;350237.24881375686;350491;60513.69743151344;60641.393586064456;60835.69582152061;60919.69540152271;61263.69368153131;36760.81619591938;37485.812570937516;64749.67625161844;65311.346886530526;65388;16041.518754437386;16428.67142657164;16440.424585139463;16452.177391130634;16454.588635284214;12597.244165350108;12689.746205076031;12761.553345632858;12791.616251512469;12791.889338259269;19303.51741206481;19310.32413865536;19321.834128175135;19470.8052919469;19572.217111315673;7179.820504487325;7209.567425954355;7281.817954551073;7419.6661150248365;7466.887996680054;845.8477474054729;901.1571336616635;907.8456662367413;997.7904640025531;1015.9288849780593;29080;29671.258218544277;29742.25644358908;29866.40267194644;29917.850410747807;992.7915137821138;993.5926270229171;1042.196999191388;1056.9694547815818;1127.0363838917772;16309.184540772914;16483.175841207893;16575.171241437878;17175.196604356614;17382.21780019902;559081;559720;563134;563746;567793;58365.41634583685;58760.41239587549;58940.41059589435;58967;59067;1296.2546535741985;1351.1015174908773;1351.4526616720048;1368.2679766324968;1375.3535838156051;28749.28126796847;29703.25741856471;30026.549601755552;30205.244868878453;30310;50840.745796270785;51525.227121593955;51577;51933.740331298104;52035.73982130065;494324;498178;500455;500860;502141;28671.569926450702;28791.712082878905;28799.5680064795;28878.566821497276;28945;47091.76454117707;47714.76142619265;48804.51195488142;49218.507814921395;49852.50147498624;39997.80001099976;41304.79347603363;44664;46169.76915115403;46195;42291.57708422876;42405.787971059945;42555.148897022504;42754.358684620376;43229.56770432381;38415.807920960215;39031.2193756129;39097.21805563816;39351.80324098361;41448.792756036026;32364.35271294514;37323.81338093292;38375.18921322229;38487;38754.6124538751;24889.751102488743;25162;25589.104381347308;25840.8707956459;25881.352966175997 14:30:16 INFO - PROCESS | 24022 | |2;jquery.html;379.26990543204323;387.87950934730094;396.6152831753199;399.2195258270081;399.86004898285603;14254.928725356358;18521.259149634014;19282.807171928278;19932.60134797305;19979.60040799185;17725.37961171356;17774.200160992754;17809.554761130978;18417.723734143998;19279.518012049706;5916.171735956958;6036.15493830864;6061.545384096188;6095.055266433687;6096.634201947897;5905.527557795387;5967.8209653710455;5986.221791167142;5993.430624090704;6023.518118550505;5941.138534912435;5979.1031345298115;5989.431004054608;5991.610545314563;6006.759729610811;5815.21494598228;5824.737886795105;5874.1776151338845;5992.910106348409;6011.939880601203;5289.100852855024;5299.920501192485;5336.893262134736;5362.168863826113;5364.597655175839;23772.40568985772;24034.399140021465;24162.51674966491;24339.756602433925;24378.878105609358;2083.9687404688943;2416.867072311022;2449.9265022049367;2530.177692250026;2559.41133539287;10213.489325533694;10353.378797272113;10462.424566648831;10569.260151789378;10662.306950048222;1822.4623735997911;1890.971635425456;1912.1204246046834;1943.183123779271;1945.472803848986;83616.16383836145;88172;91531;94185.5290723542;94935.52532237295;11024.559017639205;11122.332660040423;11230.270032447865;11352.716182095513;11452.828207576893;12487.562935297221;13375.264360460074;15868.52394428169;15902.045877247403;15904.045757254602;6987.091678081817;7228.746993855189;7267.963660181771;7281.635918204069;7593.088829340514;7202.567845929261;7237.782866514013;7287.562746235137;7290.5625662460425;7325.850772944246;4119.773412462343;4135.545090040093;4160.8335666573;4293.785310734451;4313.698041137153;1874.5594785225462;1969.4091772468203;2026.0983862181188;2040.3266921915733;2058.341330774168;975.3952549419405;989.3272574649163;996.9800603987879;1011.5903059261011;1016.3038318751679;18122.546936326435;19303.51741206481;19465.513362165777;19477.415677529698;19825.702614460795;904.0778406025817;905.2395987370641;947.7346343023964;950.6500768908166;974.7855471796336;10462.529186186639;10855;10917.727056823484;10940.890591094147;10966.122710183166;456006;462138;463415;464941;473253;87029.56485217533;94397;96990.51504742431;98040.50979745056;98412;477.7635070640055;487.59285996193574;489.7502273840296;491.7148054128597;492.29110081483265;10314.329568578018;10753.301035432673;10829.783404331713;10971.780564388508;11081.168912331446;30130.246743830703;31630.525542117346;42544.78727606342;42616.78691606522;44182.55817441784;57529;58801.70599146977;58832;58914.705426472596;58930.11604825845;8500.532470713923;8506.829863402822;8826.382153249211;11893.881061189277;12561.87438125607;13830.31092591562;14015.159090454605;14107.788383174055;14284;14762.778558321848;12284.201526900722;12313.753724925273;12463.563775268185;12558.686032848886;12745.872541274468;12448.502059917502;12727.745445091232;12768.6807829805;12895.355232238164;13133.60599182026;12206.87793122093;12437.689057773629;12734.426950787421;12843.743125137631;12986.935065324991;12864.807027894776;12892.871071289543;12961.22232666043;12981;13409.530666426628;12402.317872516738;12445.62663120108;12470.5011799527;12772.425240863997;13008.739825203633 14:30:16 INFO - PROCESS | 24022 | |3;mootools.html;1469.9118052916826;1486.5911874234585;1628.527726959181;1706.9743953840687;1781.340903865569;7285;7830.6867725290995;8162.142974987615;8536.658533658654;8572;8134.91865081349;8522.190391912774;8538.530380829052;8546.871796923035;8549.871751923725;2323.1520495019367;2356.9882150589224;2381.404648837791;2381.95236095278;2386.6300723387817;2265.909363625453;2269.4326418395403;2333.276684227886;2347.8239132065078;2354.6703461515403;2356.7643235676464;2364.893579788905;2365.7161140663143;2375.798057165143;2389.2115601851347;2298.4483723906224;2300.114455934477;2308;2315.189683610731;2339.4502291961376;2253.9098436062536;2271.7728227177317;2274.9090036398525;2286.8284878634167;2290.393045842853;8347.874781878276;8379.162083791633;8417.621207045697;8443.788905277355;8448.83102337956;5036.924446133311;5049.621278404097;5135.281060651511;5140.383154021504;5168.5606723428555;3197.6642452542383;3265.853036613358;3335.399628066947;3341.1480072581335;3377.037544299863;1162.5354248992192;1170.0405667352775;1173.8826117388278;1180.262336039975;1208.6011616166643;11756.294622322688;11851.999999999915;11920.642380728592;11924.940375298154;11969.700757481045;4257.574242575718;4520.208963431386;4568.908621827612;4721.9055618888115;4727.345429099788;10025.849612255823;10047.497625118714;10051.69844904654;10054.74863128413;10065.64770233053;5063.924041139386;5069.9746501267255;5082.974585127125;5099.184130539096;5110.642255042186;4070.4504891839815;4634.629229661619;4679.040796636681;4687.906241875144;4700.2009658358165;3698.7041036716996;3867.5939026402384;3900.356441187229;3901.7954855506546;4029.858954936622;1162.2213117211488;1189.3696340939316;1191.9106067045007;1193.8686744458103;1204.4098391787961;911.8221946720325;970.5680971967548;978.9657361992296;981.6417007792247;984.9015098490237;5763.711814409263;5865.35481097079;5869.706514674249;5920.200772895604;5991.880162396727;445.67911104005066;447.31784029354844;453.32001997004494;454.2799662534853;457.7848411246709;4026.1142548639255;4126.071633882352;4136.710430269913;4141.399497072907;4151.14901445203;10265.281430299807;10544.367337959748;10605;10657.893421065844;10662.466876656292;10552.103071238877;10603.681889543326;10613.734656633645;10625.309354892062;10664.253502254767;7517.962410188024;8041.597920103972;8088.636011379502;8096.230858068474;8122.106568277485;5928.34788173292;6027;6076.605020673642;6112.235970503687;6200.689965501617;9651.372660777028;9696.903030969883;9735.853962190715;9765;9777.364471309342;9805.509724513888;9838.212942964688;9913.900860991298;9985.101340879355;9985.251106167212;7657.272559106876;7677.347425468898;7755.379569634529;7755.534667919943;7779;8204.425690201628;8239.835203295781;8269.793255168668;8274.503529788231;8328.875066874123;7452.180260171268;7478.850422991619;7618.542887426772;7639;7682.769516914502;7177.677004534913;7451.254874512505;7555.244475552401;7562.395008399425;7717.382609391123;6744.494162937701;6859.725610975505;6870.381665650116;6910.481713871379;6957.756478523227;5146.536811686966;5152.381714194321;5153.304303918923;5182.896342073062;5364.946350536601;5218.556422704112;5225.477452254896;5303.390110137384;5330.360356757214;5332.253484512094 14:30:16 INFO - PROCESS | 24022 | |4;prototype.html;311.2483352703222;321.64458273607676;322.7111734997179;326.7990186035588;329.16720696637503;5481.534069604083;5520.696361700105;5562.415946325638;5577.191307260455;5591.888162236753;5359.678419294845;5423.972880135604;5442.911417716463;5467.289252397183;5475.014497390468;4043.7978101094973;4191.350340697181;4288.249556327646;4313.352997050436;4324.156789426063;4276.786160691953;4288.863451185438;4297.462817147856;4300.268954277764;4324.9351259730975;4243.299855523835;4272.295071313245;4275.25183092959;4284.6289187460025;4287.228298906196;4015.337469317559;4202.747835129902;4217.177650358181;4249.3625956106835;4288.76411797351;3705.5177928828416;3712.851485940559;3715.9442608360896;3723.72072094594;3723.832427540767;5282.26048353227;5309.442508536626;5313.468653134656;5323.680579165262;5339.41266460689;4585.403897493305;4777.641676874248;4847.224444088929;4851.393575803025;4864.829730959399;5665.405132461074;5709.400512946122;5722.341930677942;5734.139879018139;5736.598438109334;4066.552679205285;4076.4496792932873;4086.427900093989;4091.0590564170407;4093.3246014407587;5748.913766293509;5871.266091738533;5914.556408269354;5942.732577034;5943.613665111754;4163.770992595436;4163.959659766692;4168;4169.979150104291;4170.72890262132;4194.5386007539755;4222.514410842731;4225.260579398593;4241;4241.409471448207;4682.274247491644;4823.155947709207;4826.493218212037;4853.757312134379;4853.854384368475;5690.3456102548735;5736.422483816984;5748.482636562646;5751.252337196138;5757.65454072757;1431.0912570517796;1449.7680371140566;1450.9335638305836;1459.569427019032;1461.13062727679;891.0465801592234;916.1388295002677;938.3525367496542;939.0843927170954;976.1166144639113;5448.673079615236;5514.338279406497;5516.613837031369;5518.613697041249;5530.668159910419;5802.361740208574;5810.970945145332;5813.563982701315;5827.3298570664065;5835.270591176103;5334.946650533522;5471.562275017989;5477.546925212716;5483.779069476788;5534.7786088556;3061.6681743441673;3064.7088526589937;3081.768867334959;3091.4899041658323;3113.8131712097347;5881.617694849821;6018.608790428608;6079.969600151971;6081.878362432726;6091.238595175603;6077.24034495688;6094.360092190344;6110.450059494667;6116.204893363834;6149.200603921461;6103.938960610426;6121.969390153021;6162.506999440034;6170.753169873155;6217.906731399123;5619.522340600931;5855.7364918579615;5887;5905.675187864708;5918.674472904032;5856.590038697421;5900.580761887605;5903.203067585821;5911.172435858897;5914.497267732291;5945.821625351074;6131;6215.378462153749;6220.377962203744;6220.720067596879;4250.723702959298;4299.516666749966;4304.246756817607;4321.611055004939;4330.098833781311;5849.590528662953;5897.3807750187325;5915.40845915405;5918.3489816121055;5960.6125601837475;5581.748821303132;5736.225609542658;5751;5759.539236860957;5786.189933409242;5725.2843394575675;5727.53484142088;5738.225339579103;5754.971225144015;5756.1941328214925;5158.603483923658;5666.660000399989;5678.290213723285;5685.260916081049;5688.914666279927;5711.143328500592;5773.653580785166;5775.797847075332;5798.8692205019615;5808.651480911159;5648.830535083954;5666.405027472056;5699.23060386859;5716.5426765859465;5732.484076433141 14:30:16 INFO - PROCESS | 24022 | |5;yui.html;746.3133916796546;751.9248075192478;792.1326147868084;799.0850476204746;861.4185424838232;14521.564353069412;15260.771088433668;15273.847261527382;15295.388184472622;15298.464553740621;14682.559523214293;14784;14897.77653335201;14898.10611363319;14914.850851491481;648.4455790299297;780.4926797581561;785.1598789295442;799.7081065411112;803.2289002557523;582.548524893207;583.8803045375688;585.938476459972;586.1325238646805;586.419444749699;848.1899785704668;849.4818160921833;849.7705619482736;850.8766228896807;852.0669866496177;836.2473773603745;840.9747707568782;846.4328899637196;847.1570787066846;848.0163010907348;621.7481919822479;621.9844503887439;623.2832242920678;623.554158776477;623.9001759718469;15030.699386012328;15095.094294342374;15151.545453636409;15212;15212.619684507865;15645.921770391189;16024.679506409806;16074.43739469113;16150.192490375433;16207.108609026498;12376.752464950741;12704.364781760874;12772.808407873888;12825.871741282654;12868.87131128686;3893.7274390792654;3920.196359746245;3929.135590170158;3937.3897045957638;3996.18078293949;82372.58813705953;83395.5830220851;84038.57980710118;84836.15163848407;85621.57189214014;12063.939680301542;12197.329146897006;12284.508619655293;12295.56965506203;12398.07014473918;23601.881990589936;23624.881875590854;23644.527109457715;23676.763232367455;23754.64368034481;8649.956750216208;8657.264132548804;8686.826263474695;8895.555222238861;8898.510581917928;4724.881877953078;4732.1718699227495;4751.358566593535;4819.6867203631655;4843.951560484421;3492.7904325740537;3558.0749005258303;3601.963980360163;3621.040424287566;3627.927441451209;601.4977493792645;610.3987572241339;620.2154274842328;633.7084940927133;658.6542065415599;652.4095693397483;716.9032180655649;759.5556599389308;764.8470305938723;784.5488843914771;9935.105840474393;10089.646862359783;10274.640387586398;10291.43397113151;10337;716.4769718105812;753.3671715758788;760.6539024743728;772.9458937874407;775.46880386934;4564.475085365159;4927.408710954708;4962.131626965339;4962.851114466572;4977.32806071183;74888;96633.51683241679;108439.45780271049;117832;135010.3249483766;115521.4223928875;117475.82524174648;117492.41253793848;117500;117967.41016294864;58001.4199857996;88627;95168.52415737876;95296.52351738197;99066.5046674762;9096.590653420744;9171.037041110854;9225.261979041794;9306.906930930603;9521.857172142285;57751;58196.38116284693;58898;59214.70392648009;59933;76570;83603;84192.15807841843;84661.15338846533;86031.13968860231;12018;12018;12426;12785.36073196318;12879.420426081037;13324.600261992156;13573.86426135726;13636.386362613905;13674.453021879013;13709.725805483635;13031.804522931974;13187.60437186886;13603.863961360656;13725.794113088112;13757.10578812374;12975.221486710827;13285.40215690277;13303.334833258104;13336.733265334833;13341.533046343331;12320.938395307967;12445.62663120108;12516.687082823002;12690.428930697955;13110;10873.782524349626;10956.671299861016;11043.503042362952;11093.44532773342;11241.60654377093;10068.899311006797;10092.34399764013;10245.538950747085;11049.723756906142;11056.502457389597 14:30:16 INFO - PROCESS | 24022 | __end_tp_report 14:30:16 INFO - PROCESS | 24022 | __start_cc_report 14:30:16 INFO - PROCESS | 24022 | _x_x_mozilla_cycle_collect,317 14:30:16 INFO - PROCESS | 24022 | __end_cc_report 14:30:16 INFO - PROCESS | 24022 | __startTimestamp1471037416188__endTimestamp 14:30:16 INFO - PROCESS | 24022 | 14:30:16 INFO - PROCESS | 24022 | ------- Summary: start ------- 14:30:16 INFO - PROCESS | 24022 | Number of tests: 6 14:30:16 INFO - PROCESS | 24022 | 14:30:16 INFO - PROCESS | 24022 | [#0] dojo.html Cycles:165 Average:5468.21 Median:5706.03 stddev:625.47 (11.0%) stddev-sans-first:598.79 14:30:16 INFO - PROCESS | 24022 | Values: 3084.9 3086.7 3122.6 3124.2 3127.4 5345.5 5399.6 5460.8 5495.6 5498.1 5362.6 5465.8 5490.8 5500.3 5524.6 4956.4 5040.6 5075.0 5114.6 5182.9 5115.0 5158.8 5161.1 5203.2 5232.6 4830.2 4950.6 4981.1 5013.0 5055.1 4999.7 5050.2 5060.4 5097.1 5104.5 5002.8 5010.1 5019.9 5022.8 5037.8 5196.3 5346.9 5490.8 5491.1 5530.4 5745.5 5784.1 5788.7 5790.8 5845.7 5861.9 5890.5 5891.4 5895.4 5911.3 5343.1 5483.4 5490.2 5502.7 5528.3 6014.2 6089.0 6094.5 6095.4 6133.2 5807.7 5851.3 5853.2 5868.9 5881.1 5603.2 5795.7 5936.3 5946.9 5947.2 5801.6 5878.1 5918.3 5923.3 5941.7 5878.6 5900.1 5905.2 5906.2 5909.7 4372.3 4423.0 4494.3 4517.3 4543.5 3957.4 4001.9 4022.1 4050.8 4079.2 5605.2 5627.7 5643.0 5653.2 5658.3 5658.2 5832.7 5867.7 5909.9 5919.0 5603.0 5687.5 5696.5 5710.6 5714.6 5076.1 5076.6 5079.3 5098.8 5127.1 5937.4 6000.6 6154.0 6206.9 6217.0 5750.5 5806.2 5811.7 5820.4 5843.4 6076.9 6094.3 6110.3 6120.5 6135.9 5630.3 5690.1 5759.5 5765.1 5785.0 5822.0 5876.6 5881.2 5881.7 5947.5 5755.9 5762.2 5764.8 5768.2 5777.9 5493.4 5697.5 5718.5 5734.5 5743.9 5723.4 5728.3 5738.9 5762.9 5786.4 5790.2 5794.8 5803.8 5856.9 5858.2 5476.0 5584.3 5626.2 5706.0 5715.5 14:30:16 INFO - PROCESS | 24022 | 14:30:16 INFO - PROCESS | 24022 | [#1] ext.html Cycles:180 Average:62495.22 Median:42756.97 stddev:127267.27 (297.7%) stddev-sans-first:127539.36 14:30:16 INFO - PROCESS | 24022 | Values: 568.7 592.6 593.3 599.7 605.4 38424.2 42765.8 42789.1 42856.1 42921.0 42759.6 43410.3 43507.3 43654.8 43699.8 8816.3 9010.6 9014.2 9020.5 9028.3 9000.5 9019.0 9064.6 9068.0 9080.4 9113.1 9133.6 9134.6 9163.8 9166.6 9076.0 9103.0 9104.5 9120.9 9127.5 8842.5 8843.0 8881.6 8888.2 8944.0 40954.8 41231.6 41250.6 41425.6 41488.0 2759.7 3403.3 3548.6 3657.7 3704.9 30881.8 33013.8 33827.5 34548.7 34605.8 4090.9 4127.1 4136.4 4280.7 4292.9 344735.0 348021.0 348441.0 350237.2 350491.0 60513.7 60641.4 60835.7 60919.7 61263.7 36760.8 37485.8 64749.7 65311.3 65388.0 16041.5 16428.7 16440.4 16452.2 16454.6 12597.2 12689.7 12761.6 12791.6 12791.9 19303.5 19310.3 19321.8 19470.8 19572.2 7179.8 7209.6 7281.8 7419.7 7466.9 845.8 901.2 907.8 997.8 1015.9 29080.0 29671.3 29742.3 29866.4 29917.9 992.8 993.6 1042.2 1057.0 1127.0 16309.2 16483.2 16575.2 17175.2 17382.2 559081.0 559720.0 563134.0 563746.0 567793.0 58365.4 58760.4 58940.4 58967.0 59067.0 1296.3 1351.1 1351.5 1368.3 1375.4 28749.3 29703.3 30026.5 30205.2 30310.0 50840.7 51525.2 51577.0 51933.7 52035.7 494324.0 498178.0 500455.0 500860.0 502141.0 28671.6 28791.7 28799.6 28878.6 28945.0 47091.8 47714.8 48804.5 49218.5 49852.5 39997.8 41304.8 44664.0 46169.8 46195.0 42291.6 42405.8 42555.1 42754.4 43229.6 38415.8 39031.2 39097.2 39351.8 41448.8 32364.4 37323.8 38375.2 38487.0 38754.6 24889.8 25162.0 25589.1 25840.9 25881.4 14:30:16 INFO - PROCESS | 24022 | 14:30:16 INFO - PROCESS | 24022 | [#2] jquery.html Cycles:180 Average:28586.91 Median:13414.40 stddev:76912.61 (573.4%) stddev-sans-first:77099.21 14:30:16 INFO - PROCESS | 24022 | Values: 379.3 387.9 396.6 399.2 399.9 14254.9 18521.3 19282.8 19932.6 19979.6 17725.4 17774.2 17809.6 18417.7 19279.5 5916.2 6036.2 6061.5 6095.1 6096.6 5905.5 5967.8 5986.2 5993.4 6023.5 5941.1 5979.1 5989.4 5991.6 6006.8 5815.2 5824.7 5874.2 5992.9 6011.9 5289.1 5299.9 5336.9 5362.2 5364.6 23772.4 24034.4 24162.5 24339.8 24378.9 2084.0 2416.9 2449.9 2530.2 2559.4 10213.5 10353.4 10462.4 10569.3 10662.3 1822.5 1891.0 1912.1 1943.2 1945.5 83616.2 88172.0 91531.0 94185.5 94935.5 11024.6 11122.3 11230.3 11352.7 11452.8 12487.6 13375.3 15868.5 15902.0 15904.0 6987.1 7228.7 7268.0 7281.6 7593.1 7202.6 7237.8 7287.6 7290.6 7325.9 4119.8 4135.5 4160.8 4293.8 4313.7 1874.6 1969.4 2026.1 2040.3 2058.3 975.4 989.3 997.0 1011.6 1016.3 18122.5 19303.5 19465.5 19477.4 19825.7 904.1 905.2 947.7 950.7 974.8 10462.5 10855.0 10917.7 10940.9 10966.1 456006.0 462138.0 463415.0 464941.0 473253.0 87029.6 94397.0 96990.5 98040.5 98412.0 477.8 487.6 489.8 491.7 492.3 10314.3 10753.3 10829.8 10971.8 11081.2 30130.2 31630.5 42544.8 42616.8 44182.6 57529.0 58801.7 58832.0 58914.7 58930.1 8500.5 8506.8 8826.4 11893.9 12561.9 13830.3 14015.2 14107.8 14284.0 14762.8 12284.2 12313.8 12463.6 12558.7 12745.9 12448.5 12727.7 12768.7 12895.4 13133.6 12206.9 12437.7 12734.4 12843.7 12986.9 12864.8 12892.9 12961.2 12981.0 13409.5 12402.3 12445.6 12470.5 12772.4 13008.7 14:30:16 INFO - PROCESS | 24022 | 14:30:16 INFO - PROCESS | 24022 | [#3] mootools.html Cycles:180 Average:5656.66 Median:5043.27 stddev:3186.44 (63.2%) stddev-sans-first:3179.85 14:30:16 INFO - PROCESS | 24022 | Values: 1469.9 1486.6 1628.5 1707.0 1781.3 7285.0 7830.7 8162.1 8536.7 8572.0 8134.9 8522.2 8538.5 8546.9 8549.9 2323.2 2357.0 2381.4 2382.0 2386.6 2265.9 2269.4 2333.3 2347.8 2354.7 2356.8 2364.9 2365.7 2375.8 2389.2 2298.4 2300.1 2308.0 2315.2 2339.5 2253.9 2271.8 2274.9 2286.8 2290.4 8347.9 8379.2 8417.6 8443.8 8448.8 5036.9 5049.6 5135.3 5140.4 5168.6 3197.7 3265.9 3335.4 3341.1 3377.0 1162.5 1170.0 1173.9 1180.3 1208.6 11756.3 11852.0 11920.6 11924.9 11969.7 4257.6 4520.2 4568.9 4721.9 4727.3 10025.8 10047.5 10051.7 10054.7 10065.6 5063.9 5070.0 5083.0 5099.2 5110.6 4070.5 4634.6 4679.0 4687.9 4700.2 3698.7 3867.6 3900.4 3901.8 4029.9 1162.2 1189.4 1191.9 1193.9 1204.4 911.8 970.6 979.0 981.6 984.9 5763.7 5865.4 5869.7 5920.2 5991.9 445.7 447.3 453.3 454.3 457.8 4026.1 4126.1 4136.7 4141.4 4151.1 10265.3 10544.4 10605.0 10657.9 10662.5 10552.1 10603.7 10613.7 10625.3 10664.3 7518.0 8041.6 8088.6 8096.2 8122.1 5928.3 6027.0 6076.6 6112.2 6200.7 9651.4 9696.9 9735.9 9765.0 9777.4 9805.5 9838.2 9913.9 9985.1 9985.3 7657.3 7677.3 7755.4 7755.5 7779.0 8204.4 8239.8 8269.8 8274.5 8328.9 7452.2 7478.9 7618.5 7639.0 7682.8 7177.7 7451.3 7555.2 7562.4 7717.4 6744.5 6859.7 6870.4 6910.5 6957.8 5146.5 5152.4 5153.3 5182.9 5364.9 5218.6 5225.5 5303.4 5330.4 5332.3 14:30:16 INFO - PROCESS | 24022 | 14:30:16 INFO - PROCESS | 24022 | [#4] prototype.html Cycles:180 Average:4829.83 Median:5525.68 stddev:1435.05 (26.0%) stddev-sans-first:1398.42 14:30:16 INFO - PROCESS | 24022 | Values: 311.2 321.6 322.7 326.8 329.2 5481.5 5520.7 5562.4 5577.2 5591.9 5359.7 5424.0 5442.9 5467.3 5475.0 4043.8 4191.4 4288.2 4313.4 4324.2 4276.8 4288.9 4297.5 4300.3 4324.9 4243.3 4272.3 4275.3 4284.6 4287.2 4015.3 4202.7 4217.2 4249.4 4288.8 3705.5 3712.9 3715.9 3723.7 3723.8 5282.3 5309.4 5313.5 5323.7 5339.4 4585.4 4777.6 4847.2 4851.4 4864.8 5665.4 5709.4 5722.3 5734.1 5736.6 4066.6 4076.4 4086.4 4091.1 4093.3 5748.9 5871.3 5914.6 5942.7 5943.6 4163.8 4164.0 4168.0 4170.0 4170.7 4194.5 4222.5 4225.3 4241.0 4241.4 4682.3 4823.2 4826.5 4853.8 4853.9 5690.3 5736.4 5748.5 5751.3 5757.7 1431.1 1449.8 1450.9 1459.6 1461.1 891.0 916.1 938.4 939.1 976.1 5448.7 5514.3 5516.6 5518.6 5530.7 5802.4 5811.0 5813.6 5827.3 5835.3 5334.9 5471.6 5477.5 5483.8 5534.8 3061.7 3064.7 3081.8 3091.5 3113.8 5881.6 6018.6 6080.0 6081.9 6091.2 6077.2 6094.4 6110.5 6116.2 6149.2 6103.9 6122.0 6162.5 6170.8 6217.9 5619.5 5855.7 5887.0 5905.7 5918.7 5856.6 5900.6 5903.2 5911.2 5914.5 5945.8 6131.0 6215.4 6220.4 6220.7 4250.7 4299.5 4304.2 4321.6 4330.1 5849.6 5897.4 5915.4 5918.3 5960.6 5581.7 5736.2 5751.0 5759.5 5786.2 5725.3 5727.5 5738.2 5755.0 5756.2 5158.6 5666.7 5678.3 5685.3 5688.9 5711.1 5773.7 5775.8 5798.9 5808.7 5648.8 5666.4 5699.2 5716.5 5732.5 14:30:16 INFO - PROCESS | 24022 | 14:30:16 INFO - PROCESS | 24022 | [#5] yui.html Cycles:180 Average:21817.21 Median:3966.79 stddev:32088.76 (808.9%) stddev-sans-first:32139.77 14:30:16 INFO - PROCESS | 24022 | Values: 746.3 751.9 792.1 799.1 861.4 14521.6 15260.8 15273.8 15295.4 15298.5 14682.6 14784.0 14897.8 14898.1 14914.9 648.4 780.5 785.2 799.7 803.2 582.5 583.9 585.9 586.1 586.4 848.2 849.5 849.8 850.9 852.1 836.2 841.0 846.4 847.2 848.0 621.7 622.0 623.3 623.6 623.9 15030.7 15095.1 15151.5 15212.0 15212.6 15645.9 16024.7 16074.4 16150.2 16207.1 12376.8 12704.4 12772.8 12825.9 12868.9 3893.7 3920.2 3929.1 3937.4 3996.2 82372.6 83395.6 84038.6 84836.2 85621.6 12063.9 12197.3 12284.5 12295.6 12398.1 23601.9 23624.9 23644.5 23676.8 23754.6 8650.0 8657.3 8686.8 8895.6 8898.5 4724.9 4732.2 4751.4 4819.7 4844.0 3492.8 3558.1 3602.0 3621.0 3627.9 601.5 610.4 620.2 633.7 658.7 652.4 716.9 759.6 764.8 784.5 9935.1 10089.6 10274.6 10291.4 10337.0 716.5 753.4 760.7 772.9 775.5 4564.5 4927.4 4962.1 4962.9 4977.3 74888.0 96633.5 108439.5 117832.0 135010.3 115521.4 117475.8 117492.4 117500.0 117967.4 58001.4 88627.0 95168.5 95296.5 99066.5 9096.6 9171.0 9225.3 9306.9 9521.9 57751.0 58196.4 58898.0 59214.7 59933.0 76570.0 83603.0 84192.2 84661.2 86031.1 12018.0 12018.0 12426.0 12785.4 12879.4 13324.6 13573.9 13636.4 13674.5 13709.7 13031.8 13187.6 13603.9 13725.8 13757.1 12975.2 13285.4 13303.3 13336.7 13341.5 12320.9 12445.6 12516.7 12690.4 13110.0 10873.8 10956.7 11043.5 11093.4 11241.6 10068.9 10092.3 10245.5 11049.7 11056.5 14:30:16 INFO - PROCESS | 24022 | -------- Summary: end -------- 14:30:16 INFO - PROCESS | 24022 | 14:30:16 INFO - TEST-INFO | 24022: exit 0 14:30:17 INFO - TEST-OK | dromaeo_css | took 1113416ms 14:30:17 INFO - TEST-START | kraken 14:30:17 INFO - operating with platform_type : linux_ 14:30:17 INFO - Initialising browser for kraken test... 14:30:17 INFO - TEST-INFO | started process 24268 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnoFZAZ/profile http://localhost:59214/getInfo.html) 14:30:21 INFO - PROCESS | 24268 | __metrics Screen width/height:1600/1200 14:30:21 INFO - PROCESS | 24268 | colorDepth:24 14:30:21 INFO - PROCESS | 24268 | Browser inner width/height: 1024/697 14:30:21 INFO - PROCESS | 24268 | __metrics 14:30:22 ERROR - PROCESS | 24268 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 14:30:22 INFO - TEST-INFO | 24268: exit 0 14:30:22 INFO - Browser initialized. 14:30:22 INFO - Running cycle 1/1 for kraken test... 14:30:22 INFO - TEST-INFO | started process 24389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnoFZAZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:30:34 INFO - PROCESS | 24389 | RSS: Main: 163389440 14:30:34 INFO - PROCESS | 24389 | 14:30:37 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59214/tests/kraken/driver.html?testName=audio-beat-detection) 14:30:38 INFO - PROCESS | 24389 | RSS: Main: 168083456 14:30:38 INFO - PROCESS | 24389 | 14:30:40 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59214/tests/kraken/driver.html?testName=audio-dft) 14:30:41 INFO - PROCESS | 24389 | RSS: Main: 167624704 14:30:41 INFO - PROCESS | 24389 | 14:30:44 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59214/tests/kraken/driver.html?testName=audio-fft) 14:30:44 INFO - PROCESS | 24389 | RSS: Main: 163287040 14:30:44 INFO - PROCESS | 24389 | 14:30:46 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59214/tests/kraken/driver.html?testName=audio-oscillator) 14:30:47 INFO - PROCESS | 24389 | RSS: Main: 164343808 14:30:47 INFO - PROCESS | 24389 | 14:30:49 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59214/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:30:50 INFO - PROCESS | 24389 | RSS: Main: 164548608 14:30:50 INFO - PROCESS | 24389 | 14:30:53 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59214/tests/kraken/driver.html?testName=imaging-darkroom) 14:30:54 INFO - PROCESS | 24389 | RSS: Main: 164671488 14:30:54 INFO - PROCESS | 24389 | 14:30:57 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59214/tests/kraken/driver.html?testName=imaging-desaturate) 14:30:58 INFO - PROCESS | 24389 | RSS: Main: 162582528 14:30:58 INFO - PROCESS | 24389 | 14:31:01 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59214/tests/kraken/driver.html?testName=json-parse-financial) 14:31:01 INFO - PROCESS | 24389 | RSS: Main: 164126720 14:31:01 INFO - PROCESS | 24389 | 14:31:03 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59214/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:31:03 INFO - PROCESS | 24389 | RSS: Main: 164151296 14:31:03 INFO - PROCESS | 24389 | 14:31:05 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59214/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:31:06 INFO - PROCESS | 24389 | RSS: Main: 164323328 14:31:06 INFO - PROCESS | 24389 | 14:31:08 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59214/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:31:09 INFO - PROCESS | 24389 | RSS: Main: 164757504 14:31:09 INFO - PROCESS | 24389 | 14:31:11 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59214/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:12 INFO - PROCESS | 24389 | RSS: Main: 165199872 14:31:12 INFO - PROCESS | 24389 | 14:31:15 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59214/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:31:15 INFO - PROCESS | 24389 | RSS: Main: 164798464 14:31:15 INFO - PROCESS | 24389 | 14:31:17 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59214/tests/kraken/driver.html?testName=ai-astar) 14:31:17 INFO - PROCESS | 24389 | RSS: Main: 165691392 14:31:17 INFO - PROCESS | 24389 | 14:31:17 INFO - PROCESS | 24389 | __start_tp_report 14:31:17 INFO - PROCESS | 24389 | _x_x_mozilla_page_load 14:31:17 INFO - PROCESS | 24389 | _x_x_mozilla_page_load_details 14:31:17 INFO - PROCESS | 24389 | |i|pagename|runs| 14:31:17 INFO - PROCESS | 24389 | |0;ai-astar;103;113;107;111;112;112;114;111;112;111 14:31:17 INFO - PROCESS | 24389 | |1;audio-beat-detection;150;120;145;182;119;142;159;119;185;119 14:31:17 INFO - PROCESS | 24389 | |2;audio-dft;164;163;166;166;162;167;171;163;165;163 14:31:17 INFO - PROCESS | 24389 | |3;audio-fft;74;76;75;189;78;77;76;76;172;76 14:31:17 INFO - PROCESS | 24389 | |4;audio-oscillator;87;84;158;84;84;85;132;84;84;138 14:31:17 INFO - PROCESS | 24389 | |5;imaging-gaussian-blur;117;118;118;117;119;119;118;118;117;117 14:31:17 INFO - PROCESS | 24389 | |6;imaging-darkroom;147;148;149;151;147;147;147;147;147;148 14:31:17 INFO - PROCESS | 24389 | |7;imaging-desaturate;95;95;96;97;95;95;98;96;96;95 14:31:17 INFO - PROCESS | 24389 | |8;json-parse-financial;53;52;53;51;51;52;54;51;51;54 14:31:17 INFO - PROCESS | 24389 | |9;json-stringify-tinderbox;60;60;61;60;62;60;60;61;61;62 14:31:17 INFO - PROCESS | 24389 | |10;stanford-crypto-aes;76;75;77;77;77;78;76;81;81;77 14:31:17 INFO - PROCESS | 24389 | |11;stanford-crypto-ccm;127;133;133;124;125;128;130;125;137;128 14:31:17 INFO - PROCESS | 24389 | |12;stanford-crypto-pbkdf2;157;160;158;159;160;158;159;156;156;159 14:31:17 INFO - PROCESS | 24389 | |13;stanford-crypto-sha256-iterative;67;64;63;63;68;64;62;66;62;63 14:31:17 INFO - PROCESS | 24389 | __end_tp_report 14:31:17 INFO - PROCESS | 24389 | __start_cc_report 14:31:17 INFO - PROCESS | 24389 | _x_x_mozilla_cycle_collect,831 14:31:17 INFO - PROCESS | 24389 | __end_cc_report 14:31:17 INFO - PROCESS | 24389 | __startTimestamp1471037477574__endTimestamp 14:31:17 INFO - PROCESS | 24389 | 14:31:17 INFO - PROCESS | 24389 | ------- Summary: start ------- 14:31:17 INFO - PROCESS | 24389 | Number of tests: 14 14:31:17 INFO - PROCESS | 24389 | 14:31:17 INFO - PROCESS | 24389 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.24 (2.9%) stddev-sans-first:1.94 14:31:17 INFO - PROCESS | 24389 | Values: 103.0 113.0 107.0 111.0 112.0 112.0 114.0 111.0 112.0 111.0 14:31:17 INFO - PROCESS | 24389 | 14:31:17 INFO - PROCESS | 24389 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:147.50 stddev:25.48 (17.3%) stddev-sans-first:26.93 14:31:17 INFO - PROCESS | 24389 | Values: 150.0 120.0 145.0 182.0 119.0 142.0 159.0 119.0 185.0 119.0 14:31:17 INFO - PROCESS | 24389 | 14:31:17 INFO - PROCESS | 24389 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.50 stddev:2.67 (1.6%) stddev-sans-first:2.80 14:31:17 INFO - PROCESS | 24389 | Values: 164.0 163.0 166.0 166.0 162.0 167.0 171.0 163.0 165.0 163.0 14:31:17 INFO - PROCESS | 24389 | 14:31:17 INFO - PROCESS | 24389 | [#3] audio-fft Cycles:10 Average:96.90 Median:76.00 stddev:44.26 (58.2%) stddev-sans-first:46.16 14:31:17 INFO - PROCESS | 24389 | Values: 74.0 76.0 75.0 189.0 78.0 77.0 76.0 76.0 172.0 76.0 14:31:17 INFO - PROCESS | 24389 | 14:31:17 INFO - PROCESS | 24389 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:84.00 stddev:28.80 (34.3%) stddev-sans-first:30.03 14:31:17 INFO - PROCESS | 24389 | Values: 87.0 84.0 158.0 84.0 84.0 85.0 132.0 84.0 84.0 138.0 14:31:17 INFO - PROCESS | 24389 | 14:31:17 INFO - PROCESS | 24389 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 14:31:17 INFO - PROCESS | 24389 | Values: 117.0 118.0 118.0 117.0 119.0 119.0 118.0 118.0 117.0 117.0 14:31:17 INFO - PROCESS | 24389 | 14:31:17 INFO - PROCESS | 24389 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.50 stddev:1.32 (0.9%) stddev-sans-first:1.36 14:31:17 INFO - PROCESS | 24389 | Values: 147.0 148.0 149.0 151.0 147.0 147.0 147.0 147.0 147.0 148.0 14:31:17 INFO - PROCESS | 24389 | 14:31:17 INFO - PROCESS | 24389 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.03 (1.1%) stddev-sans-first:1.05 14:31:17 INFO - PROCESS | 24389 | Values: 95.0 95.0 96.0 97.0 95.0 95.0 98.0 96.0 96.0 95.0 14:31:17 INFO - PROCESS | 24389 | 14:31:17 INFO - PROCESS | 24389 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.50 stddev:1.23 (2.3%) stddev-sans-first:1.27 14:31:17 INFO - PROCESS | 24389 | Values: 53.0 52.0 53.0 51.0 51.0 52.0 54.0 51.0 51.0 54.0 14:31:17 INFO - PROCESS | 24389 | 14:31:17 INFO - PROCESS | 24389 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 14:31:17 INFO - PROCESS | 24389 | Values: 60.0 60.0 61.0 60.0 62.0 60.0 60.0 61.0 61.0 62.0 14:31:17 INFO - PROCESS | 24389 | 14:31:17 INFO - PROCESS | 24389 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.00 stddev:2.01 (2.6%) stddev-sans-first:2.06 14:31:17 INFO - PROCESS | 24389 | Values: 76.0 75.0 77.0 77.0 77.0 78.0 76.0 81.0 81.0 77.0 14:31:17 INFO - PROCESS | 24389 | 14:31:17 INFO - PROCESS | 24389 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:129.00 stddev:4.22 (3.3%) stddev-sans-first:4.41 14:31:17 INFO - PROCESS | 24389 | Values: 127.0 133.0 133.0 124.0 125.0 128.0 130.0 125.0 137.0 128.0 14:31:17 INFO - PROCESS | 24389 | 14:31:17 INFO - PROCESS | 24389 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:159.00 stddev:1.48 (0.9%) stddev-sans-first:1.50 14:31:17 INFO - PROCESS | 24389 | Values: 157.0 160.0 158.0 159.0 160.0 158.0 159.0 156.0 156.0 159.0 14:31:17 INFO - PROCESS | 24389 | 14:31:17 INFO - PROCESS | 24389 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:2.10 (3.3%) stddev-sans-first:1.96 14:31:17 INFO - PROCESS | 24389 | Values: 67.0 64.0 63.0 63.0 68.0 64.0 62.0 66.0 62.0 63.0 14:31:17 INFO - PROCESS | 24389 | -------- Summary: end -------- 14:31:17 INFO - PROCESS | 24389 | 14:31:18 INFO - TEST-INFO | 24389: exit 0 14:31:18 INFO - TEST-OK | kraken | took 61519ms 14:31:18 INFO - SUITE-END | took 1174s 14:31:18 INFO - Completed test suite (00:19:35) 14:31:18 INFO - javascript benchmark 14:31:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7266.480304880959, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3084.8611812468434, 3086.6913308669123, 3122.594062771839, 3124.156477751007, 3127.405792899349, 5345.518903298703, 5399.5680345572355, 5460.78156873725, 5495.560355171587, 5498.120300751875, 5362.624616276862, 5465.836024919249, 5490.80782172624, 5500.339959204891, 5524.640898341605, 4956.40523137224, 5040.6471546991725, 5075.0, 5114.590832733373, 5182.896342073156, 5114.974425127869, 5158.845234642948, 5161.122609156452, 5203.193505006711, 5232.581393488531, 4830.178869592178, 4950.554450099508, 4981.103401387731, 5012.972340670154, 5055.064813009605, 4999.725015124167, 5050.217216331474, 5060.367454068241, 5097.082525145473, 5104.489551044903, 5002.774875130592, 5010.148274793294, 5019.949800501985, 5022.824201152978, 5037.823676171353, 5196.272521846944, 5346.91979620306, 5490.780368785244, 5491.093969495028, 5530.446955304477, 5745.54035677149, 5784.103463963051, 5788.6816225107605, 5790.7683692652245, 5845.678487683176, 5861.85345366365, 5890.528757699417, 5891.410858914117, 5895.410458954113, 5911.29064512257, 5343.145096784496, 5483.369412517612, 5490.231367608498, 5502.697351645658, 5528.253685752412, 6014.188084608521, 6089.025478338473, 6094.487876503085, 6095.438338978099, 6133.172021777003, 5807.651540907559, 5851.32709738377, 5853.180554722342, 5868.941310586925, 5881.059030555176, 5603.187537806995, 5795.681237531892, 5936.347001829795, 5946.910796338058, 5947.226860508106, 5801.564882633819, 5878.088896221093, 5918.348981612019, 5923.259592550931, 5941.70291485424, 5878.617889837147, 5900.085486749561, 5905.232319798399, 5906.232189815297, 5909.674967876722, 4372.278574035312, 4423.0048239145935, 4494.348319493721, 4517.322401639714, 4543.54564543543, 3957.4261732049267, 4001.8999525011527, 4022.054817117975, 4050.837966481308, 4079.224947260011, 5605.215269862222, 5627.746751396197, 5643.0, 5653.23681303027, 5658.292713410824, 5658.207850900877, 5832.679202643895, 5867.735951882176, 5909.881802363929, 5918.970405148033, 5603.0, 5687.544996400278, 5696.544276457874, 5710.5717071219, 5714.571407144397, 5076.111680455905, 5076.593872490192, 5079.263506791494, 5098.847034588968, 5127.07712611726, 5937.376575459514, 6000.639961602318, 6154.046122850965, 6206.875862482725, 6217.0, 5750.5112065474905, 5806.187133801355, 5811.651300921958, 5820.359760426434, 5843.415658434293, 6076.8784624308155, 6094.329623741296, 6110.297315808739, 6120.510359171345, 6135.938640613536, 5630.324361076697, 5690.061139911868, 5759.481646651821, 5765.106408506688, 5784.987627165145, 5821.970890145522, 5876.647401155944, 5881.235439392852, 5881.705914704333, 5947.464728174485, 5755.942440575708, 5762.193292939076, 5764.769409223584, 5768.1636162757, 5777.942220577908, 5493.423190564933, 5697.54419646419, 5718.51392631631, 5734.483896449339, 5743.856403589776, 5723.399043100581, 5728.341240757366, 5738.942610573841, 5762.94237057624, 5786.392428795084, 5790.189373487631, 5794.797182098607, 5803.767849285981, 5856.882862342644, 5858.179854820243, 5475.972620136874, 5584.301962254718, 5626.212330273683, 5706.029974904359, 5715.457031581993], "value": 5425.148139560432, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.7326956330525, 592.6473748119868, 593.2762030323005, 599.6971529377666, 605.4278706622243, 38424.231515369676, 42765.78617106918, 42789.14421711564, 42856.14287714244, 42921.0, 42759.57240427595, 43410.34884476735, 43507.34738978918, 43654.78172609132, 43699.781501092526, 8816.250618697419, 9010.639574417048, 9014.233790127848, 9020.548972551345, 9028.32287578431, 9000.549972501381, 9018.954905225464, 9064.592093355783, 9067.954660226722, 9080.40977336471, 9113.134252246025, 9133.588988495501, 9134.634614615408, 9163.770905727344, 9166.633334666605, 9075.95462022689, 9103.0, 9104.453732776055, 9120.908790912072, 9127.543622818866, 8842.5136617486, 8843.0, 8881.600327985256, 8888.155625215593, 8943.955280223558, 40954.795226023976, 41231.58768412308, 41250.58749412528, 41425.585744142474, 41488.0, 2759.65504311961, 3403.3193361327585, 3548.609652938175, 3657.7073834093208, 3704.85180592776, 30881.845590772125, 33013.83493082519, 33827.4925876112, 34548.65451345479, 34605.82697086524, 4090.877273681794, 4127.071408932996, 4136.420901073852, 4280.657547396201, 4292.892677683051, 344735.0, 348021.0, 348441.0, 350237.24881375686, 350491.0, 60513.69743151344, 60641.393586064456, 60835.69582152061, 60919.69540152271, 61263.69368153131, 36760.81619591938, 37485.812570937516, 64749.67625161844, 65311.346886530526, 65388.0, 16041.518754437386, 16428.67142657164, 16440.424585139463, 16452.177391130634, 16454.588635284214, 12597.244165350108, 12689.746205076031, 12761.553345632858, 12791.616251512469, 12791.889338259269, 19303.51741206481, 19310.32413865536, 19321.834128175135, 19470.8052919469, 19572.217111315673, 7179.820504487325, 7209.567425954355, 7281.817954551073, 7419.6661150248365, 7466.887996680054, 845.8477474054729, 901.1571336616635, 907.8456662367413, 997.7904640025531, 1015.9288849780593, 29080.0, 29671.258218544277, 29742.25644358908, 29866.40267194644, 29917.850410747807, 992.7915137821138, 993.5926270229171, 1042.196999191388, 1056.9694547815818, 1127.0363838917772, 16309.184540772914, 16483.175841207893, 16575.171241437878, 17175.196604356614, 17382.21780019902, 559081.0, 559720.0, 563134.0, 563746.0, 567793.0, 58365.41634583685, 58760.41239587549, 58940.41059589435, 58967.0, 59067.0, 1296.2546535741985, 1351.1015174908773, 1351.4526616720048, 1368.2679766324968, 1375.3535838156051, 28749.28126796847, 29703.25741856471, 30026.549601755552, 30205.244868878453, 30310.0, 50840.745796270785, 51525.227121593955, 51577.0, 51933.740331298104, 52035.73982130065, 494324.0, 498178.0, 500455.0, 500860.0, 502141.0, 28671.569926450702, 28791.712082878905, 28799.5680064795, 28878.566821497276, 28945.0, 47091.76454117707, 47714.76142619265, 48804.51195488142, 49218.507814921395, 49852.50147498624, 39997.80001099976, 41304.79347603363, 44664.0, 46169.76915115403, 46195.0, 42291.57708422876, 42405.787971059945, 42555.148897022504, 42754.358684620376, 43229.56770432381, 38415.807920960215, 39031.2193756129, 39097.21805563816, 39351.80324098361, 41448.792756036026, 32364.35271294514, 37323.81338093292, 38375.18921322229, 38487.0, 38754.6124538751, 24889.751102488743, 25162.0, 25589.104381347308, 25840.8707956459, 25881.352966175997], "value": 20007.04596057887, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.26990543204323, 387.87950934730094, 396.6152831753199, 399.2195258270081, 399.86004898285603, 14254.928725356358, 18521.259149634014, 19282.807171928278, 19932.60134797305, 19979.60040799185, 17725.37961171356, 17774.200160992754, 17809.554761130978, 18417.723734143998, 19279.518012049706, 5916.171735956958, 6036.15493830864, 6061.545384096188, 6095.055266433687, 6096.634201947897, 5905.527557795387, 5967.8209653710455, 5986.221791167142, 5993.430624090704, 6023.518118550505, 5941.138534912435, 5979.1031345298115, 5989.431004054608, 5991.610545314563, 6006.759729610811, 5815.21494598228, 5824.737886795105, 5874.1776151338845, 5992.910106348409, 6011.939880601203, 5289.100852855024, 5299.920501192485, 5336.893262134736, 5362.168863826113, 5364.597655175839, 23772.40568985772, 24034.399140021465, 24162.51674966491, 24339.756602433925, 24378.878105609358, 2083.9687404688943, 2416.867072311022, 2449.9265022049367, 2530.177692250026, 2559.41133539287, 10213.489325533694, 10353.378797272113, 10462.424566648831, 10569.260151789378, 10662.306950048222, 1822.4623735997911, 1890.971635425456, 1912.1204246046834, 1943.183123779271, 1945.472803848986, 83616.16383836145, 88172.0, 91531.0, 94185.5290723542, 94935.52532237295, 11024.559017639205, 11122.332660040423, 11230.270032447865, 11352.716182095513, 11452.828207576893, 12487.562935297221, 13375.264360460074, 15868.52394428169, 15902.045877247403, 15904.045757254602, 6987.091678081817, 7228.746993855189, 7267.963660181771, 7281.635918204069, 7593.088829340514, 7202.567845929261, 7237.782866514013, 7287.562746235137, 7290.5625662460425, 7325.850772944246, 4119.773412462343, 4135.545090040093, 4160.8335666573, 4293.785310734451, 4313.698041137153, 1874.5594785225462, 1969.4091772468203, 2026.0983862181188, 2040.3266921915733, 2058.341330774168, 975.3952549419405, 989.3272574649163, 996.9800603987879, 1011.5903059261011, 1016.3038318751679, 18122.546936326435, 19303.51741206481, 19465.513362165777, 19477.415677529698, 19825.702614460795, 904.0778406025817, 905.2395987370641, 947.7346343023964, 950.6500768908166, 974.7855471796336, 10462.529186186639, 10855.0, 10917.727056823484, 10940.890591094147, 10966.122710183166, 456006.0, 462138.0, 463415.0, 464941.0, 473253.0, 87029.56485217533, 94397.0, 96990.51504742431, 98040.50979745056, 98412.0, 477.7635070640055, 487.59285996193574, 489.7502273840296, 491.7148054128597, 492.29110081483265, 10314.329568578018, 10753.301035432673, 10829.783404331713, 10971.780564388508, 11081.168912331446, 30130.246743830703, 31630.525542117346, 42544.78727606342, 42616.78691606522, 44182.55817441784, 57529.0, 58801.70599146977, 58832.0, 58914.705426472596, 58930.11604825845, 8500.532470713923, 8506.829863402822, 8826.382153249211, 11893.881061189277, 12561.87438125607, 13830.31092591562, 14015.159090454605, 14107.788383174055, 14284.0, 14762.778558321848, 12284.201526900722, 12313.753724925273, 12463.563775268185, 12558.686032848886, 12745.872541274468, 12448.502059917502, 12727.745445091232, 12768.6807829805, 12895.355232238164, 13133.60599182026, 12206.87793122093, 12437.689057773629, 12734.426950787421, 12843.743125137631, 12986.935065324991, 12864.807027894776, 12892.871071289543, 12961.22232666043, 12981.0, 13409.530666426628, 12402.317872516738, 12445.62663120108, 12470.5011799527, 12772.425240863997, 13008.739825203633], "value": 9095.85254421668, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.9118052916826, 1486.5911874234585, 1628.527726959181, 1706.9743953840687, 1781.340903865569, 7285.0, 7830.6867725290995, 8162.142974987615, 8536.658533658654, 8572.0, 8134.91865081349, 8522.190391912774, 8538.530380829052, 8546.871796923035, 8549.871751923725, 2323.1520495019367, 2356.9882150589224, 2381.404648837791, 2381.95236095278, 2386.6300723387817, 2265.909363625453, 2269.4326418395403, 2333.276684227886, 2347.8239132065078, 2354.6703461515403, 2356.7643235676464, 2364.893579788905, 2365.7161140663143, 2375.798057165143, 2389.2115601851347, 2298.4483723906224, 2300.114455934477, 2308.0, 2315.189683610731, 2339.4502291961376, 2253.9098436062536, 2271.7728227177317, 2274.9090036398525, 2286.8284878634167, 2290.393045842853, 8347.874781878276, 8379.162083791633, 8417.621207045697, 8443.788905277355, 8448.83102337956, 5036.924446133311, 5049.621278404097, 5135.281060651511, 5140.383154021504, 5168.5606723428555, 3197.6642452542383, 3265.853036613358, 3335.399628066947, 3341.1480072581335, 3377.037544299863, 1162.5354248992192, 1170.0405667352775, 1173.8826117388278, 1180.262336039975, 1208.6011616166643, 11756.294622322688, 11851.999999999915, 11920.642380728592, 11924.940375298154, 11969.700757481045, 4257.574242575718, 4520.208963431386, 4568.908621827612, 4721.9055618888115, 4727.345429099788, 10025.849612255823, 10047.497625118714, 10051.69844904654, 10054.74863128413, 10065.64770233053, 5063.924041139386, 5069.9746501267255, 5082.974585127125, 5099.184130539096, 5110.642255042186, 4070.4504891839815, 4634.629229661619, 4679.040796636681, 4687.906241875144, 4700.2009658358165, 3698.7041036716996, 3867.5939026402384, 3900.356441187229, 3901.7954855506546, 4029.858954936622, 1162.2213117211488, 1189.3696340939316, 1191.9106067045007, 1193.8686744458103, 1204.4098391787961, 911.8221946720325, 970.5680971967548, 978.9657361992296, 981.6417007792247, 984.9015098490237, 5763.711814409263, 5865.35481097079, 5869.706514674249, 5920.200772895604, 5991.880162396727, 445.67911104005066, 447.31784029354844, 453.32001997004494, 454.2799662534853, 457.7848411246709, 4026.1142548639255, 4126.071633882352, 4136.710430269913, 4141.399497072907, 4151.14901445203, 10265.281430299807, 10544.367337959748, 10605.0, 10657.893421065844, 10662.466876656292, 10552.103071238877, 10603.681889543326, 10613.734656633645, 10625.309354892062, 10664.253502254767, 7517.962410188024, 8041.597920103972, 8088.636011379502, 8096.230858068474, 8122.106568277485, 5928.34788173292, 6027.0, 6076.605020673642, 6112.235970503687, 6200.689965501617, 9651.372660777028, 9696.903030969883, 9735.853962190715, 9765.0, 9777.364471309342, 9805.509724513888, 9838.212942964688, 9913.900860991298, 9985.101340879355, 9985.251106167212, 7657.272559106876, 7677.347425468898, 7755.379569634529, 7755.534667919943, 7779.0, 8204.425690201628, 8239.835203295781, 8269.793255168668, 8274.503529788231, 8328.875066874123, 7452.180260171268, 7478.850422991619, 7618.542887426772, 7639.0, 7682.769516914502, 7177.677004534913, 7451.254874512505, 7555.244475552401, 7562.395008399425, 7717.382609391123, 6744.494162937701, 6859.725610975505, 6870.381665650116, 6910.481713871379, 6957.756478523227, 5146.536811686966, 5152.381714194321, 5153.304303918923, 5182.896342073062, 5364.946350536601, 5218.556422704112, 5225.477452254896, 5303.390110137384, 5330.360356757214, 5332.253484512094], "value": 4478.918352971221, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.2483352703222, 321.64458273607676, 322.7111734997179, 326.7990186035588, 329.16720696637503, 5481.534069604083, 5520.696361700105, 5562.415946325638, 5577.191307260455, 5591.888162236753, 5359.678419294845, 5423.972880135604, 5442.911417716463, 5467.289252397183, 5475.014497390468, 4043.7978101094973, 4191.350340697181, 4288.249556327646, 4313.352997050436, 4324.156789426063, 4276.786160691953, 4288.863451185438, 4297.462817147856, 4300.268954277764, 4324.9351259730975, 4243.299855523835, 4272.295071313245, 4275.25183092959, 4284.6289187460025, 4287.228298906196, 4015.337469317559, 4202.747835129902, 4217.177650358181, 4249.3625956106835, 4288.76411797351, 3705.5177928828416, 3712.851485940559, 3715.9442608360896, 3723.72072094594, 3723.832427540767, 5282.26048353227, 5309.442508536626, 5313.468653134656, 5323.680579165262, 5339.41266460689, 4585.403897493305, 4777.641676874248, 4847.224444088929, 4851.393575803025, 4864.829730959399, 5665.405132461074, 5709.400512946122, 5722.341930677942, 5734.139879018139, 5736.598438109334, 4066.552679205285, 4076.4496792932873, 4086.427900093989, 4091.0590564170407, 4093.3246014407587, 5748.913766293509, 5871.266091738533, 5914.556408269354, 5942.732577034, 5943.613665111754, 4163.770992595436, 4163.959659766692, 4168.0, 4169.979150104291, 4170.72890262132, 4194.5386007539755, 4222.514410842731, 4225.260579398593, 4241.0, 4241.409471448207, 4682.274247491644, 4823.155947709207, 4826.493218212037, 4853.757312134379, 4853.854384368475, 5690.3456102548735, 5736.422483816984, 5748.482636562646, 5751.252337196138, 5757.65454072757, 1431.0912570517796, 1449.7680371140566, 1450.9335638305836, 1459.569427019032, 1461.13062727679, 891.0465801592234, 916.1388295002677, 938.3525367496542, 939.0843927170954, 976.1166144639113, 5448.673079615236, 5514.338279406497, 5516.613837031369, 5518.613697041249, 5530.668159910419, 5802.361740208574, 5810.970945145332, 5813.563982701315, 5827.3298570664065, 5835.270591176103, 5334.946650533522, 5471.562275017989, 5477.546925212716, 5483.779069476788, 5534.7786088556, 3061.6681743441673, 3064.7088526589937, 3081.768867334959, 3091.4899041658323, 3113.8131712097347, 5881.617694849821, 6018.608790428608, 6079.969600151971, 6081.878362432726, 6091.238595175603, 6077.24034495688, 6094.360092190344, 6110.450059494667, 6116.204893363834, 6149.200603921461, 6103.938960610426, 6121.969390153021, 6162.506999440034, 6170.753169873155, 6217.906731399123, 5619.522340600931, 5855.7364918579615, 5887.0, 5905.675187864708, 5918.674472904032, 5856.590038697421, 5900.580761887605, 5903.203067585821, 5911.172435858897, 5914.497267732291, 5945.821625351074, 6131.0, 6215.378462153749, 6220.377962203744, 6220.720067596879, 4250.723702959298, 4299.516666749966, 4304.246756817607, 4321.611055004939, 4330.098833781311, 5849.590528662953, 5897.3807750187325, 5915.40845915405, 5918.3489816121055, 5960.6125601837475, 5581.748821303132, 5736.225609542658, 5751.0, 5759.539236860957, 5786.189933409242, 5725.2843394575675, 5727.53484142088, 5738.225339579103, 5754.971225144015, 5756.1941328214925, 5158.603483923658, 5666.660000399989, 5678.290213723285, 5685.260916081049, 5688.914666279927, 5711.143328500592, 5773.653580785166, 5775.797847075332, 5798.8692205019615, 5808.651480911159, 5648.830535083954, 5666.405027472056, 5699.23060386859, 5716.5426765859465, 5732.484076433141], "value": 4362.311374827445, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.3133916796546, 751.9248075192478, 792.1326147868084, 799.0850476204746, 861.4185424838232, 14521.564353069412, 15260.771088433668, 15273.847261527382, 15295.388184472622, 15298.464553740621, 14682.559523214293, 14784.0, 14897.77653335201, 14898.10611363319, 14914.850851491481, 648.4455790299297, 780.4926797581561, 785.1598789295442, 799.7081065411112, 803.2289002557523, 582.548524893207, 583.8803045375688, 585.938476459972, 586.1325238646805, 586.419444749699, 848.1899785704668, 849.4818160921833, 849.7705619482736, 850.8766228896807, 852.0669866496177, 836.2473773603745, 840.9747707568782, 846.4328899637196, 847.1570787066846, 848.0163010907348, 621.7481919822479, 621.9844503887439, 623.2832242920678, 623.554158776477, 623.9001759718469, 15030.699386012328, 15095.094294342374, 15151.545453636409, 15212.0, 15212.619684507865, 15645.921770391189, 16024.679506409806, 16074.43739469113, 16150.192490375433, 16207.108609026498, 12376.752464950741, 12704.364781760874, 12772.808407873888, 12825.871741282654, 12868.87131128686, 3893.7274390792654, 3920.196359746245, 3929.135590170158, 3937.3897045957638, 3996.18078293949, 82372.58813705953, 83395.5830220851, 84038.57980710118, 84836.15163848407, 85621.57189214014, 12063.939680301542, 12197.329146897006, 12284.508619655293, 12295.56965506203, 12398.07014473918, 23601.881990589936, 23624.881875590854, 23644.527109457715, 23676.763232367455, 23754.64368034481, 8649.956750216208, 8657.264132548804, 8686.826263474695, 8895.555222238861, 8898.510581917928, 4724.881877953078, 4732.1718699227495, 4751.358566593535, 4819.6867203631655, 4843.951560484421, 3492.7904325740537, 3558.0749005258303, 3601.963980360163, 3621.040424287566, 3627.927441451209, 601.4977493792645, 610.3987572241339, 620.2154274842328, 633.7084940927133, 658.6542065415599, 652.4095693397483, 716.9032180655649, 759.5556599389308, 764.8470305938723, 784.5488843914771, 9935.105840474393, 10089.646862359783, 10274.640387586398, 10291.43397113151, 10337.0, 716.4769718105812, 753.3671715758788, 760.6539024743728, 772.9458937874407, 775.46880386934, 4564.475085365159, 4927.408710954708, 4962.131626965339, 4962.851114466572, 4977.32806071183, 74888.0, 96633.51683241679, 108439.45780271049, 117832.0, 135010.3249483766, 115521.4223928875, 117475.82524174648, 117492.41253793848, 117500.0, 117967.41016294864, 58001.4199857996, 88627.0, 95168.52415737876, 95296.52351738197, 99066.5046674762, 9096.590653420744, 9171.037041110854, 9225.261979041794, 9306.906930930603, 9521.857172142285, 57751.0, 58196.38116284693, 58898.0, 59214.70392648009, 59933.0, 76570.0, 83603.0, 84192.15807841843, 84661.15338846533, 86031.13968860231, 12018.0, 12018.0, 12426.0, 12785.36073196318, 12879.420426081037, 13324.600261992156, 13573.86426135726, 13636.386362613905, 13674.453021879013, 13709.725805483635, 13031.804522931974, 13187.60437186886, 13603.863961360656, 13725.794113088112, 13757.10578812374, 12975.221486710827, 13285.40215690277, 13303.334833258104, 13336.733265334833, 13341.533046343331, 12320.938395307967, 12445.62663120108, 12516.687082823002, 12690.428930697955, 13110.0, 10873.782524349626, 10956.671299861016, 11043.503042362952, 11093.44532773342, 11241.60654377093, 10068.899311006797, 10092.34399764013, 10245.538950747085, 11049.723756906142, 11056.502457389597], "value": 7630.842480101562, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 107.0, 111.0, 112.0, 112.0, 114.0, 111.0, 112.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 120.0, 145.0, 182.0, 119.0, 142.0, 159.0, 119.0, 185.0, 119.0], "value": 144.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 166.0, 166.0, 162.0, 167.0, 171.0, 163.0, 165.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 189.0, 78.0, 77.0, 76.0, 76.0, 172.0, 76.0], "value": 96.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 158.0, 84.0, 84.0, 85.0, 132.0, 84.0, 84.0, 138.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 119.0, 119.0, 118.0, 118.0, 117.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 151.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 97.0, 95.0, 95.0, 98.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 51.0, 51.0, 52.0, 54.0, 51.0, 51.0, 54.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 60.0, 62.0, 60.0, 60.0, 61.0, 61.0, 62.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 77.0, 77.0, 78.0, 76.0, 81.0, 81.0, 77.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 133.0, 133.0, 124.0, 125.0, 128.0, 130.0, 125.0, 137.0, 128.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 158.0, 159.0, 160.0, 158.0, 159.0, 156.0, 156.0, 159.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 63.0, 63.0, 68.0, 64.0, 62.0, 66.0, 62.0, 63.0], "value": 64.2, "unit": "score"}]}]} 14:31:18 INFO - Return code: 0 14:31:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:31:18 ERROR - # TBPL SUCCESS # 14:31:18 INFO - Running post-action listener: _resource_record_post_action 14:31:18 INFO - [mozharness: 2016-08-12 21:31:18.862692Z] Finished run-tests step (success) 14:31:18 INFO - Running post-run listener: _resource_record_post_run 14:31:18 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554168320; Read time: 8; Write time: 594936 14:31:18 INFO - TinderboxPrint: CPU usage
13.3% 14:31:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 14:31:18 INFO - TinderboxPrint: I/O write bytes / time
554,168,320 / 594,936 14:31:18 INFO - TinderboxPrint: CPU idle
8,242.8 (86.6%) 14:31:18 INFO - TinderboxPrint: CPU user
1,210.8 (12.7%) 14:31:18 INFO - TinderboxPrint: Swap in / out
0 / 0 14:31:18 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 260493312; Read time: 0; Write time: 337556 14:31:18 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 293675008; Read time: 0; Write time: 257380 14:31:19 INFO - Running post-run listener: _upload_blobber_files 14:31:19 INFO - Blob upload gear active. 14:31:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:31:19 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 14:31:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:31:19 INFO - (blobuploader) - INFO - Open directory for files ... 14:31:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:31:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:31:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:24 INFO - (blobuploader) - INFO - Done attempting. 14:31:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:31:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:31:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:25 INFO - (blobuploader) - INFO - Done attempting. 14:31:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:31:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:31:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:26 INFO - (blobuploader) - INFO - Done attempting. 14:31:26 INFO - (blobuploader) - INFO - Iteration through files over. 14:31:26 INFO - Return code: 0 14:31:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:31:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:31:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/838b4bca747299cdec8c27846bcd1fcc07908c10bb238d2e34888d071391919e5fbca362c0b9953c08716d92bec65a4118a9e898f904119d724fede9988c70f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4389ea32e14cbef2fb6bb4a3b466ee530134ebfd2a4489a7677b6ae18ba57172f2f7830d1745ca90771239ddfe0ef4ea09f6319df0f9e1cc98f94c9c21156de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d0a67b025f82d8db17218b46112cd2326dfd8b3e42c6b05b4519ab17422bd670d9a335b85e008b46b3735e7b76ca7d9e147704090c4baa8a044726da8772c9a"} 14:31:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:31:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:31:26 INFO - Contents: 14:31:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/838b4bca747299cdec8c27846bcd1fcc07908c10bb238d2e34888d071391919e5fbca362c0b9953c08716d92bec65a4118a9e898f904119d724fede9988c70f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4389ea32e14cbef2fb6bb4a3b466ee530134ebfd2a4489a7677b6ae18ba57172f2f7830d1745ca90771239ddfe0ef4ea09f6319df0f9e1cc98f94c9c21156de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d0a67b025f82d8db17218b46112cd2326dfd8b3e42c6b05b4519ab17422bd670d9a335b85e008b46b3735e7b76ca7d9e147704090c4baa8a044726da8772c9a"} 14:31:26 INFO - Running post-run listener: copy_logs_to_upload_dir 14:31:26 INFO - Copying logs to upload dir... 14:31:26 INFO - mkdir: /builds/slave/test/build/upload/logs 14:31:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.451832 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-12 14:31:25.936805) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 14:31:25.940529) ========= 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=232498196343f89f466a4a9a000001c8-1471034741.257538-185105996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/838b4bca747299cdec8c27846bcd1fcc07908c10bb238d2e34888d071391919e5fbca362c0b9953c08716d92bec65a4118a9e898f904119d724fede9988c70f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4389ea32e14cbef2fb6bb4a3b466ee530134ebfd2a4489a7677b6ae18ba57172f2f7830d1745ca90771239ddfe0ef4ea09f6319df0f9e1cc98f94c9c21156de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d0a67b025f82d8db17218b46112cd2326dfd8b3e42c6b05b4519ab17422bd670d9a335b85e008b46b3735e7b76ca7d9e147704090c4baa8a044726da8772c9a"} build_url:https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011147 build_url: 'https://queue.taskcluster.net/v1/task/IdJLyV9DSJ655FxDSAGHIg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/838b4bca747299cdec8c27846bcd1fcc07908c10bb238d2e34888d071391919e5fbca362c0b9953c08716d92bec65a4118a9e898f904119d724fede9988c70f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4389ea32e14cbef2fb6bb4a3b466ee530134ebfd2a4489a7677b6ae18ba57172f2f7830d1745ca90771239ddfe0ef4ea09f6319df0f9e1cc98f94c9c21156de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d0a67b025f82d8db17218b46112cd2326dfd8b3e42c6b05b4519ab17422bd670d9a335b85e008b46b3735e7b76ca7d9e147704090c4baa8a044726da8772c9a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 14:31:25.965127) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 14:31:25.965442) ========= 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=232498196343f89f466a4a9a000001c8-1471034741.257538-185105996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 14:31:26.051012) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 14:31:26.051329) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 14:31:26.051614) ========= ========= Total master_lag: 0.16 =========