builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1471908750.13 results: success (0) buildid: 20160822145214 builduid: bfa0b3d7dfdb4689b676509060d68745 revision: 3e537d8eb88c440fd0b7aa88deec56aa688715b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 16:32:30.135192) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 16:32:30.135651) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 16:32:30.135923) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 16:32:30.150683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:32:30.151095) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 16:32:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-08-22 16:32:32 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162705 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:32:30.328660) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:32:30.329242) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018178 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:32:30.378777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:32:30.379122) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3e537d8eb88c440fd0b7aa88deec56aa688715b0 --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 3e537d8eb88c440fd0b7aa88deec56aa688715b0 --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=97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 16:32:32,333 truncating revision to first 12 chars 2016-08-22 16:32:32,333 Setting DEBUG logging. 2016-08-22 16:32:32,333 attempt 1/10 2016-08-22 16:32:32,333 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3e537d8eb88c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 16:32:32,631 unpacking tar archive at: fx-team-3e537d8eb88c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622644 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:32:31.017746) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 16:32:31.018274) ========= script_repo_revision: 3e537d8eb88c440fd0b7aa88deec56aa688715b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 16:32:31.018893) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 16:32:31.019255) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 16:32:31.030232) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-22 16:32:31.030666) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:32:33 INFO - MultiFileLogger online at 20160822 16:32:33 in /builds/slave/test 16:32:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:32:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:32:33 INFO - {'append_to_log': False, 16:32:33 INFO - 'base_work_dir': '/builds/slave/test', 16:32:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:32:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:32:33 INFO - 'branch': 'Fx-Team-Non-PGO', 16:32:33 INFO - 'buildbot_json_path': 'buildprops.json', 16:32:33 INFO - 'config_files': ('talos/linux_config.py',), 16:32:33 INFO - 'default_actions': ('clobber', 16:32:33 INFO - 'read-buildbot-config', 16:32:33 INFO - 'download-and-extract', 16:32:33 INFO - 'populate-webroot', 16:32:33 INFO - 'create-virtualenv', 16:32:33 INFO - 'install', 16:32:33 INFO - 'run-tests'), 16:32:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:32:33 INFO - 'download_minidump_stackwalk': True, 16:32:33 INFO - 'download_symbols': 'ondemand', 16:32:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:32:33 INFO - 'tooltool.py': '/tools/tooltool.py', 16:32:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:32:33 INFO - '/tools/misc-python/virtualenv.py')}, 16:32:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:32:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:32:33 INFO - 'installer_path': 'installer.exe', 16:32:33 INFO - 'log_level': 'info', 16:32:33 INFO - 'log_name': 'talos', 16:32:33 INFO - 'log_to_console': True, 16:32:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:32:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:32:33 INFO - 'opt_config_files': (), 16:32:33 INFO - 'pip_index': False, 16:32:33 INFO - 'sps_profile': False, 16:32:33 INFO - 'sps_profile_interval': 0, 16:32:33 INFO - 'suite': 'dromaeojs-e10s', 16:32:33 INFO - 'system_bits': '32', 16:32:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:32:33 INFO - 'title': 'talos-linux64-ix-068', 16:32:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:32:33 INFO - 'use_talos_json': True, 16:32:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:32:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:32:33 INFO - 'work_dir': 'build'} 16:32:33 INFO - [mozharness: 2016-08-22 23:32:33.088679Z] Running clobber step. 16:32:33 INFO - Running pre-action listener: _resource_record_pre_action 16:32:33 INFO - Running main action method: clobber 16:32:33 INFO - rmtree: /builds/slave/test/build 16:32:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:32:33 INFO - Running post-action listener: _resource_record_post_action 16:32:33 INFO - [mozharness: 2016-08-22 23:32:33.563256Z] Finished clobber step (success) 16:32:33 INFO - [mozharness: 2016-08-22 23:32:33.563358Z] Running read-buildbot-config step. 16:32:33 INFO - Running pre-action listener: _resource_record_pre_action 16:32:33 INFO - Running main action method: read_buildbot_config 16:32:33 INFO - Using buildbot properties: 16:32:33 INFO - { 16:32:33 INFO - "project": "", 16:32:33 INFO - "product": "firefox", 16:32:33 INFO - "script_repo_revision": "production", 16:32:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:32:33 INFO - "repository": "", 16:32:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 16:32:33 INFO - "buildid": "20160822145214", 16:32:33 INFO - "pgo_build": "False", 16:32:33 INFO - "basedir": "/builds/slave/test", 16:32:33 INFO - "buildnumber": 1768, 16:32:33 INFO - "slavename": "talos-linux64-ix-068", 16:32:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:32:33 INFO - "platform": "ubuntu64_hw", 16:32:33 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 16:32:33 INFO - "branch": "fx-team", 16:32:33 INFO - "repo_path": "integration/fx-team", 16:32:33 INFO - "revision": "3e537d8eb88c440fd0b7aa88deec56aa688715b0", 16:32:33 INFO - "stage_platform": "linux64", 16:32:33 INFO - "builduid": "bfa0b3d7dfdb4689b676509060d68745", 16:32:33 INFO - "slavebuilddir": "test" 16:32:33 INFO - } 16:32:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:32:33 INFO - Running post-action listener: _resource_record_post_action 16:32:33 INFO - [mozharness: 2016-08-22 23:32:33.565801Z] Finished read-buildbot-config step (success) 16:32:33 INFO - [mozharness: 2016-08-22 23:32:33.565888Z] Running download-and-extract step. 16:32:33 INFO - Running pre-action listener: _resource_record_pre_action 16:32:33 INFO - Running main action method: download_and_extract 16:32:33 INFO - mkdir: /builds/slave/test/build/tests 16:32:33 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')]} 16:32:33 INFO - trying https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:32:33 INFO - Downloading https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 16:32:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 16:32:34 INFO - Downloaded 1361 bytes. 16:32:34 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:32:34 INFO - Using the following test package requirements: 16:32:34 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:32:34 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:32:34 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:32:34 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:34 INFO - u'jsshell-linux-x86_64.zip'], 16:32:34 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:32:34 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:32:34 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:32:34 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:32:34 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:32:34 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:32:34 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:32:34 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')]} 16:32:34 INFO - trying https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:32:34 INFO - Downloading https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 16:32:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 16:32:35 INFO - Downloaded 20330904 bytes. 16:32:35 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16:32:39 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 16:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:39 INFO - trying https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:32:39 INFO - Downloading https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 16:32:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 16:32:40 INFO - Downloaded 20330904 bytes. 16:32:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:44 INFO - trying https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:32:44 INFO - Downloading https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 16:32:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 16:32:45 INFO - Downloaded 14413981 bytes. 16:32:45 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 16:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:45 INFO - trying https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:32:45 INFO - Downloading https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 16:32:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 16:32:47 INFO - Downloaded 55764349 bytes. 16:32:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:32:47 INFO - mkdir: /builds/slave/test/properties 16:32:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:32:47 INFO - Writing to file /builds/slave/test/properties/build_url 16:32:47 INFO - Contents: 16:32:47 INFO - build_url:https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:32:47 INFO - Running post-action listener: _resource_record_post_action 16:32:47 INFO - Running post-action listener: set_extra_try_arguments 16:32:47 INFO - [mozharness: 2016-08-22 23:32:47.757753Z] Finished download-and-extract step (success) 16:32:47 INFO - [mozharness: 2016-08-22 23:32:47.757977Z] Running populate-webroot step. 16:32:47 INFO - Running pre-action listener: _resource_record_pre_action 16:32:47 INFO - Running main action method: populate_webroot 16:32:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:32:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:32:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:32:47 INFO - '--tppagecycles', 16:32:47 INFO - '7'], 16:32:47 INFO - 'tests': ['tsvgm']}}, 16:32:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:32:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:32:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:32:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:32:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:32:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:32:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:47 INFO - 'talos_options': ['--disable-e10s'], 16:32:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:32:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:32:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:47 INFO - 'talos_options': ['--disable-e10s'], 16:32:47 INFO - 'tests': ['damp', 'tps']}, 16:32:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:47 INFO - 'tests': ['damp', 'tps']}, 16:32:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:32:47 INFO - 'tests': ['dromaeo_dom']}, 16:32:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:32:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:32:47 INFO - 'tests': ['basic_compositor_video']}, 16:32:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:32:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:32:47 INFO - 'tests': ['a11yr', 16:32:47 INFO - 'ts_paint', 16:32:47 INFO - 'tpaint', 16:32:47 INFO - 'sessionrestore', 16:32:47 INFO - 'sessionrestore_no_auto_restore', 16:32:47 INFO - 'tabpaint']}, 16:32:47 INFO - 'other-e10s': {'tests': ['a11yr', 16:32:47 INFO - 'ts_paint', 16:32:47 INFO - 'tpaint', 16:32:47 INFO - 'sessionrestore', 16:32:47 INFO - 'sessionrestore_no_auto_restore', 16:32:47 INFO - 'tabpaint']}, 16:32:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:32:47 INFO - 'ts_paint', 16:32:47 INFO - 'tpaint', 16:32:47 INFO - 'sessionrestore', 16:32:47 INFO - 'sessionrestore_no_auto_restore', 16:32:47 INFO - 'tabpaint']}, 16:32:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:32:47 INFO - 'ts_paint', 16:32:47 INFO - 'tpaint', 16:32:47 INFO - 'sessionrestore', 16:32:47 INFO - 'sessionrestore_no_auto_restore', 16:32:47 INFO - 'tabpaint']}, 16:32:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:32:47 INFO - 'tests': ['a11yr', 16:32:47 INFO - 'ts_paint', 16:32:47 INFO - 'tpaint', 16:32:47 INFO - 'sessionrestore', 16:32:47 INFO - 'sessionrestore_no_auto_restore', 16:32:47 INFO - 'tabpaint']}, 16:32:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:32:47 INFO - 'tests': ['a11yr', 16:32:47 INFO - 'ts_paint', 16:32:47 INFO - 'tpaint', 16:32:47 INFO - 'sessionrestore', 16:32:47 INFO - 'sessionrestore_no_auto_restore', 16:32:47 INFO - 'tabpaint']}, 16:32:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:32:47 INFO - 'tests': ['tsvgx', 16:32:47 INFO - 'tsvgr_opacity', 16:32:47 INFO - 'tart', 16:32:47 INFO - 'tscrollx', 16:32:47 INFO - 'cart']}, 16:32:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:32:47 INFO - 'tsvgr_opacity', 16:32:47 INFO - 'tart', 16:32:47 INFO - 'tscrollx', 16:32:47 INFO - 'cart']}, 16:32:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:47 INFO - 'talos_options': ['--disable-e10s'], 16:32:47 INFO - 'tests': ['tp5o']}, 16:32:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:47 INFO - 'tests': ['tp5o']}, 16:32:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:47 INFO - 'talos_options': ['--disable-e10s', 16:32:47 INFO - '--xperf_path', 16:32:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:32:47 INFO - 'tests': ['tp5n']}, 16:32:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:47 INFO - 'talos_options': ['--xperf_path', 16:32:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:32:47 INFO - 'tests': ['tp5n']}}, 16:32:47 INFO - 'talos.zip': {'path': '', 16:32:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:32:47 INFO - Running post-action listener: _resource_record_post_action 16:32:47 INFO - [mozharness: 2016-08-22 23:32:47.775154Z] Finished populate-webroot step (success) 16:32:47 INFO - [mozharness: 2016-08-22 23:32:47.775242Z] Running create-virtualenv step. 16:32:47 INFO - Running pre-action listener: _resource_record_pre_action 16:32:47 INFO - Running main action method: create_virtualenv 16:32:47 INFO - Creating virtualenv /builds/slave/test/build/venv 16:32:47 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 16:32:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:32:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:32:47 INFO - Using real prefix '/usr' 16:32:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:32:48 INFO - Installing distribute.............................................................................................................................................................................................done. 16:32:50 INFO - Installing pip.................done. 16:32:50 INFO - Return code: 0 16:32:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:50 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 0x7f78da778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b80230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a090>, '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 0x2b7d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7de40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', '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 16:32:50 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 16:32:50 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 16:32:50 INFO - Using env: {'DISPLAY': ':0', 16:32:50 INFO - 'HOME': '/home/cltbld', 16:32:50 INFO - 'LANG': 'en_US.UTF-8', 16:32:50 INFO - 'LANGUAGE': 'en_US:en', 16:32:50 INFO - 'LOGNAME': 'cltbld', 16:32:50 INFO - 'MAIL': '/var/mail/cltbld', 16:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:50 INFO - 'MOZ_NO_REMOTE': '1', 16:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:50 INFO - 'NO_EM_RESTART': '1', 16:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:50 INFO - 'PWD': '/builds/slave/test', 16:32:50 INFO - 'SHELL': '/bin/bash', 16:32:50 INFO - 'SHLVL': '1', 16:32:50 INFO - 'TERM': 'linux', 16:32:50 INFO - 'TMOUT': '86400', 16:32:50 INFO - 'USER': 'cltbld', 16:32:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', 16:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:50 INFO - '_': '/tools/buildbot/bin/python'} 16:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:50 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 16:32:50 INFO - Cleaning up... 16:32:50 INFO - Return code: 0 16:32:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:50 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 0x7f78da778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b80230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a090>, '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 0x2b7d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7de40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', '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 16:32:50 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 16:32:50 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 16:32:50 INFO - Using env: {'DISPLAY': ':0', 16:32:50 INFO - 'HOME': '/home/cltbld', 16:32:50 INFO - 'LANG': 'en_US.UTF-8', 16:32:50 INFO - 'LANGUAGE': 'en_US:en', 16:32:50 INFO - 'LOGNAME': 'cltbld', 16:32:50 INFO - 'MAIL': '/var/mail/cltbld', 16:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:50 INFO - 'MOZ_NO_REMOTE': '1', 16:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:50 INFO - 'NO_EM_RESTART': '1', 16:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:50 INFO - 'PWD': '/builds/slave/test', 16:32:50 INFO - 'SHELL': '/bin/bash', 16:32:50 INFO - 'SHLVL': '1', 16:32:50 INFO - 'TERM': 'linux', 16:32:50 INFO - 'TMOUT': '86400', 16:32:50 INFO - 'USER': 'cltbld', 16:32:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', 16:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:50 INFO - '_': '/tools/buildbot/bin/python'} 16:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:50 INFO - Downloading/unpacking psutil>=3.1.1 16:32:50 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 16:32:50 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 16:32:50 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 16:32:50 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 16:32:50 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 16:32:50 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 16:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:32:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:52 INFO - Installing collected packages: psutil 16:32:52 INFO - Running setup.py install for psutil 16:32:52 INFO - building 'psutil._psutil_linux' extension 16:32:52 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 16:32:53 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 16:32:53 INFO - building 'psutil._psutil_posix' extension 16:32:53 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 16:32:53 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 16:32:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:53 INFO - Successfully installed psutil 16:32:53 INFO - Cleaning up... 16:32:53 INFO - Return code: 0 16:32:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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')]} 16:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f78da778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b80230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a090>, '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 0x2b7d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7de40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', '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 16:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:32:53 INFO - Using env: {'DISPLAY': ':0', 16:32:53 INFO - 'HOME': '/home/cltbld', 16:32:53 INFO - 'LANG': 'en_US.UTF-8', 16:32:53 INFO - 'LANGUAGE': 'en_US:en', 16:32:53 INFO - 'LOGNAME': 'cltbld', 16:32:53 INFO - 'MAIL': '/var/mail/cltbld', 16:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:53 INFO - 'MOZ_NO_REMOTE': '1', 16:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:53 INFO - 'NO_EM_RESTART': '1', 16:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:53 INFO - 'PWD': '/builds/slave/test', 16:32:53 INFO - 'SHELL': '/bin/bash', 16:32:53 INFO - 'SHLVL': '1', 16:32:53 INFO - 'TERM': 'linux', 16:32:53 INFO - 'TMOUT': '86400', 16:32:53 INFO - 'USER': 'cltbld', 16:32:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', 16:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:53 INFO - '_': '/tools/buildbot/bin/python'} 16:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:32:55 INFO - Installing collected packages: mozsystemmonitor 16:32:55 INFO - Running setup.py install for mozsystemmonitor 16:32:55 INFO - Successfully installed mozsystemmonitor 16:32:55 INFO - Cleaning up... 16:32:55 INFO - Return code: 0 16:32:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:32:55 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')]} 16:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:55 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')]} 16:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:55 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 0x7f78da778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b80230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a090>, '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 0x2b7d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7de40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', '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 16:32:55 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 16:32:55 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 16:32:55 INFO - Using env: {'DISPLAY': ':0', 16:32:55 INFO - 'HOME': '/home/cltbld', 16:32:55 INFO - 'LANG': 'en_US.UTF-8', 16:32:55 INFO - 'LANGUAGE': 'en_US:en', 16:32:55 INFO - 'LOGNAME': 'cltbld', 16:32:55 INFO - 'MAIL': '/var/mail/cltbld', 16:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:55 INFO - 'MOZ_NO_REMOTE': '1', 16:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:55 INFO - 'NO_EM_RESTART': '1', 16:32:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:55 INFO - 'PWD': '/builds/slave/test', 16:32:55 INFO - 'SHELL': '/bin/bash', 16:32:55 INFO - 'SHLVL': '1', 16:32:55 INFO - 'TERM': 'linux', 16:32:55 INFO - 'TMOUT': '86400', 16:32:55 INFO - 'USER': 'cltbld', 16:32:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', 16:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:55 INFO - '_': '/tools/buildbot/bin/python'} 16:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:55 INFO - Downloading/unpacking jsonschema==2.5.1 16:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:32:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:32:57 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 16:32:57 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 16:32:57 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 16:32:57 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 16:32:57 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 16:32:57 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 16:32:57 INFO - Downloading functools32-3.2.3-2.tar.gz 16:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:32:58 INFO - warning: no files found matching '*.txt' 16:32:58 INFO - no previously-included directories found matching 'build' 16:32:58 INFO - no previously-included directories found matching 'dist' 16:32:58 INFO - no previously-included directories found matching '.git*' 16:32:58 INFO - Installing collected packages: jsonschema, functools32 16:32:58 INFO - Running setup.py install for functools32 16:32:58 INFO - warning: no files found matching '*.txt' 16:32:58 INFO - no previously-included directories found matching 'build' 16:32:58 INFO - no previously-included directories found matching 'dist' 16:32:58 INFO - no previously-included directories found matching '.git*' 16:32:58 INFO - Successfully installed jsonschema functools32 16:32:58 INFO - Cleaning up... 16:32:58 INFO - Return code: 0 16:32:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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')]} 16:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:58 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 0x7f78da778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b80230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a090>, '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 0x2b7d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7de40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', '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 16:32:58 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 16:32:58 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 16:32:58 INFO - Using env: {'DISPLAY': ':0', 16:32:58 INFO - 'HOME': '/home/cltbld', 16:32:58 INFO - 'LANG': 'en_US.UTF-8', 16:32:58 INFO - 'LANGUAGE': 'en_US:en', 16:32:58 INFO - 'LOGNAME': 'cltbld', 16:32:58 INFO - 'MAIL': '/var/mail/cltbld', 16:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:58 INFO - 'MOZ_NO_REMOTE': '1', 16:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:58 INFO - 'NO_EM_RESTART': '1', 16:32:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:58 INFO - 'PWD': '/builds/slave/test', 16:32:58 INFO - 'SHELL': '/bin/bash', 16:32:58 INFO - 'SHLVL': '1', 16:32:58 INFO - 'TERM': 'linux', 16:32:58 INFO - 'TMOUT': '86400', 16:32:58 INFO - 'USER': 'cltbld', 16:32:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', 16:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:58 INFO - '_': '/tools/buildbot/bin/python'} 16:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:32:58 INFO - Cleaning up... 16:32:58 INFO - Return code: 0 16:32:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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')]} 16:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:58 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 0x7f78da778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b80230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a090>, '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 0x2b7d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7de40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', '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 16:32:58 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 16:32:58 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 16:32:58 INFO - Using env: {'DISPLAY': ':0', 16:32:58 INFO - 'HOME': '/home/cltbld', 16:32:58 INFO - 'LANG': 'en_US.UTF-8', 16:32:58 INFO - 'LANGUAGE': 'en_US:en', 16:32:58 INFO - 'LOGNAME': 'cltbld', 16:32:58 INFO - 'MAIL': '/var/mail/cltbld', 16:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:58 INFO - 'MOZ_NO_REMOTE': '1', 16:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:58 INFO - 'NO_EM_RESTART': '1', 16:32:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:58 INFO - 'PWD': '/builds/slave/test', 16:32:58 INFO - 'SHELL': '/bin/bash', 16:32:58 INFO - 'SHLVL': '1', 16:32:58 INFO - 'TERM': 'linux', 16:32:58 INFO - 'TMOUT': '86400', 16:32:58 INFO - 'USER': 'cltbld', 16:32:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', 16:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:58 INFO - '_': '/tools/buildbot/bin/python'} 16:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:58 INFO - Downloading/unpacking blobuploader==1.2.4 16:32:58 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 16:32:58 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 16:32:58 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 16:32:58 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 16:32:58 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 16:32:58 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 16:33:00 INFO - Downloading blobuploader-1.2.4.tar.gz 16:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:33:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:33:00 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 16:33:00 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 16:33:00 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 16:33:00 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 16:33:00 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 16:33:00 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 16:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:33:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:01 INFO - Downloading docopt-0.6.1.tar.gz 16:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:33:01 INFO - Installing collected packages: blobuploader, requests, docopt 16:33:01 INFO - Running setup.py install for blobuploader 16:33:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:33:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:33:01 INFO - Running setup.py install for requests 16:33:01 INFO - Running setup.py install for docopt 16:33:01 INFO - Successfully installed blobuploader requests docopt 16:33:01 INFO - Cleaning up... 16:33:01 INFO - Return code: 0 16:33:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:33:01 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')]} 16:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:01 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')]} 16:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:01 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 0x7f78da778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b80230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a090>, '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 0x2b7d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7de40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', '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 16:33:01 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 16:33:01 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 16:33:01 INFO - Using env: {'DISPLAY': ':0', 16:33:01 INFO - 'HOME': '/home/cltbld', 16:33:01 INFO - 'LANG': 'en_US.UTF-8', 16:33:01 INFO - 'LANGUAGE': 'en_US:en', 16:33:01 INFO - 'LOGNAME': 'cltbld', 16:33:01 INFO - 'MAIL': '/var/mail/cltbld', 16:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:01 INFO - 'MOZ_NO_REMOTE': '1', 16:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:01 INFO - 'NO_EM_RESTART': '1', 16:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:01 INFO - 'PWD': '/builds/slave/test', 16:33:01 INFO - 'SHELL': '/bin/bash', 16:33:01 INFO - 'SHLVL': '1', 16:33:01 INFO - 'TERM': 'linux', 16:33:01 INFO - 'TMOUT': '86400', 16:33:01 INFO - 'USER': 'cltbld', 16:33:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', 16:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:01 INFO - '_': '/tools/buildbot/bin/python'} 16:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:33:02 INFO - Running setup.py (path:/tmp/pip-XB8j9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:33:02 INFO - Running setup.py (path:/tmp/pip-RrYIEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:33:02 INFO - Running setup.py (path:/tmp/pip-A6aUNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:33:02 INFO - Running setup.py (path:/tmp/pip-p_aSGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:33:02 INFO - Running setup.py (path:/tmp/pip-4bxysP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:33:02 INFO - Running setup.py (path:/tmp/pip-c7sRvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:33:02 INFO - Running setup.py (path:/tmp/pip-FemQ2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:33:02 INFO - Running setup.py (path:/tmp/pip-AkQnOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:33:02 INFO - Running setup.py (path:/tmp/pip-Gbzmns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:33:02 INFO - Running setup.py (path:/tmp/pip-zU06uX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:33:02 INFO - Running setup.py (path:/tmp/pip-mEBVBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:33:02 INFO - Running setup.py (path:/tmp/pip-L5zR9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:33:03 INFO - Running setup.py (path:/tmp/pip-70W2r6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:33:03 INFO - Running setup.py (path:/tmp/pip-ypPjo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:33:03 INFO - Running setup.py (path:/tmp/pip-gLYIWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:33:03 INFO - Running setup.py (path:/tmp/pip-R3gMkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:33:03 INFO - Running setup.py (path:/tmp/pip-FxzQjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:33:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:33:03 INFO - Running setup.py install for manifestparser 16:33:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:33:03 INFO - Running setup.py install for mozcrash 16:33:03 INFO - Running setup.py install for mozdebug 16:33:03 INFO - Running setup.py install for mozdevice 16:33:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:33:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:33:03 INFO - Running setup.py install for mozfile 16:33:03 INFO - Running setup.py install for mozhttpd 16:33:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:33:04 INFO - Running setup.py install for mozinfo 16:33:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:33:04 INFO - Running setup.py install for mozInstall 16:33:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:33:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:33:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:33:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:33:04 INFO - Running setup.py install for mozleak 16:33:04 INFO - Running setup.py install for mozlog 16:33:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:33:04 INFO - Running setup.py install for moznetwork 16:33:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:33:04 INFO - Running setup.py install for mozprocess 16:33:04 INFO - Running setup.py install for mozprofile 16:33:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:33:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:33:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:33:04 INFO - Running setup.py install for mozrunner 16:33:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:33:04 INFO - Running setup.py install for mozscreenshot 16:33:04 INFO - Running setup.py install for moztest 16:33:05 INFO - Running setup.py install for mozversion 16:33:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:33:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:33:05 INFO - Cleaning up... 16:33:05 INFO - Return code: 0 16:33:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:05 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 0x7f78da778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b80230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a090>, '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 0x2b7d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7de40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', '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 16:33:05 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 16:33:05 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 16:33:05 INFO - Using env: {'DISPLAY': ':0', 16:33:05 INFO - 'HOME': '/home/cltbld', 16:33:05 INFO - 'LANG': 'en_US.UTF-8', 16:33:05 INFO - 'LANGUAGE': 'en_US:en', 16:33:05 INFO - 'LOGNAME': 'cltbld', 16:33:05 INFO - 'MAIL': '/var/mail/cltbld', 16:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:05 INFO - 'MOZ_NO_REMOTE': '1', 16:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:05 INFO - 'NO_EM_RESTART': '1', 16:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:05 INFO - 'PWD': '/builds/slave/test', 16:33:05 INFO - 'SHELL': '/bin/bash', 16:33:05 INFO - 'SHLVL': '1', 16:33:05 INFO - 'TERM': 'linux', 16:33:05 INFO - 'TMOUT': '86400', 16:33:05 INFO - 'USER': 'cltbld', 16:33:05 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', 16:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:05 INFO - '_': '/tools/buildbot/bin/python'} 16:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:33:05 INFO - Running setup.py (path:/tmp/pip-YFces8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:33:05 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)) 16:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:33:05 INFO - Running setup.py (path:/tmp/pip-_Q8ZaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:33:05 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)) 16:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:33:05 INFO - Running setup.py (path:/tmp/pip-xV6FN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:33:05 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)) 16:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:33:05 INFO - Running setup.py (path:/tmp/pip-cDPUSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:33:05 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)) 16:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:33:05 INFO - Running setup.py (path:/tmp/pip-saNSLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:33:05 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)) 16:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:33:05 INFO - Running setup.py (path:/tmp/pip-U6vVX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:33:05 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)) 16:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:33:05 INFO - Running setup.py (path:/tmp/pip-TGdUZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:33:05 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)) 16:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:33:05 INFO - Running setup.py (path:/tmp/pip-CCdE1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:33:06 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)) 16:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:33:06 INFO - Running setup.py (path:/tmp/pip-zJ61Xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:33:06 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)) 16:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:33:06 INFO - Running setup.py (path:/tmp/pip-ZTzkLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:33:06 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)) 16:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:33:06 INFO - Running setup.py (path:/tmp/pip-S9cgpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:33:06 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)) 16:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:33:06 INFO - Running setup.py (path:/tmp/pip-ViW3c5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:33:06 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)) 16:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:33:06 INFO - Running setup.py (path:/tmp/pip-sBI8w2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:33:06 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)) 16:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:33:06 INFO - Running setup.py (path:/tmp/pip-pxLZ7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:33:06 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)) 16:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:33:06 INFO - Running setup.py (path:/tmp/pip-Slnpgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:33:06 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)) 16:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:33:06 INFO - Running setup.py (path:/tmp/pip-IeTfht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:33:06 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)) 16:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:33:06 INFO - Running setup.py (path:/tmp/pip-UfZk5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:33:06 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)) 16:33:06 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)) 16:33:06 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)) 16:33:06 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)) 16:33:06 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)) 16:33:06 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)) 16:33:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:33:06 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 16:33:06 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 16:33:06 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 16:33:06 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 16:33:06 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 16:33:06 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 16:33:08 INFO - Downloading blessings-1.6.tar.gz 16:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:33:08 INFO - Installing collected packages: blessings 16:33:08 INFO - Running setup.py install for blessings 16:33:08 INFO - Successfully installed blessings 16:33:08 INFO - Cleaning up... 16:33:08 INFO - Return code: 0 16:33:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:33:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:33:09 INFO - Reading from file tmpfile_stdout 16:33:09 INFO - Current package versions: 16:33:09 INFO - argparse == 1.2.1 16:33:09 INFO - blessings == 1.6 16:33:09 INFO - blobuploader == 1.2.4 16:33:09 INFO - docopt == 0.6.1 16:33:09 INFO - functools32 == 3.2.3-2 16:33:09 INFO - jsonschema == 2.5.1 16:33:09 INFO - manifestparser == 1.1 16:33:09 INFO - mozInstall == 1.12 16:33:09 INFO - mozcrash == 0.17 16:33:09 INFO - mozdebug == 0.1 16:33:09 INFO - mozdevice == 0.48 16:33:09 INFO - mozfile == 1.2 16:33:09 INFO - mozhttpd == 0.7 16:33:09 INFO - mozinfo == 0.9 16:33:09 INFO - mozleak == 0.1 16:33:09 INFO - mozlog == 3.3 16:33:09 INFO - moznetwork == 0.27 16:33:09 INFO - mozprocess == 0.23 16:33:09 INFO - mozprofile == 0.28 16:33:09 INFO - mozrunner == 6.12 16:33:09 INFO - mozscreenshot == 0.1 16:33:09 INFO - mozsystemmonitor == 0.3 16:33:09 INFO - moztest == 0.7 16:33:09 INFO - mozversion == 1.4 16:33:09 INFO - psutil == 3.1.1 16:33:09 INFO - requests == 1.2.3 16:33:09 INFO - wsgiref == 0.1.2 16:33:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:33: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')]} 16:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33: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')]} 16:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:09 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 0x7f78da778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b80230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a090>, '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 0x2b7d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7de40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', '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 16:33:09 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 16:33:09 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 16:33:09 INFO - Using env: {'DISPLAY': ':0', 16:33:09 INFO - 'HOME': '/home/cltbld', 16:33:09 INFO - 'LANG': 'en_US.UTF-8', 16:33:09 INFO - 'LANGUAGE': 'en_US:en', 16:33:09 INFO - 'LOGNAME': 'cltbld', 16:33:09 INFO - 'MAIL': '/var/mail/cltbld', 16:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:09 INFO - 'MOZ_NO_REMOTE': '1', 16:33:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:09 INFO - 'NO_EM_RESTART': '1', 16:33:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:09 INFO - 'PWD': '/builds/slave/test', 16:33:09 INFO - 'SHELL': '/bin/bash', 16:33:09 INFO - 'SHLVL': '1', 16:33:09 INFO - 'TERM': 'linux', 16:33:09 INFO - 'TMOUT': '86400', 16:33:09 INFO - 'USER': 'cltbld', 16:33:09 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', 16:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:09 INFO - '_': '/tools/buildbot/bin/python'} 16:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:09 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)) 16:33:09 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)) 16:33:09 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)) 16:33:09 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)) 16:33:09 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)) 16:33:09 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)) 16:33:09 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)) 16:33:09 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)) 16:33:09 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)) 16:33:09 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)) 16:33:09 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)) 16:33:09 INFO - Cleaning up... 16:33:09 INFO - Return code: 0 16:33:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:33: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')]} 16:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33: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')]} 16:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f78da778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b80230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a090>, '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 0x2b7d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7de40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', '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 16:33: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', 'jsonschema'] in /builds/slave/test/build 16:33: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 jsonschema 16:33:09 INFO - Using env: {'DISPLAY': ':0', 16:33:09 INFO - 'HOME': '/home/cltbld', 16:33:09 INFO - 'LANG': 'en_US.UTF-8', 16:33:09 INFO - 'LANGUAGE': 'en_US:en', 16:33:09 INFO - 'LOGNAME': 'cltbld', 16:33:09 INFO - 'MAIL': '/var/mail/cltbld', 16:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:09 INFO - 'MOZ_NO_REMOTE': '1', 16:33:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:09 INFO - 'NO_EM_RESTART': '1', 16:33:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:09 INFO - 'PWD': '/builds/slave/test', 16:33:09 INFO - 'SHELL': '/bin/bash', 16:33:09 INFO - 'SHLVL': '1', 16:33:09 INFO - 'TERM': 'linux', 16:33:09 INFO - 'TMOUT': '86400', 16:33:09 INFO - 'USER': 'cltbld', 16:33:09 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', 16:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:09 INFO - '_': '/tools/buildbot/bin/python'} 16:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:33:09 INFO - Cleaning up... 16:33:09 INFO - Return code: 0 16:33:09 INFO - Running post-action listener: _resource_record_post_action 16:33:09 INFO - Running post-action listener: _start_resource_monitoring 16:33:09 INFO - Starting resource monitoring. 16:33:09 INFO - [mozharness: 2016-08-22 23:33:09.668769Z] Finished create-virtualenv step (success) 16:33:09 INFO - [mozharness: 2016-08-22 23:33:09.669234Z] Running install step. 16:33:09 INFO - Running pre-action listener: _resource_record_pre_action 16:33:09 INFO - Running main action method: install 16:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:33:09 INFO - Reading from file tmpfile_stdout 16:33:09 INFO - Detecting whether we're running mozinstall >=1.0... 16:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:33:09 INFO - Reading from file tmpfile_stdout 16:33:09 INFO - Output received: 16:33:09 INFO - Usage: mozinstall [options] installer 16:33:09 INFO - Options: 16:33:09 INFO - -h, --help show this help message and exit 16:33:09 INFO - -d DEST, --destination=DEST 16:33:09 INFO - Directory to install application into. [default: 16:33:09 INFO - "/builds/slave/test"] 16:33:09 INFO - --app=APP Application being installed. [default: firefox] 16:33:09 INFO - mkdir: /builds/slave/test/build/application 16:33:09 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'] 16:33:09 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 16:33:26 INFO - Reading from file tmpfile_stdout 16:33:26 INFO - Output received: 16:33:26 INFO - /builds/slave/test/build/application/firefox/firefox 16:33:26 INFO - Running post-action listener: _resource_record_post_action 16:33:26 INFO - [mozharness: 2016-08-22 23:33:26.072576Z] Finished install step (success) 16:33:26 INFO - [mozharness: 2016-08-22 23:33:26.072916Z] Running run-tests step. 16:33:26 INFO - Running pre-action listener: _resource_record_pre_action 16:33:26 INFO - Running main action method: run_tests 16:33:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:33:26 INFO - Python 2.7.3 16:33:26 INFO - Return code: 0 16:33:26 INFO - grabbing minidump binary from tooltool 16:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:26 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 0x2b7a090>, '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 0x2b7d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7de40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:33:26 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 16:33:26 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 16:33:26 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 16:33:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:33:26 INFO - Return code: 0 16:33:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:33:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:33:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:33:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:33:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:33:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 16:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 16:33:26 INFO - Using env: {'DISPLAY': ':0', 16:33:26 INFO - 'HOME': '/home/cltbld', 16:33:26 INFO - 'LANG': 'en_US.UTF-8', 16:33:26 INFO - 'LANGUAGE': 'en_US:en', 16:33:26 INFO - 'LOGNAME': 'cltbld', 16:33:26 INFO - 'MAIL': '/var/mail/cltbld', 16:33:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:33:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:26 INFO - 'MOZ_NO_REMOTE': '1', 16:33:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:26 INFO - 'NO_EM_RESTART': '1', 16:33:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:26 INFO - 'PWD': '/builds/slave/test', 16:33:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:33:26 INFO - 'SHELL': '/bin/bash', 16:33:26 INFO - 'SHLVL': '1', 16:33:26 INFO - 'TERM': 'linux', 16:33:26 INFO - 'TMOUT': '86400', 16:33:26 INFO - 'USER': 'cltbld', 16:33:26 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499', 16:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:26 INFO - '_': '/tools/buildbot/bin/python'} 16:33:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 16:33:26 INFO - mozversion application_buildid: 20160822145214 16:33:26 INFO - mozversion application_changeset: 3e537d8eb88c440fd0b7aa88deec56aa688715b0 16:33:26 INFO - mozversion application_display_name: Nightly 16:33:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:33:26 INFO - mozversion application_name: Firefox 16:33:26 INFO - mozversion application_remotingname: firefox 16:33:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:33:26 INFO - mozversion application_vendor: Mozilla 16:33:26 INFO - mozversion application_version: 51.0a1 16:33:26 INFO - mozversion platform_buildid: 20160822145214 16:33:26 INFO - mozversion platform_changeset: 3e537d8eb88c440fd0b7aa88deec56aa688715b0 16:33:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:33:26 INFO - mozversion platform_version: 51.0a1 16:33:26 INFO - using testdate: 1471908806 16:33:26 INFO - actual date: 1471908806 16:33:26 INFO - starting webserver on 'localhost:50306' 16:33:26 INFO - SUITE-START | Running 2 tests 16:33:26 INFO - TEST-START | dromaeo_css 16:33:26 INFO - operating with platform_type : linux_ 16:33:26 INFO - Initialising browser for dromaeo_css test... 16:33:26 INFO - TEST-INFO | started process 6290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAHNoGL/profile http://localhost:50306/getInfo.html) 16:33:31 INFO - PROCESS | 6290 | __metrics Screen width/height:1600/1200 16:33:31 INFO - PROCESS | 6290 | colorDepth:24 16:33:31 INFO - PROCESS | 6290 | Browser inner width/height: 1024/697 16:33:31 INFO - PROCESS | 6290 | __metrics 16:33:32 ERROR - PROCESS | 6290 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 16:33:33 INFO - TEST-INFO | 6290: exit 0 16:33:33 INFO - Browser initialized. 16:33:33 INFO - Running cycle 1/1 for dromaeo_css test... 16:33:33 INFO - TEST-INFO | started process 6409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAHNoGL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:45 INFO - PROCESS | 6409 | RSS: Main: 187461632 16:33:45 INFO - PROCESS | 6409 | 16:34:35 INFO - PROCESS | 6409 | 1471908875005 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] 16:36:47 INFO - PROCESS | 6409 | Cycle 1(1): loaded http://localhost:50306/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50306/tests/dromaeo/cssquery-ext.html) 16:36:48 INFO - PROCESS | 6409 | RSS: Main: 199073792 16:36:48 INFO - PROCESS | 6409 | 16:39:51 INFO - PROCESS | 6409 | Cycle 1(1): loaded http://localhost:50306/tests/dromaeo/cssquery-ext.html (next: http://localhost:50306/tests/dromaeo/cssquery-jquery.html) 16:39:51 INFO - PROCESS | 6409 | RSS: Main: 197722112 16:39:51 INFO - PROCESS | 6409 | 16:42:53 INFO - PROCESS | 6409 | Cycle 1(1): loaded http://localhost:50306/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50306/tests/dromaeo/cssquery-mootools.html) 16:42:54 INFO - PROCESS | 6409 | RSS: Main: 199254016 16:42:54 INFO - PROCESS | 6409 | 16:45:56 INFO - PROCESS | 6409 | Cycle 1(1): loaded http://localhost:50306/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50306/tests/dromaeo/cssquery-prototype.html) 16:45:57 INFO - PROCESS | 6409 | RSS: Main: 196648960 16:45:57 INFO - PROCESS | 6409 | 16:48:59 INFO - PROCESS | 6409 | Cycle 1(1): loaded http://localhost:50306/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50306/tests/dromaeo/cssquery-yui.html) 16:49:00 INFO - PROCESS | 6409 | RSS: Main: 198361088 16:49:00 INFO - PROCESS | 6409 | 16:52:03 INFO - PROCESS | 6409 | Cycle 1(1): loaded http://localhost:50306/tests/dromaeo/cssquery-yui.html (next: http://localhost:50306/tests/dromaeo/cssquery-dojo.html) 16:52:03 INFO - PROCESS | 6409 | RSS: Main: 199671808 16:52:03 INFO - PROCESS | 6409 | 16:52:03 INFO - PROCESS | 6409 | __start_tp_report 16:52:03 INFO - PROCESS | 6409 | _x_x_mozilla_page_load 16:52:03 INFO - PROCESS | 6409 | _x_x_mozilla_page_load_details 16:52:03 INFO - PROCESS | 6409 | |i|pagename|runs| 16:52:03 INFO - PROCESS | 6409 | |0;dojo.html;2613.007057318219;2617.4110825064363;2633.6181253718205;2637.208837348795;2656.189862092064;4701.059788042388;4794.688345257556;4853.587445067169;4884.926726099111;4911.435184953727;4714.9528504714945;4765.785539650716;4780.067886762083;4785.042991401725;4799.112164249616;4288.185244803493;4436.5119836818;4457.977710111445;4544.9091018179615;4547.63618910488;4492.0791237796175;4495.640348772106;4529.320601909723;4535.7958891849785;4544.386507821451;4284.61438470536;4350.7172033818015;4377.606015458592;4394.648428125743;4411.669124815619;4419.138268037702;4425.712328698624;4431.977840110779;4488.394066800973;4500.234960056799;4406.184855801687;4424.137293227822;4457.0194557197365;4464.933026004613;4468.597826195625;4705.035467729142;4771.355866957951;4781.282807578891;4820.312031802472;4836.758162091916;5174.068667639824;5174.948250517485;5185.429602743695;5200.869978250536;5218.243354713583;5069.569086627641;5122.641415100945;5139.665921715076;5147.948520514784;5168.948310516885;4803.159447096744;4824.879378015543;4839.370881785346;4839.733814640158;4842.055799119208;5255.237990491434;5273.630845840831;5281.049411105961;5286.444923283;5300.681959082467;4983.651144419929;5058.570021548136;5058.924116138261;5064.645474816727;5068.746562671851;4976.776045077981;4999.65002449825;5069.746512674352;5141.8457446275925;5207.3490813648295;5154.252633368215;5164.767585458663;5165.793368265303;5167.741612919339;5171.974140129275;4909.901801963941;5115.283860259567;5122.308488354024;5148.9485105149215;5152.845414637567;4210.389493523422;4233.047564298008;4237.555056719062;4294.656427485794;4307.978460107679;3743.47591337213;3744.400895856704;3758.8496460141837;3759.4924685167152;3764.134249122717;4340.110277393127;4342.891427714332;4361.280388735887;4363.0401311712;4375.971646663095;5103.591712662978;5127.794888204505;5178.6116041297055;5207.739613019334;5218.530332270114;4391.363252328459;4427.114577084531;4433.645308375322;4435.844745433958;4442.444694413199;4528.50186479487;4539.977300113478;4651.279051746985;4654.95263565695;4663.27719203524;4838.298446725275;4846.636502262415;4850.733209673432;4876.341693871282;4888.5355891189565;5181.974090129525;5215.45237750046;5223.738813059256;5250.868728281824;5271.894562108813;4745.762711864462;4783.091212669721;4813.614910807197;4922.8769280768265;4928.112939670894;5026.321446604661;5060;5074.137396642506;5079.9238011429115;5138.100832354397;5125.205593133071;5145.253938179018;5182.6113041521285;5212.661177023481;5216.634835561475;4791.688540244873;4944.629152813482;4951.207806750903;4972.5276098770555;5067.442581316126;4894.706317620954;4898.21628539432;4949.97525012387;4969.552740253394;4980.153373926369;4939.333190019302;4942.332785073969;4952.579030782424;4968.850934471971;4974.452810190948;4887.242477416006;4959.454460009469;4960.355153829979;5095.490450954875;5098.158803797481;4902.2156454967035;4924.679895806761;4930.654854160318;4947.431045429822;4955.033768415268 16:52:03 INFO - PROCESS | 6409 | |1;ext.html;544.3630951786412;544.4528249109645;551.762742020931;558.2073455692915;562.9634073785206;34595;38601;38609.613903860954;38642.42036369457;38701.225975480476;38978.22043559127;39347.606523934825;39502.60497395025;39516.80241598788;39572;7378.262173782619;7601.23987601241;7620.618969051553;7623.123340815821;7651.234876512332;7480.812979675497;7575.431842611826;7583.355414789722;7596.696132154707;7625.084989801232;7589.810254743648;7615.885761713579;7636.198199189089;7658.770236892902;7666.080070391561;7589.089309282866;7652.808679782995;7665.271799179069;7674.46278760487;7679.884801727979;7298.270172982712;7373.594452305121;7404.851902961911;7415.40676745859;7431.442641801887;37244.255114897824;37320.44019339685;37548.43677344842;37591.436128458095;37827.4325885112;2603.570410882202;2608.9167909126813;2641.867906604681;2675.5184066867955;2677.799165062628;28229.85885070582;28616.85691571529;28892.566611500843;29080.563791543143;29883.5517467236;3372.104047223434;3466.5146879436898;3487.761844545201;3534.7525673202886;3551.94672079919;254247;256195;256375;257475;257518;49989.25016124761;50172.74913625408;50477.49522504801;50486.24270635944;50571.644245813906;31979.36041279208;53471;53685.1947220792;53822.730886345315;53941.46058539443;12846.871531284567;13409.463621455032;13462.192268463923;13524.256165910772;13582.524611638546;9982.201423886072;10064.647737329158;10115;10133.949330253448;10150.03574660406;17258.741118883227;17437.21532531039;17676.292948281924;17708.822911770716;17745.46763597094;6643.734250630017;6704.966475167593;6814.965925170342;6858.759943402057;6927.515073944775;774.7753151586089;834.8163404051099;935.5369092299355;989.995154917759;990.7404638738614;27052.729472705414;29066.854665726536;31460.30431942061;31494.842525787226;31535.526967095513;924.242121460396;975.7121649113386;984.5717113055844;1001.7746007148479;1022.5551884930079;14661.633459163606;14806.407743690132;14986.250687465583;14996.62508437276;15098.39606415731;385046;388639;389144;389646;390092;46791;47228.52771472241;47260.5273947263;47405.28892066553;47802.5219747805;1162.6686394377562;1172.284906207213;1220.45079714129;1224.969375765613;1230.21266389509;25397.492050159264;26438;27340.726592734612;27664.58503122495;27727.72272277332;41888.16223675571;42638.57361426346;42985.57014429941;43084.35373469463;43162.1367572653;342370;342663;344258;345035;345271;24719.505609887343;25076.498470030863;25094.62358064667;25113.121040763486;25231.74768252294;35216.471752923215;35554.28891422209;36023.639763603074;36367.818160909024;36851.447228292134;30472.39055218839;30582.541261881535;30612.846935765177;30724.84637576798;31541.211469713442;35433.46849797203;35449.518533702394;35763;35839.28321433609;35975.460368093976;26942.59586106171;34636.480452792726;34689.13277168091;35174;35462.46806297856;30669.23326916756;32419.83790081129;32469.837650811594;32475.350492989535;32698.34603307968;25059.749402505742;25254.368640784127;25399.746002540476;25617.97528098855;26698.466030679665 16:52:03 INFO - PROCESS | 6409 | |2;jquery.html;344.5882170805888;355.3638986214675;357.6459305287765;369.95375578052744;378.3662365537725;15849.12829794361;16313;17351;17522.737158942626;17607.647847043052;15443.073415595072;15752.76370854438;16123.83876161238;16488.58778530537;16557.66884662306;4301.698881078326;4569.200389931765;4593.770311484429;4656.022235330584;4658.138244424776;4604.033153037866;4610.9308360374625;4631.652626053043;4639.976800116012;4641.35021097045;4546.090781843644;4718.882027949295;5066.518680725325;5086.262491938666;5092.872678183038;5040.319556859814;5053.823116190934;5067.417247016603;5076.974615126937;5084.262781896641;4498.415206023229;4598.977005114986;4766.690165139289;4779.307000484945;4801.423829140525;11456.369899655516;11679.766404671944;11843.703907402298;11856.703582410422;11864.406779660982;1832.7159290310024;1839.9908000460046;1860.618573192506;1948.1428171604448;2160.2547121243147;8566.914330856674;8606.31149508038;8676.783080422976;8917.286617070618;9112.908870911273;1653.7271350227197;1696.4401747423321;1702.9063401512913;1705.7611934329204;1709.2735587375316;63932.36067639311;69911.30088699098;70248.6487567559;72442.63778681072;73412.63293683497;9862.408255504693;9986.550605222783;10091.293609447268;10242.846357304647;10323.63867264642;13777.517786877412;13795.931020344835;13822.308884555932;13838.30808459573;13838.930805345908;6811.352921472452;6814.284500127515;6970.756023539152;7081.433485321162;7152.678129484186;6503.28463868974;6561.507886908501;6568.244651865097;6801.9319806801295;6856.725730970805;4153.231652144363;4181;4189.371594260885;4287.121140166259;4343.087951530214;1735.6008118132647;1813.619139980619;1820.2718912434866;1852.8147185281634;1857.4334827877626;792.528445574882;815.2377527012144;826.9379796515285;833.5207255827924;914.2366124286295;16819.327226910787;17035.40376086831;17310.913445432692;17381.217845196996;17599.38402155944;799.9880001799978;815.9918400815916;841.87792770048;850.9957450212834;901.977450563728;9608.75978100539;9752.561134748954;9815.165710914509;9970.202383809423;10136.341137826017;345904;349985;351907.96184076177;352559;353297;78317.21682783213;79261.60369198117;79310.6034469824;79363;80355.59822200969;794.9721759738497;818.55388813097;819.4182130687279;822.5928165558087;824.6000689665508;15076.547703568911;15422.845771542141;15509.76735348948;15613.14127722986;15840.524784256491;35768.853868767954;38009.61990380061;38141;38383.04042398962;39055.437782488385;50850.23724644207;51050;51273.743631281606;51371.2294315593;53674.46325536694;7189.424846012411;7214.783556493314;7356.632168391666;7466.626668666437;7665.080190377191;9971.40171589707;11346.602868899548;11402.714932126763;11783.705407364885;11894.821577676168;7855.685772569033;8206;9729.562169702238;10186.439745814052;10287.588496460057;8539.615717292612;9821.263405244492;10314.381137131797;10556.947215263874;10772.461376930965;5190.714510701948;8305.044919834296;10532;10683.5192416343;10720.46797588499;7477.925220747723;7548.584827834522;7570.242975702386;7629.504082234637;7713.730019449293;7976;10578.259521833397;10642.521086550969;10910.509027093642;11244 16:52:03 INFO - PROCESS | 6409 | |3;mootools.html;1354.9729005419892;1383.8754512093913;1461.1744364434094;1572.48108124319;1637.2632315458047;6554.737810487575;7261.564306141629;7371.668274927628;7845.490043147199;7848.2544158304945;7649;7985.121636619967;7985.4010949178755;7985.760427187193;7986.1614530474335;2092.2049621143983;2138.0485683870684;2149.5271040371094;2151.6880052392394;2157.492989147549;2074.294739788472;2106.6734656128324;2150.569886022794;2156.493224092337;2186.7703891091446;2139.1336508713916;2145.6137895178863;2154.8922553872244;2160.2331172433796;2170.305502239284;2048.068129001301;2070.3271436782957;2076.408223656258;2085.103405535619;2094.319346212487;2042.9897850510802;2093.3824521766114;2093.57081798231;2096.75887272964;2102.3167470572125;7784.494007889526;7855.8821617675785;7859.56772377519;7864.331531819802;7876.842463150705;4375.321825117112;4431.512533621331;4506.346579745951;4508.571685689854;4536;2829.3068198291344;2874.4969630314613;2903.5499497577907;2961.7630589553;2969.524876019848;834.2932771255595;894.9520349268886;904.1410659873147;906.4697152165991;911.2118017914522;10899.618513351994;10941;10941;10980.341179529254;11079.778404431867;3826.6556009959236;3878.26313000529;4048.8582899598373;4085.571015043437;4107.199096176217;9202.079792020744;9318.347715659975;9318.86021709675;9321;9341.299402544837;4472.814704103415;4510.932336014962;4516.345129956138;4520.412346395014;4523.796429160696;3429.331280400298;3946.8159552134243;4049.3723472861166;4072.8778136655947;4112.876613701594;3533;3553.4136867417105;3624.492571040004;3633.6184700606586;3651.3610118229203;1123.2530367305812;1127.644791890552;1129.1192869561755;1131.1685910855515;1137.5108703257679;621.599068600759;653.1769969838039;656.4846595422666;731;747.1482509938675;5002.2496625506465;5091.821786237464;5186.429492755794;5189.844304670866;5218.321618189687;845.8266055458616;847.3009766942297;851.974440766778;861.6294993153004;891.3003292415423;3425.72594192464;3443.897952655126;3453.60283567393;3509.596396414394;3525.9118522036642;9703.563339649592;9867.901320986843;9942.254330925209;9946.502674866373;9982.301238913205;8984.640614375352;9878.604855805686;9881.209503239723;9888.703338899844;9893.258005649604;7071.681774320168;7328.230535793665;7385.3722433592675;7435;7469.514481558681;5187.377514698261;5337.9466205339;5415.2147938547905;5474.069408200695;5565.749541270734;8999.865002025106;9007.279417646441;9031.142041506046;9144.908550914406;9227.35408521397;8974.775630609287;9097.681581144892;9198.080191980749;9255.35212535116;9332;5932.110183472513;6570.605763654196;6610.867782644224;6776.15298087739;6776.390124888783;7454.030975973305;7465.7386991457215;7472.663730132048;7569.5079819811535;7586.506877053194;6578.276389597045;6641.435477984232;6725.327467253235;6896.172459304916;6901.102856628606;6720.1599800025;6731.360520750521;6814.420774234048;6865.176178858569;6904.206016307988;5991.2510936132985;6096.055111457731;6177.567570270038;6182.690865456799;6183.072539119168;4372.584604462571;4466.709663871838;4473.821047158077;4571.6799824012;4615.376924115201;4397.758123303249;4432.468103827561;4514.074614703912;4528.275475923968;4650.651201159859 16:52:03 INFO - PROCESS | 6409 | |4;prototype.html;288.0838932195618;289.29412234148674;295.51240453252126;295.9792814502986;296.9524876019835;4968.677035992658;5024.417308547814;5041.143005689032;5047.116754567955;5057.875692209276;4952.851414457572;4954.7274899880495;4963.751812409374;4972.801087956477;4976.8506944791625;3689.4281386385087;3749.43758436234;3794.203217324365;3861.9613803861885;3886.9805650971707;3860.8455661773496;3875.593062728401;3879.5344558653;3881.7088718346236;3886.747361421513;3849.2878817418728;3852.210296889131;3861.517310336208;3873.3661110444887;3882.534095908495;3760.9435858462143;3780.8487660493547;3856.382978723405;3866.4007078902814;3868.40039793831;3418.478776944261;3429.742769292288;3430.468277417004;3431.7083047940955;3433.1760377509468;4849.636277279183;4849.660523763338;4857.1742803723455;4860.392450943632;4861.513848615145;4402.713823601488;4416.1609294233995;4423.380726698265;4423.429682462712;4425.3847345718905;4875.804967801284;5149.588032957392;5173;5180.8963820723375;5184.351956005499;3656.926861462756;3657.817109144532;3660.9267814643827;3661.6521430464063;3663.761855479412;5363.597730170253;5383.838484845422;5404.648697834628;5419.59353048519;5423.511883930465;3560.5549306336707;3615.9276814463565;3629.383004889175;3673.9632603674154;3685.262947410529;3719.8698045568276;3726.4782930389765;3728.3289007978283;3730.421784623388;3732.122951106488;4277.465316835395;4282.721623094489;4296.935545966813;4317.676174286941;4319.870403887889;5068.087744206078;5197.350331208599;5204.8178313758835;5218.739063046833;5221.32122824038;1287.2984223598162;1312;1314.6910476038124;1316.880651446263;1317.440087962612;783.5925318834175;814.5886327404622;820.4420993724206;825.1500954017372;825.2572684583803;4331.956680433218;4341.066670665822;4499.392582001388;4512.571305725951;4523.050159466483;5345.38528069277;5359.356877174764;5365.919511207335;5399.541039011649;5410.215518749838;4532.320151977164;4537.500874903758;4546.749928753884;4560.703554268962;4572.314152877028;2706.3896981296098;2831.476176907279;2847.5477506471434;2854.715378079872;2859.37093839355;4988.7528117970505;5001.8499445016705;5008.949910500848;5021.748912554431;5025.246213068069;5235.476452354734;5369.167778994184;5396.519245086897;5408.648437851527;5477.561795056386;5000.574836171673;5011.84964451067;5029.17018691919;5032.6980381177245;5040.621953353513;5341.305630268041;5350.785968561214;5352.5450336721815;5354.554270346906;5356.78572857097;5024.680104996283;5131.024555546067;5246.3179786629025;5247.344081989751;5266.183741520071;4972.353594032753;4980.950190498049;4998.325226094431;5024.874378140576;5065.670731402447;3720.981395093007;3722.218334149859;3726.142987112925;3729.6270372962485;3737.850485980639;5008.824691135793;5302.969742995274;5373.140297552372;5373.704446255493;5382.43909266324;5264.31563896691;5264.8674038946765;5268.104422248303;5274.709890955881;5278.551323137576;5212.921806172834;5251.868703282448;5267.657602255841;5268.631195816256;5269.631125821155;4803.231482962709;5088.211327244283;5136.2552429898205;5179.715115668524;5189.740512974412;5017.54842064216;5141.557760064089;5232.790688372423;5249.826388021608;5257.658252213594;5113.51421614946;5123.666961647481;5125.743712814419;5134.460881607378;5151.742412879266 16:52:03 INFO - PROCESS | 6409 | |5;yui.html;569.9686517241552;592.49933805934;592.5940730599536;640.95513314068;653.1476423267634;11995.04039676826;13243.139195952257;13252.536161234359;13257.602271931846;13361.465541378333;13760.655983600414;14251.57245282643;14369.497067602637;14383;14410.639734006654;734.9559026458417;761;766.3830616353833;766.8082979255187;768.2356055724534;595.2975488923068;723.6200994477889;749.5502698380982;755.3654929858917;760.7831767946136;793.0681449297053;793.4961299574783;794.0907660728462;797.1709422200904;800.8718605023197;791.9485233459807;792.4056957282038;792.5086446403238;792.5522080024825;792.7066985215449;579.3974266762561;580.2109131581046;580.2427831679656;580.7154494297806;582.1587805620879;12533.43599538023;12578.119531632788;12578.308193049379;12602.74794504114;12638.241705497607;12799.168054076456;13095.934520327433;13283.335833208397;13301.268430236332;13402.530911418151;10275.48622568876;10371.636992705218;10512.52693628781;10622.840657390145;11103.222774405795;3227.4997375406615;3283.9835800821083;3290.8683652653867;3302.4055669979393;3303.520989456539;65859.3414065858;67349.3265067348;67448.66275668639;67818.66090669564;68033.65983170053;9015.63937442508;9091;9124.24439226652;9357.953210233905;9363.25093992479;17883.642327153386;17893.552661183574;18009.00950447738;18023.549411264823;18030.36893708714;6848.3494068063455;6880.346367095118;6885.277045910208;6911.550749201286;7251.0573625429415;3543.9291214175573;3654.744167908221;3660.5607327120915;3671.4492826076303;3736.271427071695;2862.1699707084713;2933.0170373054098;2955.3202763364548;2963.866626001835;2965.6506289638164;453.92283311837065;459.7245615773295;467.1497873869525;469.47887844492584;477.59404506169477;496.53077841440216;531.6225479909231;535.234614501267;536.7369988705506;564.6075977195892;7761.767146985487;7889.329407000355;8195.71315003972;8215.712450064219;8241.50550966944;490.7423602608659;528.5269683633127;555.2504119438726;557.7629507459313;557.8577462747055;3775.659640827522;3867.7292589518465;3929.941050884239;3930.4300876373336;4107.774072426046;75283;77320.29378971709;78637.60681196557;83984.74022889661;99089;74638.25361746422;75322;78139.21860781433;79624.60187699024;80805.59597201976;43561.56438435638;61945.38054619396;67295.66352168306;67945.66027169931;72066.279337207;7851.725189618336;8326.25063744266;8415.873761893454;8444.197801208875;8446.66213351459;42616.78691606522;43397.56602433935;43944.78027609841;44160;44701.55298447104;56897.43102569087;57304.1404378943;61681.691591541756;62233.688831555555;62483.813066542454;10727.946360268461;10756.623518176826;10911.127109831035;10939.56241750321;11105.444727763417;12110.152289339661;12337.938310308391;12968.157069790434;13188.604341869759;13311.600651980456;11479.942600287279;11605.129615278718;11737.061035117342;12211.633650990485;12222.633321000385;11091.778164436828;11237.887621123684;11480.196386252883;12079.094067945114;12091.516339346328;11013.339199648046;11091.556337746722;11178.496967636313;11413.372264525198;11711.590094346657;9400.670976515788;9648.276379271443;9997.850032249376;10323.432211228455;10334.483275836328;9296.767580810534;9465.432074075577;9679.370840895319;9995.20038396941;10013.899861001588 16:52:03 INFO - PROCESS | 6409 | __end_tp_report 16:52:03 INFO - PROCESS | 6409 | __start_cc_report 16:52:03 INFO - PROCESS | 6409 | _x_x_mozilla_cycle_collect,391 16:52:03 INFO - PROCESS | 6409 | __end_cc_report 16:52:03 INFO - PROCESS | 6409 | __startTimestamp1471909923937__endTimestamp 16:52:03 INFO - PROCESS | 6409 | 16:52:03 INFO - PROCESS | 6409 | ------- Summary: start ------- 16:52:03 INFO - PROCESS | 6409 | Number of tests: 6 16:52:03 INFO - PROCESS | 6409 | 16:52:03 INFO - PROCESS | 6409 | [#0] dojo.html Cycles:165 Average:4744.80 Median:4887.24 stddev:511.68 (10.5%) stddev-sans-first:485.15 16:52:03 INFO - PROCESS | 6409 | Values: 2613.0 2617.4 2633.6 2637.2 2656.2 4701.1 4794.7 4853.6 4884.9 4911.4 4715.0 4765.8 4780.1 4785.0 4799.1 4288.2 4436.5 4458.0 4544.9 4547.6 4492.1 4495.6 4529.3 4535.8 4544.4 4284.6 4350.7 4377.6 4394.6 4411.7 4419.1 4425.7 4432.0 4488.4 4500.2 4406.2 4424.1 4457.0 4464.9 4468.6 4705.0 4771.4 4781.3 4820.3 4836.8 5174.1 5174.9 5185.4 5200.9 5218.2 5069.6 5122.6 5139.7 5147.9 5168.9 4803.2 4824.9 4839.4 4839.7 4842.1 5255.2 5273.6 5281.0 5286.4 5300.7 4983.7 5058.6 5058.9 5064.6 5068.7 4976.8 4999.7 5069.7 5141.8 5207.3 5154.3 5164.8 5165.8 5167.7 5172.0 4909.9 5115.3 5122.3 5148.9 5152.8 4210.4 4233.0 4237.6 4294.7 4308.0 3743.5 3744.4 3758.8 3759.5 3764.1 4340.1 4342.9 4361.3 4363.0 4376.0 5103.6 5127.8 5178.6 5207.7 5218.5 4391.4 4427.1 4433.6 4435.8 4442.4 4528.5 4540.0 4651.3 4655.0 4663.3 4838.3 4846.6 4850.7 4876.3 4888.5 5182.0 5215.5 5223.7 5250.9 5271.9 4745.8 4783.1 4813.6 4922.9 4928.1 5026.3 5060.0 5074.1 5079.9 5138.1 5125.2 5145.3 5182.6 5212.7 5216.6 4791.7 4944.6 4951.2 4972.5 5067.4 4894.7 4898.2 4950.0 4969.6 4980.2 4939.3 4942.3 4952.6 4968.9 4974.5 4887.2 4959.5 4960.4 5095.5 5098.2 4902.2 4924.7 4930.7 4947.4 4955.0 16:52:03 INFO - PROCESS | 6409 | 16:52:03 INFO - PROCESS | 6409 | [#1] ext.html Cycles:180 Average:47450.68 Median:19553.12 stddev:88121.25 (450.7%) stddev-sans-first:88298.07 16:52:03 INFO - PROCESS | 6409 | Values: 544.4 544.5 551.8 558.2 563.0 34595.0 38601.0 38609.6 38642.4 38701.2 38978.2 39347.6 39502.6 39516.8 39572.0 7378.3 7601.2 7620.6 7623.1 7651.2 7480.8 7575.4 7583.4 7596.7 7625.1 7589.8 7615.9 7636.2 7658.8 7666.1 7589.1 7652.8 7665.3 7674.5 7679.9 7298.3 7373.6 7404.9 7415.4 7431.4 37244.3 37320.4 37548.4 37591.4 37827.4 2603.6 2608.9 2641.9 2675.5 2677.8 28229.9 28616.9 28892.6 29080.6 29883.6 3372.1 3466.5 3487.8 3534.8 3551.9 254247.0 256195.0 256375.0 257475.0 257518.0 49989.3 50172.7 50477.5 50486.2 50571.6 31979.4 53471.0 53685.2 53822.7 53941.5 12846.9 13409.5 13462.2 13524.3 13582.5 9982.2 10064.6 10115.0 10133.9 10150.0 17258.7 17437.2 17676.3 17708.8 17745.5 6643.7 6705.0 6815.0 6858.8 6927.5 774.8 834.8 935.5 990.0 990.7 27052.7 29066.9 31460.3 31494.8 31535.5 924.2 975.7 984.6 1001.8 1022.6 14661.6 14806.4 14986.3 14996.6 15098.4 385046.0 388639.0 389144.0 389646.0 390092.0 46791.0 47228.5 47260.5 47405.3 47802.5 1162.7 1172.3 1220.5 1225.0 1230.2 25397.5 26438.0 27340.7 27664.6 27727.7 41888.2 42638.6 42985.6 43084.4 43162.1 342370.0 342663.0 344258.0 345035.0 345271.0 24719.5 25076.5 25094.6 25113.1 25231.7 35216.5 35554.3 36023.6 36367.8 36851.4 30472.4 30582.5 30612.8 30724.8 31541.2 35433.5 35449.5 35763.0 35839.3 35975.5 26942.6 34636.5 34689.1 35174.0 35462.5 30669.2 32419.8 32469.8 32475.4 32698.3 25059.7 25254.4 25399.7 25618.0 26698.5 16:52:03 INFO - PROCESS | 6409 | 16:52:03 INFO - PROCESS | 6409 | [#2] jquery.html Cycles:180 Average:22900.35 Median:4601.51 stddev:58374.30 (1268.6%) stddev-sans-first:58513.49 16:52:03 INFO - PROCESS | 6409 | Values: 344.6 355.4 357.6 370.0 378.4 15849.1 16313.0 17351.0 17522.7 17607.6 15443.1 15752.8 16123.8 16488.6 16557.7 4301.7 4569.2 4593.8 4656.0 4658.1 4604.0 4610.9 4631.7 4640.0 4641.4 4546.1 4718.9 5066.5 5086.3 5092.9 5040.3 5053.8 5067.4 5077.0 5084.3 4498.4 4599.0 4766.7 4779.3 4801.4 11456.4 11679.8 11843.7 11856.7 11864.4 1832.7 1840.0 1860.6 1948.1 2160.3 8566.9 8606.3 8676.8 8917.3 9112.9 1653.7 1696.4 1702.9 1705.8 1709.3 63932.4 69911.3 70248.6 72442.6 73412.6 9862.4 9986.6 10091.3 10242.8 10323.6 13777.5 13795.9 13822.3 13838.3 13838.9 6811.4 6814.3 6970.8 7081.4 7152.7 6503.3 6561.5 6568.2 6801.9 6856.7 4153.2 4181.0 4189.4 4287.1 4343.1 1735.6 1813.6 1820.3 1852.8 1857.4 792.5 815.2 826.9 833.5 914.2 16819.3 17035.4 17310.9 17381.2 17599.4 800.0 816.0 841.9 851.0 902.0 9608.8 9752.6 9815.2 9970.2 10136.3 345904.0 349985.0 351908.0 352559.0 353297.0 78317.2 79261.6 79310.6 79363.0 80355.6 795.0 818.6 819.4 822.6 824.6 15076.5 15422.8 15509.8 15613.1 15840.5 35768.9 38009.6 38141.0 38383.0 39055.4 50850.2 51050.0 51273.7 51371.2 53674.5 7189.4 7214.8 7356.6 7466.6 7665.1 9971.4 11346.6 11402.7 11783.7 11894.8 7855.7 8206.0 9729.6 10186.4 10287.6 8539.6 9821.3 10314.4 10556.9 10772.5 5190.7 8305.0 10532.0 10683.5 10720.5 7477.9 7548.6 7570.2 7629.5 7713.7 7976.0 10578.3 10642.5 10910.5 11244.0 16:52:03 INFO - PROCESS | 6409 | 16:52:03 INFO - PROCESS | 6409 | [#3] mootools.html Cycles:180 Average:5121.15 Median:5278.13 stddev:2952.19 (55.9%) stddev-sans-first:2946.90 16:52:03 INFO - PROCESS | 6409 | Values: 1355.0 1383.9 1461.2 1572.5 1637.3 6554.7 7261.6 7371.7 7845.5 7848.3 7649.0 7985.1 7985.4 7985.8 7986.2 2092.2 2138.0 2149.5 2151.7 2157.5 2074.3 2106.7 2150.6 2156.5 2186.8 2139.1 2145.6 2154.9 2160.2 2170.3 2048.1 2070.3 2076.4 2085.1 2094.3 2043.0 2093.4 2093.6 2096.8 2102.3 7784.5 7855.9 7859.6 7864.3 7876.8 4375.3 4431.5 4506.3 4508.6 4536.0 2829.3 2874.5 2903.5 2961.8 2969.5 834.3 895.0 904.1 906.5 911.2 10899.6 10941.0 10941.0 10980.3 11079.8 3826.7 3878.3 4048.9 4085.6 4107.2 9202.1 9318.3 9318.9 9321.0 9341.3 4472.8 4510.9 4516.3 4520.4 4523.8 3429.3 3946.8 4049.4 4072.9 4112.9 3533.0 3553.4 3624.5 3633.6 3651.4 1123.3 1127.6 1129.1 1131.2 1137.5 621.6 653.2 656.5 731.0 747.1 5002.2 5091.8 5186.4 5189.8 5218.3 845.8 847.3 852.0 861.6 891.3 3425.7 3443.9 3453.6 3509.6 3525.9 9703.6 9867.9 9942.3 9946.5 9982.3 8984.6 9878.6 9881.2 9888.7 9893.3 7071.7 7328.2 7385.4 7435.0 7469.5 5187.4 5337.9 5415.2 5474.1 5565.7 8999.9 9007.3 9031.1 9144.9 9227.4 8974.8 9097.7 9198.1 9255.4 9332.0 5932.1 6570.6 6610.9 6776.2 6776.4 7454.0 7465.7 7472.7 7569.5 7586.5 6578.3 6641.4 6725.3 6896.2 6901.1 6720.2 6731.4 6814.4 6865.2 6904.2 5991.3 6096.1 6177.6 6182.7 6183.1 4372.6 4466.7 4473.8 4571.7 4615.4 4397.8 4432.5 4514.1 4528.3 4650.7 16:52:03 INFO - PROCESS | 6409 | 16:52:03 INFO - PROCESS | 6409 | [#4] prototype.html Cycles:180 Average:4293.26 Median:4970.52 stddev:1264.20 (25.4%) stddev-sans-first:1231.48 16:52:03 INFO - PROCESS | 6409 | Values: 288.1 289.3 295.5 296.0 297.0 4968.7 5024.4 5041.1 5047.1 5057.9 4952.9 4954.7 4963.8 4972.8 4976.9 3689.4 3749.4 3794.2 3862.0 3887.0 3860.8 3875.6 3879.5 3881.7 3886.7 3849.3 3852.2 3861.5 3873.4 3882.5 3760.9 3780.8 3856.4 3866.4 3868.4 3418.5 3429.7 3430.5 3431.7 3433.2 4849.6 4849.7 4857.2 4860.4 4861.5 4402.7 4416.2 4423.4 4423.4 4425.4 4875.8 5149.6 5173.0 5180.9 5184.4 3656.9 3657.8 3660.9 3661.7 3663.8 5363.6 5383.8 5404.6 5419.6 5423.5 3560.6 3615.9 3629.4 3674.0 3685.3 3719.9 3726.5 3728.3 3730.4 3732.1 4277.5 4282.7 4296.9 4317.7 4319.9 5068.1 5197.4 5204.8 5218.7 5221.3 1287.3 1312.0 1314.7 1316.9 1317.4 783.6 814.6 820.4 825.2 825.3 4332.0 4341.1 4499.4 4512.6 4523.1 5345.4 5359.4 5365.9 5399.5 5410.2 4532.3 4537.5 4546.7 4560.7 4572.3 2706.4 2831.5 2847.5 2854.7 2859.4 4988.8 5001.8 5008.9 5021.7 5025.2 5235.5 5369.2 5396.5 5408.6 5477.6 5000.6 5011.8 5029.2 5032.7 5040.6 5341.3 5350.8 5352.5 5354.6 5356.8 5024.7 5131.0 5246.3 5247.3 5266.2 4972.4 4981.0 4998.3 5024.9 5065.7 3721.0 3722.2 3726.1 3729.6 3737.9 5008.8 5303.0 5373.1 5373.7 5382.4 5264.3 5264.9 5268.1 5274.7 5278.6 5212.9 5251.9 5267.7 5268.6 5269.6 4803.2 5088.2 5136.3 5179.7 5189.7 5017.5 5141.6 5232.8 5249.8 5257.7 5113.5 5123.7 5125.7 5134.5 5151.7 16:52:03 INFO - PROCESS | 6409 | 16:52:03 INFO - PROCESS | 6409 | [#5] yui.html Cycles:180 Average:16833.41 Median:512.53 stddev:23158.66 (4518.5%) stddev-sans-first:23191.42 16:52:03 INFO - PROCESS | 6409 | Values: 570.0 592.5 592.6 641.0 653.1 11995.0 13243.1 13252.5 13257.6 13361.5 13760.7 14251.6 14369.5 14383.0 14410.6 735.0 761.0 766.4 766.8 768.2 595.3 723.6 749.6 755.4 760.8 793.1 793.5 794.1 797.2 800.9 791.9 792.4 792.5 792.6 792.7 579.4 580.2 580.2 580.7 582.2 12533.4 12578.1 12578.3 12602.7 12638.2 12799.2 13095.9 13283.3 13301.3 13402.5 10275.5 10371.6 10512.5 10622.8 11103.2 3227.5 3284.0 3290.9 3302.4 3303.5 65859.3 67349.3 67448.7 67818.7 68033.7 9015.6 9091.0 9124.2 9358.0 9363.3 17883.6 17893.6 18009.0 18023.5 18030.4 6848.3 6880.3 6885.3 6911.6 7251.1 3543.9 3654.7 3660.6 3671.4 3736.3 2862.2 2933.0 2955.3 2963.9 2965.7 453.9 459.7 467.1 469.5 477.6 496.5 531.6 535.2 536.7 564.6 7761.8 7889.3 8195.7 8215.7 8241.5 490.7 528.5 555.3 557.8 557.9 3775.7 3867.7 3929.9 3930.4 4107.8 75283.0 77320.3 78637.6 83984.7 99089.0 74638.3 75322.0 78139.2 79624.6 80805.6 43561.6 61945.4 67295.7 67945.7 72066.3 7851.7 8326.3 8415.9 8444.2 8446.7 42616.8 43397.6 43944.8 44160.0 44701.6 56897.4 57304.1 61681.7 62233.7 62483.8 10727.9 10756.6 10911.1 10939.6 11105.4 12110.2 12337.9 12968.2 13188.6 13311.6 11479.9 11605.1 11737.1 12211.6 12222.6 11091.8 11237.9 11480.2 12079.1 12091.5 11013.3 11091.6 11178.5 11413.4 11711.6 9400.7 9648.3 9997.9 10323.4 10334.5 9296.8 9465.4 9679.4 9995.2 10013.9 16:52:03 INFO - PROCESS | 6409 | -------- Summary: end -------- 16:52:03 INFO - PROCESS | 6409 | 16:52:04 INFO - TEST-INFO | 6409: exit 0 16:52:04 INFO - TEST-OK | dromaeo_css | took 1118622ms 16:52:04 INFO - TEST-START | kraken 16:52:04 INFO - operating with platform_type : linux_ 16:52:04 INFO - Initialising browser for kraken test... 16:52:04 INFO - TEST-INFO | started process 6765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUlsNc3/profile http://localhost:50306/getInfo.html) 16:52:09 INFO - PROCESS | 6765 | __metrics Screen width/height:1600/1200 16:52:09 INFO - PROCESS | 6765 | colorDepth:24 16:52:09 INFO - PROCESS | 6765 | Browser inner width/height: 1024/697 16:52:09 INFO - PROCESS | 6765 | __metrics 16:52:10 ERROR - PROCESS | 6765 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 16:52:11 INFO - TEST-INFO | 6765: exit 0 16:52:11 INFO - Browser initialized. 16:52:11 INFO - Running cycle 1/1 for kraken test... 16:52:11 INFO - TEST-INFO | started process 6884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUlsNc3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:52:23 INFO - PROCESS | 6884 | RSS: Main: 187363328 16:52:23 INFO - PROCESS | 6884 | 16:52:26 INFO - PROCESS | 6884 | Cycle 1(1): loaded http://localhost:50306/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50306/tests/kraken/driver.html?testName=audio-beat-detection) 16:52:27 INFO - PROCESS | 6884 | RSS: Main: 200564736 16:52:27 INFO - PROCESS | 6884 | 16:52:30 INFO - PROCESS | 6884 | Cycle 1(1): loaded http://localhost:50306/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50306/tests/kraken/driver.html?testName=audio-dft) 16:52:31 INFO - PROCESS | 6884 | RSS: Main: 199311360 16:52:31 INFO - PROCESS | 6884 | 16:52:34 INFO - PROCESS | 6884 | Cycle 1(1): loaded http://localhost:50306/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50306/tests/kraken/driver.html?testName=audio-fft) 16:52:34 INFO - PROCESS | 6884 | RSS: Main: 196128768 16:52:34 INFO - PROCESS | 6884 | 16:52:36 INFO - PROCESS | 6884 | Cycle 1(1): loaded http://localhost:50306/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50306/tests/kraken/driver.html?testName=audio-oscillator) 16:52:37 INFO - PROCESS | 6884 | RSS: Main: 196681728 16:52:37 INFO - PROCESS | 6884 | 16:52:39 INFO - PROCESS | 6884 | Cycle 1(1): loaded http://localhost:50306/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50306/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:52:40 INFO - PROCESS | 6884 | RSS: Main: 196849664 16:52:40 INFO - PROCESS | 6884 | 16:52:43 INFO - PROCESS | 6884 | Cycle 1(1): loaded http://localhost:50306/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50306/tests/kraken/driver.html?testName=imaging-darkroom) 16:52:44 INFO - PROCESS | 6884 | RSS: Main: 197099520 16:52:44 INFO - PROCESS | 6884 | 16:52:47 INFO - PROCESS | 6884 | Cycle 1(1): loaded http://localhost:50306/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50306/tests/kraken/driver.html?testName=imaging-desaturate) 16:52:48 INFO - PROCESS | 6884 | RSS: Main: 194629632 16:52:48 INFO - PROCESS | 6884 | 16:52:51 INFO - PROCESS | 6884 | Cycle 1(1): loaded http://localhost:50306/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50306/tests/kraken/driver.html?testName=json-parse-financial) 16:52:52 INFO - PROCESS | 6884 | RSS: Main: 195715072 16:52:52 INFO - PROCESS | 6884 | 16:52:53 INFO - PROCESS | 6884 | Cycle 1(1): loaded http://localhost:50306/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50306/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:52:54 INFO - PROCESS | 6884 | RSS: Main: 195911680 16:52:54 INFO - PROCESS | 6884 | 16:52:56 INFO - PROCESS | 6884 | Cycle 1(1): loaded http://localhost:50306/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50306/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:52:57 INFO - PROCESS | 6884 | RSS: Main: 196108288 16:52:57 INFO - PROCESS | 6884 | 16:52:59 INFO - PROCESS | 6884 | Cycle 1(1): loaded http://localhost:50306/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50306/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:53:00 INFO - PROCESS | 6884 | RSS: Main: 196415488 16:53:00 INFO - PROCESS | 6884 | 16:53:03 INFO - PROCESS | 6884 | Cycle 1(1): loaded http://localhost:50306/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:53:03 INFO - PROCESS | 6884 | RSS: Main: 196571136 16:53:03 INFO - PROCESS | 6884 | 16:53:06 INFO - PROCESS | 6884 | Cycle 1(1): loaded http://localhost:50306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:53:07 INFO - PROCESS | 6884 | RSS: Main: 196308992 16:53:07 INFO - PROCESS | 6884 | 16:53:09 INFO - PROCESS | 6884 | Cycle 1(1): loaded http://localhost:50306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50306/tests/kraken/driver.html?testName=ai-astar) 16:53:09 INFO - PROCESS | 6884 | RSS: Main: 199217152 16:53:09 INFO - PROCESS | 6884 | 16:53:09 INFO - PROCESS | 6884 | __start_tp_report 16:53:09 INFO - PROCESS | 6884 | _x_x_mozilla_page_load 16:53:09 INFO - PROCESS | 6884 | _x_x_mozilla_page_load_details 16:53:09 INFO - PROCESS | 6884 | |i|pagename|runs| 16:53:09 INFO - PROCESS | 6884 | |0;ai-astar;112;117;113;116;114;114;120;117;137;116 16:53:09 INFO - PROCESS | 6884 | |1;audio-beat-detection;156;125;156;194;129;157;158;128;188;127 16:53:09 INFO - PROCESS | 6884 | |2;audio-dft;175;165;164;166;167;166;166;168;168;166 16:53:09 INFO - PROCESS | 6884 | |3;audio-fft;81;79;78;186;79;79;79;84;163;79 16:53:09 INFO - PROCESS | 6884 | |4;audio-oscillator;89;89;139;90;88;92;140;88;88;129 16:53:09 INFO - PROCESS | 6884 | |5;imaging-gaussian-blur;119;119;119;119;119;122;119;139;119;118 16:53:09 INFO - PROCESS | 6884 | |6;imaging-darkroom;149;149;149;149;148;149;151;148;148;151 16:53:09 INFO - PROCESS | 6884 | |7;imaging-desaturate;95;98;97;97;95;97;97;98;96;97 16:53:09 INFO - PROCESS | 6884 | |8;json-parse-financial;66;69;67;69;69;67;69;69;68;67 16:53:09 INFO - PROCESS | 6884 | |9;json-stringify-tinderbox;72;74;70;74;70;74;72;74;70;73 16:53:09 INFO - PROCESS | 6884 | |10;stanford-crypto-aes;92;85;89;85;101;94;85;87;86;96 16:53:09 INFO - PROCESS | 6884 | |11;stanford-crypto-ccm;143;141;145;141;145;146;151;158;160;140 16:53:09 INFO - PROCESS | 6884 | |12;stanford-crypto-pbkdf2;184;189;181;175;178;178;189;184;177;179 16:53:09 INFO - PROCESS | 6884 | |13;stanford-crypto-sha256-iterative;71;71;73;75;72;72;72;73;74;74 16:53:09 INFO - PROCESS | 6884 | __end_tp_report 16:53:09 INFO - PROCESS | 6884 | __start_cc_report 16:53:09 INFO - PROCESS | 6884 | _x_x_mozilla_cycle_collect,938 16:53:09 INFO - PROCESS | 6884 | __end_cc_report 16:53:09 INFO - PROCESS | 6884 | __startTimestamp1471909989629__endTimestamp 16:53:09 INFO - PROCESS | 6884 | 16:53:09 INFO - PROCESS | 6884 | ------- Summary: start ------- 16:53:09 INFO - PROCESS | 6884 | Number of tests: 14 16:53:09 INFO - PROCESS | 6884 | 16:53:09 INFO - PROCESS | 6884 | [#0] ai-astar Cycles:10 Average:117.60 Median:116.50 stddev:7.20 (6.2%) stddev-sans-first:7.34 16:53:09 INFO - PROCESS | 6884 | Values: 112.0 117.0 113.0 116.0 114.0 114.0 120.0 117.0 137.0 116.0 16:53:09 INFO - PROCESS | 6884 | 16:53:09 INFO - PROCESS | 6884 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:156.50 stddev:24.97 (16.0%) stddev-sans-first:26.44 16:53:09 INFO - PROCESS | 6884 | Values: 156.0 125.0 156.0 194.0 129.0 157.0 158.0 128.0 188.0 127.0 16:53:09 INFO - PROCESS | 6884 | 16:53:09 INFO - PROCESS | 6884 | [#2] audio-dft Cycles:10 Average:167.10 Median:166.50 stddev:3.03 (1.8%) stddev-sans-first:1.30 16:53:09 INFO - PROCESS | 6884 | Values: 175.0 165.0 164.0 166.0 167.0 166.0 166.0 168.0 168.0 166.0 16:53:09 INFO - PROCESS | 6884 | 16:53:09 INFO - PROCESS | 6884 | [#3] audio-fft Cycles:10 Average:98.70 Median:79.00 stddev:40.35 (51.1%) stddev-sans-first:42.29 16:53:09 INFO - PROCESS | 6884 | Values: 81.0 79.0 78.0 186.0 79.0 79.0 79.0 84.0 163.0 79.0 16:53:09 INFO - PROCESS | 6884 | 16:53:09 INFO - PROCESS | 6884 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:88.50 stddev:22.85 (25.8%) stddev-sans-first:23.65 16:53:09 INFO - PROCESS | 6884 | Values: 89.0 89.0 139.0 90.0 88.0 92.0 140.0 88.0 88.0 129.0 16:53:09 INFO - PROCESS | 6884 | 16:53:09 INFO - PROCESS | 6884 | [#5] imaging-gaussian-blur Cycles:10 Average:121.20 Median:119.00 stddev:6.34 (5.3%) stddev-sans-first:6.67 16:53:09 INFO - PROCESS | 6884 | Values: 119.0 119.0 119.0 119.0 119.0 122.0 119.0 139.0 119.0 118.0 16:53:09 INFO - PROCESS | 6884 | 16:53:09 INFO - PROCESS | 6884 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 16:53:09 INFO - PROCESS | 6884 | Values: 149.0 149.0 149.0 149.0 148.0 149.0 151.0 148.0 148.0 151.0 16:53:09 INFO - PROCESS | 6884 | 16:53:09 INFO - PROCESS | 6884 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:1.06 (1.1%) stddev-sans-first:0.93 16:53:09 INFO - PROCESS | 6884 | Values: 95.0 98.0 97.0 97.0 95.0 97.0 97.0 98.0 96.0 97.0 16:53:09 INFO - PROCESS | 6884 | 16:53:09 INFO - PROCESS | 6884 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:69.00 stddev:1.15 (1.7%) stddev-sans-first:0.97 16:53:09 INFO - PROCESS | 6884 | Values: 66.0 69.0 67.0 69.0 69.0 67.0 69.0 69.0 68.0 67.0 16:53:09 INFO - PROCESS | 6884 | 16:53:09 INFO - PROCESS | 6884 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:73.50 stddev:1.77 (2.4%) stddev-sans-first:1.87 16:53:09 INFO - PROCESS | 6884 | Values: 72.0 74.0 70.0 74.0 70.0 74.0 72.0 74.0 70.0 73.0 16:53:09 INFO - PROCESS | 6884 | 16:53:09 INFO - PROCESS | 6884 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:88.00 stddev:5.56 (6.3%) stddev-sans-first:5.85 16:53:09 INFO - PROCESS | 6884 | Values: 92.0 85.0 89.0 85.0 101.0 94.0 85.0 87.0 86.0 96.0 16:53:09 INFO - PROCESS | 6884 | 16:53:09 INFO - PROCESS | 6884 | [#11] stanford-crypto-ccm Cycles:10 Average:147.00 Median:145.50 stddev:7.09 (4.9%) stddev-sans-first:7.37 16:53:09 INFO - PROCESS | 6884 | Values: 143.0 141.0 145.0 141.0 145.0 146.0 151.0 158.0 160.0 140.0 16:53:09 INFO - PROCESS | 6884 | 16:53:09 INFO - PROCESS | 6884 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.40 Median:182.50 stddev:4.93 (2.7%) stddev-sans-first:5.13 16:53:09 INFO - PROCESS | 6884 | Values: 184.0 189.0 181.0 175.0 178.0 178.0 189.0 184.0 177.0 179.0 16:53:09 INFO - PROCESS | 6884 | 16:53:09 INFO - PROCESS | 6884 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:73.00 stddev:1.34 (1.8%) stddev-sans-first:1.27 16:53:09 INFO - PROCESS | 6884 | Values: 71.0 71.0 73.0 75.0 72.0 72.0 72.0 73.0 74.0 74.0 16:53:09 INFO - PROCESS | 6884 | -------- Summary: end -------- 16:53:09 INFO - PROCESS | 6884 | 16:53:10 INFO - TEST-INFO | 6884: exit 0 16:53:10 INFO - TEST-OK | kraken | took 65937ms 16:53:10 INFO - SUITE-END | took 1184s 16:53:11 INFO - Completed test suite (00:19:44) 16:53:11 INFO - javascript benchmark 16:53:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6304.896311694581, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2613.007057318219, 2617.4110825064363, 2633.6181253718205, 2637.208837348795, 2656.189862092064, 4701.059788042388, 4794.688345257556, 4853.587445067169, 4884.926726099111, 4911.435184953727, 4714.9528504714945, 4765.785539650716, 4780.067886762083, 4785.042991401725, 4799.112164249616, 4288.185244803493, 4436.5119836818, 4457.977710111445, 4544.9091018179615, 4547.63618910488, 4492.0791237796175, 4495.640348772106, 4529.320601909723, 4535.7958891849785, 4544.386507821451, 4284.61438470536, 4350.7172033818015, 4377.606015458592, 4394.648428125743, 4411.669124815619, 4419.138268037702, 4425.712328698624, 4431.977840110779, 4488.394066800973, 4500.234960056799, 4406.184855801687, 4424.137293227822, 4457.0194557197365, 4464.933026004613, 4468.597826195625, 4705.035467729142, 4771.355866957951, 4781.282807578891, 4820.312031802472, 4836.758162091916, 5174.068667639824, 5174.948250517485, 5185.429602743695, 5200.869978250536, 5218.243354713583, 5069.569086627641, 5122.641415100945, 5139.665921715076, 5147.948520514784, 5168.948310516885, 4803.159447096744, 4824.879378015543, 4839.370881785346, 4839.733814640158, 4842.055799119208, 5255.237990491434, 5273.630845840831, 5281.049411105961, 5286.444923283, 5300.681959082467, 4983.651144419929, 5058.570021548136, 5058.924116138261, 5064.645474816727, 5068.746562671851, 4976.776045077981, 4999.65002449825, 5069.746512674352, 5141.8457446275925, 5207.3490813648295, 5154.252633368215, 5164.767585458663, 5165.793368265303, 5167.741612919339, 5171.974140129275, 4909.901801963941, 5115.283860259567, 5122.308488354024, 5148.9485105149215, 5152.845414637567, 4210.389493523422, 4233.047564298008, 4237.555056719062, 4294.656427485794, 4307.978460107679, 3743.47591337213, 3744.400895856704, 3758.8496460141837, 3759.4924685167152, 3764.134249122717, 4340.110277393127, 4342.891427714332, 4361.280388735887, 4363.0401311712, 4375.971646663095, 5103.591712662978, 5127.794888204505, 5178.6116041297055, 5207.739613019334, 5218.530332270114, 4391.363252328459, 4427.114577084531, 4433.645308375322, 4435.844745433958, 4442.444694413199, 4528.50186479487, 4539.977300113478, 4651.279051746985, 4654.95263565695, 4663.27719203524, 4838.298446725275, 4846.636502262415, 4850.733209673432, 4876.341693871282, 4888.5355891189565, 5181.974090129525, 5215.45237750046, 5223.738813059256, 5250.868728281824, 5271.894562108813, 4745.762711864462, 4783.091212669721, 4813.614910807197, 4922.8769280768265, 4928.112939670894, 5026.321446604661, 5060.0, 5074.137396642506, 5079.9238011429115, 5138.100832354397, 5125.205593133071, 5145.253938179018, 5182.6113041521285, 5212.661177023481, 5216.634835561475, 4791.688540244873, 4944.629152813482, 4951.207806750903, 4972.5276098770555, 5067.442581316126, 4894.706317620954, 4898.21628539432, 4949.97525012387, 4969.552740253394, 4980.153373926369, 4939.333190019302, 4942.332785073969, 4952.579030782424, 4968.850934471971, 4974.452810190948, 4887.242477416006, 4959.454460009469, 4960.355153829979, 5095.490450954875, 5098.158803797481, 4902.2156454967035, 4924.679895806761, 4930.654854160318, 4947.431045429822, 4955.033768415268], "value": 4710.953662954814, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.3630951786412, 544.4528249109645, 551.762742020931, 558.2073455692915, 562.9634073785206, 34595.0, 38601.0, 38609.613903860954, 38642.42036369457, 38701.225975480476, 38978.22043559127, 39347.606523934825, 39502.60497395025, 39516.80241598788, 39572.0, 7378.262173782619, 7601.23987601241, 7620.618969051553, 7623.123340815821, 7651.234876512332, 7480.812979675497, 7575.431842611826, 7583.355414789722, 7596.696132154707, 7625.084989801232, 7589.810254743648, 7615.885761713579, 7636.198199189089, 7658.770236892902, 7666.080070391561, 7589.089309282866, 7652.808679782995, 7665.271799179069, 7674.46278760487, 7679.884801727979, 7298.270172982712, 7373.594452305121, 7404.851902961911, 7415.40676745859, 7431.442641801887, 37244.255114897824, 37320.44019339685, 37548.43677344842, 37591.436128458095, 37827.4325885112, 2603.570410882202, 2608.9167909126813, 2641.867906604681, 2675.5184066867955, 2677.799165062628, 28229.85885070582, 28616.85691571529, 28892.566611500843, 29080.563791543143, 29883.5517467236, 3372.104047223434, 3466.5146879436898, 3487.761844545201, 3534.7525673202886, 3551.94672079919, 254247.0, 256195.0, 256375.0, 257475.0, 257518.0, 49989.25016124761, 50172.74913625408, 50477.49522504801, 50486.24270635944, 50571.644245813906, 31979.36041279208, 53471.0, 53685.1947220792, 53822.730886345315, 53941.46058539443, 12846.871531284567, 13409.463621455032, 13462.192268463923, 13524.256165910772, 13582.524611638546, 9982.201423886072, 10064.647737329158, 10115.0, 10133.949330253448, 10150.03574660406, 17258.741118883227, 17437.21532531039, 17676.292948281924, 17708.822911770716, 17745.46763597094, 6643.734250630017, 6704.966475167593, 6814.965925170342, 6858.759943402057, 6927.515073944775, 774.7753151586089, 834.8163404051099, 935.5369092299355, 989.995154917759, 990.7404638738614, 27052.729472705414, 29066.854665726536, 31460.30431942061, 31494.842525787226, 31535.526967095513, 924.242121460396, 975.7121649113386, 984.5717113055844, 1001.7746007148479, 1022.5551884930079, 14661.633459163606, 14806.407743690132, 14986.250687465583, 14996.62508437276, 15098.39606415731, 385046.0, 388639.0, 389144.0, 389646.0, 390092.0, 46791.0, 47228.52771472241, 47260.5273947263, 47405.28892066553, 47802.5219747805, 1162.6686394377562, 1172.284906207213, 1220.45079714129, 1224.969375765613, 1230.21266389509, 25397.492050159264, 26438.0, 27340.726592734612, 27664.58503122495, 27727.72272277332, 41888.16223675571, 42638.57361426346, 42985.57014429941, 43084.35373469463, 43162.1367572653, 342370.0, 342663.0, 344258.0, 345035.0, 345271.0, 24719.505609887343, 25076.498470030863, 25094.62358064667, 25113.121040763486, 25231.74768252294, 35216.471752923215, 35554.28891422209, 36023.639763603074, 36367.818160909024, 36851.447228292134, 30472.39055218839, 30582.541261881535, 30612.846935765177, 30724.84637576798, 31541.211469713442, 35433.46849797203, 35449.518533702394, 35763.0, 35839.28321433609, 35975.460368093976, 26942.59586106171, 34636.480452792726, 34689.13277168091, 35174.0, 35462.46806297856, 30669.23326916756, 32419.83790081129, 32469.837650811594, 32475.350492989535, 32698.34603307968, 25059.749402505742, 25254.368640784127, 25399.746002540476, 25617.97528098855, 26698.466030679665], "value": 17002.72322800576, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.5882170805888, 355.3638986214675, 357.6459305287765, 369.95375578052744, 378.3662365537725, 15849.12829794361, 16313.0, 17351.0, 17522.737158942626, 17607.647847043052, 15443.073415595072, 15752.76370854438, 16123.83876161238, 16488.58778530537, 16557.66884662306, 4301.698881078326, 4569.200389931765, 4593.770311484429, 4656.022235330584, 4658.138244424776, 4604.033153037866, 4610.9308360374625, 4631.652626053043, 4639.976800116012, 4641.35021097045, 4546.090781843644, 4718.882027949295, 5066.518680725325, 5086.262491938666, 5092.872678183038, 5040.319556859814, 5053.823116190934, 5067.417247016603, 5076.974615126937, 5084.262781896641, 4498.415206023229, 4598.977005114986, 4766.690165139289, 4779.307000484945, 4801.423829140525, 11456.369899655516, 11679.766404671944, 11843.703907402298, 11856.703582410422, 11864.406779660982, 1832.7159290310024, 1839.9908000460046, 1860.618573192506, 1948.1428171604448, 2160.2547121243147, 8566.914330856674, 8606.31149508038, 8676.783080422976, 8917.286617070618, 9112.908870911273, 1653.7271350227197, 1696.4401747423321, 1702.9063401512913, 1705.7611934329204, 1709.2735587375316, 63932.36067639311, 69911.30088699098, 70248.6487567559, 72442.63778681072, 73412.63293683497, 9862.408255504693, 9986.550605222783, 10091.293609447268, 10242.846357304647, 10323.63867264642, 13777.517786877412, 13795.931020344835, 13822.308884555932, 13838.30808459573, 13838.930805345908, 6811.352921472452, 6814.284500127515, 6970.756023539152, 7081.433485321162, 7152.678129484186, 6503.28463868974, 6561.507886908501, 6568.244651865097, 6801.9319806801295, 6856.725730970805, 4153.231652144363, 4181.0, 4189.371594260885, 4287.121140166259, 4343.087951530214, 1735.6008118132647, 1813.619139980619, 1820.2718912434866, 1852.8147185281634, 1857.4334827877626, 792.528445574882, 815.2377527012144, 826.9379796515285, 833.5207255827924, 914.2366124286295, 16819.327226910787, 17035.40376086831, 17310.913445432692, 17381.217845196996, 17599.38402155944, 799.9880001799978, 815.9918400815916, 841.87792770048, 850.9957450212834, 901.977450563728, 9608.75978100539, 9752.561134748954, 9815.165710914509, 9970.202383809423, 10136.341137826017, 345904.0, 349985.0, 351907.96184076177, 352559.0, 353297.0, 78317.21682783213, 79261.60369198117, 79310.6034469824, 79363.0, 80355.59822200969, 794.9721759738497, 818.55388813097, 819.4182130687279, 822.5928165558087, 824.6000689665508, 15076.547703568911, 15422.845771542141, 15509.76735348948, 15613.14127722986, 15840.524784256491, 35768.853868767954, 38009.61990380061, 38141.0, 38383.04042398962, 39055.437782488385, 50850.23724644207, 51050.0, 51273.743631281606, 51371.2294315593, 53674.46325536694, 7189.424846012411, 7214.783556493314, 7356.632168391666, 7466.626668666437, 7665.080190377191, 9971.40171589707, 11346.602868899548, 11402.714932126763, 11783.705407364885, 11894.821577676168, 7855.685772569033, 8206.0, 9729.562169702238, 10186.439745814052, 10287.588496460057, 8539.615717292612, 9821.263405244492, 10314.381137131797, 10556.947215263874, 10772.461376930965, 5190.714510701948, 8305.044919834296, 10532.0, 10683.5192416343, 10720.46797588499, 7477.925220747723, 7548.584827834522, 7570.242975702386, 7629.504082234637, 7713.730019449293, 7976.0, 10578.259521833397, 10642.521086550969, 10910.509027093642, 11244.0], "value": 7795.164518822511, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.9729005419892, 1383.8754512093913, 1461.1744364434094, 1572.48108124319, 1637.2632315458047, 6554.737810487575, 7261.564306141629, 7371.668274927628, 7845.490043147199, 7848.2544158304945, 7649.0, 7985.121636619967, 7985.4010949178755, 7985.760427187193, 7986.1614530474335, 2092.2049621143983, 2138.0485683870684, 2149.5271040371094, 2151.6880052392394, 2157.492989147549, 2074.294739788472, 2106.6734656128324, 2150.569886022794, 2156.493224092337, 2186.7703891091446, 2139.1336508713916, 2145.6137895178863, 2154.8922553872244, 2160.2331172433796, 2170.305502239284, 2048.068129001301, 2070.3271436782957, 2076.408223656258, 2085.103405535619, 2094.319346212487, 2042.9897850510802, 2093.3824521766114, 2093.57081798231, 2096.75887272964, 2102.3167470572125, 7784.494007889526, 7855.8821617675785, 7859.56772377519, 7864.331531819802, 7876.842463150705, 4375.321825117112, 4431.512533621331, 4506.346579745951, 4508.571685689854, 4536.0, 2829.3068198291344, 2874.4969630314613, 2903.5499497577907, 2961.7630589553, 2969.524876019848, 834.2932771255595, 894.9520349268886, 904.1410659873147, 906.4697152165991, 911.2118017914522, 10899.618513351994, 10941.0, 10941.0, 10980.341179529254, 11079.778404431867, 3826.6556009959236, 3878.26313000529, 4048.8582899598373, 4085.571015043437, 4107.199096176217, 9202.079792020744, 9318.347715659975, 9318.86021709675, 9321.0, 9341.299402544837, 4472.814704103415, 4510.932336014962, 4516.345129956138, 4520.412346395014, 4523.796429160696, 3429.331280400298, 3946.8159552134243, 4049.3723472861166, 4072.8778136655947, 4112.876613701594, 3533.0, 3553.4136867417105, 3624.492571040004, 3633.6184700606586, 3651.3610118229203, 1123.2530367305812, 1127.644791890552, 1129.1192869561755, 1131.1685910855515, 1137.5108703257679, 621.599068600759, 653.1769969838039, 656.4846595422666, 731.0, 747.1482509938675, 5002.2496625506465, 5091.821786237464, 5186.429492755794, 5189.844304670866, 5218.321618189687, 845.8266055458616, 847.3009766942297, 851.974440766778, 861.6294993153004, 891.3003292415423, 3425.72594192464, 3443.897952655126, 3453.60283567393, 3509.596396414394, 3525.9118522036642, 9703.563339649592, 9867.901320986843, 9942.254330925209, 9946.502674866373, 9982.301238913205, 8984.640614375352, 9878.604855805686, 9881.209503239723, 9888.703338899844, 9893.258005649604, 7071.681774320168, 7328.230535793665, 7385.3722433592675, 7435.0, 7469.514481558681, 5187.377514698261, 5337.9466205339, 5415.2147938547905, 5474.069408200695, 5565.749541270734, 8999.865002025106, 9007.279417646441, 9031.142041506046, 9144.908550914406, 9227.35408521397, 8974.775630609287, 9097.681581144892, 9198.080191980749, 9255.35212535116, 9332.0, 5932.110183472513, 6570.605763654196, 6610.867782644224, 6776.15298087739, 6776.390124888783, 7454.030975973305, 7465.7386991457215, 7472.663730132048, 7569.5079819811535, 7586.506877053194, 6578.276389597045, 6641.435477984232, 6725.327467253235, 6896.172459304916, 6901.102856628606, 6720.1599800025, 6731.360520750521, 6814.420774234048, 6865.176178858569, 6904.206016307988, 5991.2510936132985, 6096.055111457731, 6177.567570270038, 6182.690865456799, 6183.072539119168, 4372.584604462571, 4466.709663871838, 4473.821047158077, 4571.6799824012, 4615.376924115201, 4397.758123303249, 4432.468103827561, 4514.074614703912, 4528.275475923968, 4650.651201159859], "value": 4073.5375773466426, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.0838932195618, 289.29412234148674, 295.51240453252126, 295.9792814502986, 296.9524876019835, 4968.677035992658, 5024.417308547814, 5041.143005689032, 5047.116754567955, 5057.875692209276, 4952.851414457572, 4954.7274899880495, 4963.751812409374, 4972.801087956477, 4976.8506944791625, 3689.4281386385087, 3749.43758436234, 3794.203217324365, 3861.9613803861885, 3886.9805650971707, 3860.8455661773496, 3875.593062728401, 3879.5344558653, 3881.7088718346236, 3886.747361421513, 3849.2878817418728, 3852.210296889131, 3861.517310336208, 3873.3661110444887, 3882.534095908495, 3760.9435858462143, 3780.8487660493547, 3856.382978723405, 3866.4007078902814, 3868.40039793831, 3418.478776944261, 3429.742769292288, 3430.468277417004, 3431.7083047940955, 3433.1760377509468, 4849.636277279183, 4849.660523763338, 4857.1742803723455, 4860.392450943632, 4861.513848615145, 4402.713823601488, 4416.1609294233995, 4423.380726698265, 4423.429682462712, 4425.3847345718905, 4875.804967801284, 5149.588032957392, 5173.0, 5180.8963820723375, 5184.351956005499, 3656.926861462756, 3657.817109144532, 3660.9267814643827, 3661.6521430464063, 3663.761855479412, 5363.597730170253, 5383.838484845422, 5404.648697834628, 5419.59353048519, 5423.511883930465, 3560.5549306336707, 3615.9276814463565, 3629.383004889175, 3673.9632603674154, 3685.262947410529, 3719.8698045568276, 3726.4782930389765, 3728.3289007978283, 3730.421784623388, 3732.122951106488, 4277.465316835395, 4282.721623094489, 4296.935545966813, 4317.676174286941, 4319.870403887889, 5068.087744206078, 5197.350331208599, 5204.8178313758835, 5218.739063046833, 5221.32122824038, 1287.2984223598162, 1312.0, 1314.6910476038124, 1316.880651446263, 1317.440087962612, 783.5925318834175, 814.5886327404622, 820.4420993724206, 825.1500954017372, 825.2572684583803, 4331.956680433218, 4341.066670665822, 4499.392582001388, 4512.571305725951, 4523.050159466483, 5345.38528069277, 5359.356877174764, 5365.919511207335, 5399.541039011649, 5410.215518749838, 4532.320151977164, 4537.500874903758, 4546.749928753884, 4560.703554268962, 4572.314152877028, 2706.3896981296098, 2831.476176907279, 2847.5477506471434, 2854.715378079872, 2859.37093839355, 4988.7528117970505, 5001.8499445016705, 5008.949910500848, 5021.748912554431, 5025.246213068069, 5235.476452354734, 5369.167778994184, 5396.519245086897, 5408.648437851527, 5477.561795056386, 5000.574836171673, 5011.84964451067, 5029.17018691919, 5032.6980381177245, 5040.621953353513, 5341.305630268041, 5350.785968561214, 5352.5450336721815, 5354.554270346906, 5356.78572857097, 5024.680104996283, 5131.024555546067, 5246.3179786629025, 5247.344081989751, 5266.183741520071, 4972.353594032753, 4980.950190498049, 4998.325226094431, 5024.874378140576, 5065.670731402447, 3720.981395093007, 3722.218334149859, 3726.142987112925, 3729.6270372962485, 3737.850485980639, 5008.824691135793, 5302.969742995274, 5373.140297552372, 5373.704446255493, 5382.43909266324, 5264.31563896691, 5264.8674038946765, 5268.104422248303, 5274.709890955881, 5278.551323137576, 5212.921806172834, 5251.868703282448, 5267.657602255841, 5268.631195816256, 5269.631125821155, 4803.231482962709, 5088.211327244283, 5136.2552429898205, 5179.715115668524, 5189.740512974412, 5017.54842064216, 5141.557760064089, 5232.790688372423, 5249.826388021608, 5257.658252213594, 5113.51421614946, 5123.666961647481, 5125.743712814419, 5134.460881607378, 5151.742412879266], "value": 3882.853717043993, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.9686517241552, 592.49933805934, 592.5940730599536, 640.95513314068, 653.1476423267634, 11995.04039676826, 13243.139195952257, 13252.536161234359, 13257.602271931846, 13361.465541378333, 13760.655983600414, 14251.57245282643, 14369.497067602637, 14383.0, 14410.639734006654, 734.9559026458417, 761.0, 766.3830616353833, 766.8082979255187, 768.2356055724534, 595.2975488923068, 723.6200994477889, 749.5502698380982, 755.3654929858917, 760.7831767946136, 793.0681449297053, 793.4961299574783, 794.0907660728462, 797.1709422200904, 800.8718605023197, 791.9485233459807, 792.4056957282038, 792.5086446403238, 792.5522080024825, 792.7066985215449, 579.3974266762561, 580.2109131581046, 580.2427831679656, 580.7154494297806, 582.1587805620879, 12533.43599538023, 12578.119531632788, 12578.308193049379, 12602.74794504114, 12638.241705497607, 12799.168054076456, 13095.934520327433, 13283.335833208397, 13301.268430236332, 13402.530911418151, 10275.48622568876, 10371.636992705218, 10512.52693628781, 10622.840657390145, 11103.222774405795, 3227.4997375406615, 3283.9835800821083, 3290.8683652653867, 3302.4055669979393, 3303.520989456539, 65859.3414065858, 67349.3265067348, 67448.66275668639, 67818.66090669564, 68033.65983170053, 9015.63937442508, 9091.0, 9124.24439226652, 9357.953210233905, 9363.25093992479, 17883.642327153386, 17893.552661183574, 18009.00950447738, 18023.549411264823, 18030.36893708714, 6848.3494068063455, 6880.346367095118, 6885.277045910208, 6911.550749201286, 7251.0573625429415, 3543.9291214175573, 3654.744167908221, 3660.5607327120915, 3671.4492826076303, 3736.271427071695, 2862.1699707084713, 2933.0170373054098, 2955.3202763364548, 2963.866626001835, 2965.6506289638164, 453.92283311837065, 459.7245615773295, 467.1497873869525, 469.47887844492584, 477.59404506169477, 496.53077841440216, 531.6225479909231, 535.234614501267, 536.7369988705506, 564.6075977195892, 7761.767146985487, 7889.329407000355, 8195.71315003972, 8215.712450064219, 8241.50550966944, 490.7423602608659, 528.5269683633127, 555.2504119438726, 557.7629507459313, 557.8577462747055, 3775.659640827522, 3867.7292589518465, 3929.941050884239, 3930.4300876373336, 4107.774072426046, 75283.0, 77320.29378971709, 78637.60681196557, 83984.74022889661, 99089.0, 74638.25361746422, 75322.0, 78139.21860781433, 79624.60187699024, 80805.59597201976, 43561.56438435638, 61945.38054619396, 67295.66352168306, 67945.66027169931, 72066.279337207, 7851.725189618336, 8326.25063744266, 8415.873761893454, 8444.197801208875, 8446.66213351459, 42616.78691606522, 43397.56602433935, 43944.78027609841, 44160.0, 44701.55298447104, 56897.43102569087, 57304.1404378943, 61681.691591541756, 62233.688831555555, 62483.813066542454, 10727.946360268461, 10756.623518176826, 10911.127109831035, 10939.56241750321, 11105.444727763417, 12110.152289339661, 12337.938310308391, 12968.157069790434, 13188.604341869759, 13311.600651980456, 11479.942600287279, 11605.129615278718, 11737.061035117342, 12211.633650990485, 12222.633321000385, 11091.778164436828, 11237.887621123684, 11480.196386252883, 12079.094067945114, 12091.516339346328, 11013.339199648046, 11091.556337746722, 11178.496967636313, 11413.372264525198, 11711.590094346657, 9400.670976515788, 9648.276379271443, 9997.850032249376, 10323.432211228455, 10334.483275836328, 9296.767580810534, 9465.432074075577, 9679.370840895319, 9995.20038396941, 10013.899861001588], "value": 6359.829095023114, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1636.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 117.0, 113.0, 116.0, 114.0, 114.0, 120.0, 117.0, 137.0, 116.0], "value": 117.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 156.0, 194.0, 129.0, 157.0, 158.0, 128.0, 188.0, 127.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 165.0, 164.0, 166.0, 167.0, 166.0, 166.0, 168.0, 168.0, 166.0], "value": 167.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 78.0, 186.0, 79.0, 79.0, 79.0, 84.0, 163.0, 79.0], "value": 98.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 139.0, 90.0, 88.0, 92.0, 140.0, 88.0, 88.0, 129.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 119.0, 119.0, 119.0, 122.0, 119.0, 139.0, 119.0, 118.0], "value": 121.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 149.0, 148.0, 149.0, 151.0, 148.0, 148.0, 151.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 97.0, 97.0, 95.0, 97.0, 97.0, 98.0, 96.0, 97.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 67.0, 69.0, 69.0, 67.0, 69.0, 69.0, 68.0, 67.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 70.0, 74.0, 70.0, 74.0, 72.0, 74.0, 70.0, 73.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 85.0, 89.0, 85.0, 101.0, 94.0, 85.0, 87.0, 86.0, 96.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 141.0, 145.0, 141.0, 145.0, 146.0, 151.0, 158.0, 160.0, 140.0], "value": 147.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 189.0, 181.0, 175.0, 178.0, 178.0, 189.0, 184.0, 177.0, 179.0], "value": 181.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 73.0, 75.0, 72.0, 72.0, 72.0, 73.0, 74.0, 74.0], "value": 72.7, "unit": "score"}]}]} 16:53:11 INFO - Return code: 0 16:53:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:53:11 ERROR - # TBPL SUCCESS # 16:53:11 INFO - Running post-action listener: _resource_record_post_action 16:53:11 INFO - [mozharness: 2016-08-22 23:53:11.411712Z] Finished run-tests step (success) 16:53:11 INFO - Running post-run listener: _resource_record_post_run 16:53:11 INFO - Total resource usage - Wall time: 1201s; CPU: 14.0%; Read bytes: 0; Write bytes: 416694272; Read time: 0; Write time: 306360 16:53:11 INFO - TinderboxPrint: CPU usage
13.9% 16:53:11 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:53:11 INFO - TinderboxPrint: I/O write bytes / time
416,694,272 / 306,360 16:53:11 INFO - TinderboxPrint: CPU idle
8,249.4 (86.1%) 16:53:11 INFO - TinderboxPrint: CPU user
1,230.8 (12.8%) 16:53:11 INFO - TinderboxPrint: Swap in / out
0 / 0 16:53:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124686336; Read time: 0; Write time: 92856 16:53:11 INFO - run-tests - Wall time: 1185s; CPU: 14.0%; Read bytes: 0; Write bytes: 290971648; Read time: 0; Write time: 213452 16:53:12 INFO - Running post-run listener: _upload_blobber_files 16:53:12 INFO - Blob upload gear active. 16:53:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:53:12 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 16:53:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:53:12 INFO - (blobuploader) - INFO - Open directory for files ... 16:53:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:53:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:53:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:53:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:53:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:53:13 INFO - (blobuploader) - INFO - Done attempting. 16:53:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:53:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:53:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:53:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:53:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:53:17 INFO - (blobuploader) - INFO - Done attempting. 16:53:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:53:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:53:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:53:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:53:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:53:18 INFO - (blobuploader) - INFO - Done attempting. 16:53:18 INFO - (blobuploader) - INFO - Iteration through files over. 16:53:18 INFO - Return code: 0 16:53:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:53:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:53:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6c973cdfb3171a1f85f6d9e45893bb8682005fe9592bcaca297427984743b16033af367133f9567c9b257c433e1320b9dad5cd2903496f3022b2d1088a66f682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/46da1fd06aac1cc3037cc70ce9845bc094db20b57184ccab51b8285c06acafd99e0739d8badec477f5c4d11297501482101fe0adf35bfcdb3f71a4b9a9e62a23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e36ea1e183c16095297a4aa36851719da82a3009a292bba62c4231a0a3bd6575469f4b660383ab3fb1be98dec779e061284e3c1f5b9122c878ee21130a2b36eb"} 16:53:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:53:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:53:18 INFO - Contents: 16:53:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6c973cdfb3171a1f85f6d9e45893bb8682005fe9592bcaca297427984743b16033af367133f9567c9b257c433e1320b9dad5cd2903496f3022b2d1088a66f682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/46da1fd06aac1cc3037cc70ce9845bc094db20b57184ccab51b8285c06acafd99e0739d8badec477f5c4d11297501482101fe0adf35bfcdb3f71a4b9a9e62a23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e36ea1e183c16095297a4aa36851719da82a3009a292bba62c4231a0a3bd6575469f4b660383ab3fb1be98dec779e061284e3c1f5b9122c878ee21130a2b36eb"} 16:53:18 INFO - Running post-run listener: copy_logs_to_upload_dir 16:53:18 INFO - Copying logs to upload dir... 16:53:18 INFO - mkdir: /builds/slave/test/build/upload/logs 16:53:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.684918 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-22 16:53:16.714434) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 16:53:16.718159) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499 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-Non-PGO/sha512/6c973cdfb3171a1f85f6d9e45893bb8682005fe9592bcaca297427984743b16033af367133f9567c9b257c433e1320b9dad5cd2903496f3022b2d1088a66f682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/46da1fd06aac1cc3037cc70ce9845bc094db20b57184ccab51b8285c06acafd99e0739d8badec477f5c4d11297501482101fe0adf35bfcdb3f71a4b9a9e62a23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e36ea1e183c16095297a4aa36851719da82a3009a292bba62c4231a0a3bd6575469f4b660383ab3fb1be98dec779e061284e3c1f5b9122c878ee21130a2b36eb"} build_url:https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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-Non-PGO/sha512/6c973cdfb3171a1f85f6d9e45893bb8682005fe9592bcaca297427984743b16033af367133f9567c9b257c433e1320b9dad5cd2903496f3022b2d1088a66f682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/46da1fd06aac1cc3037cc70ce9845bc094db20b57184ccab51b8285c06acafd99e0739d8badec477f5c4d11297501482101fe0adf35bfcdb3f71a4b9a9e62a23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e36ea1e183c16095297a4aa36851719da82a3009a292bba62c4231a0a3bd6575469f4b660383ab3fb1be98dec779e061284e3c1f5b9122c878ee21130a2b36eb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 16:53:16.743789) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:53:16.744131) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1471908750.975730-998495499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:53:16.827480) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 16:53:16.827937) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 16:53:16.828365) ========= ========= Total master_lag: 0.15 =========