builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1470706194.97 results: success (0) buildid: 20160808161220 builduid: d3ab91f9e92f439b9a56e8ade74e746e revision: 5ff96be046af749644327f75b21ce9437d766886 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 18:29:54.970630) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 18:29:54.971592) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 18:29:54.972157) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 18:29:54.987645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 18:29:54.988085) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 18:29:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2016-08-08 18:29:55 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128629 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 18:29:55.131828) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 18:29:55.132184) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020097 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 18:29:55.182883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 18:29:55.183355) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5ff96be046af749644327f75b21ce9437d766886 --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 5ff96be046af749644327f75b21ce9437d766886 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 18:29:55,598 truncating revision to first 12 chars 2016-08-08 18:29:55,598 Setting DEBUG logging. 2016-08-08 18:29:55,598 attempt 1/10 2016-08-08 18:29:55,598 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5ff96be046af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 18:29:56,987 unpacking tar archive at: fx-team-5ff96be046af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.773026 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 18:29:56.970441) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 18:29:56.970803) ========= script_repo_revision: 5ff96be046af749644327f75b21ce9437d766886 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 18:29:56.971223) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 18:29:56.971538) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 18:29:56.981463) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-08 18:29:56.981817) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:29:57 INFO - MultiFileLogger online at 20160808 18:29:57 in /builds/slave/test 18:29:57 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 18:29:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:29:57 INFO - {'append_to_log': False, 18:29:57 INFO - 'base_work_dir': '/builds/slave/test', 18:29:57 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:29:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:29:57 INFO - 'branch': 'Fx-Team-Non-PGO', 18:29:57 INFO - 'buildbot_json_path': 'buildprops.json', 18:29:57 INFO - 'config_files': ('talos/linux_config.py',), 18:29:57 INFO - 'default_actions': ('clobber', 18:29:57 INFO - 'read-buildbot-config', 18:29:57 INFO - 'download-and-extract', 18:29:57 INFO - 'populate-webroot', 18:29:57 INFO - 'create-virtualenv', 18:29:57 INFO - 'install', 18:29:57 INFO - 'run-tests'), 18:29:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:29:57 INFO - 'download_minidump_stackwalk': True, 18:29:57 INFO - 'download_symbols': 'ondemand', 18:29:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:29:57 INFO - 'tooltool.py': '/tools/tooltool.py', 18:29:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:29:57 INFO - '/tools/misc-python/virtualenv.py')}, 18:29:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:29:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:29:57 INFO - 'installer_path': 'installer.exe', 18:29:57 INFO - 'log_level': 'info', 18:29:57 INFO - 'log_name': 'talos', 18:29:57 INFO - 'log_to_console': True, 18:29:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:29:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:29:57 INFO - 'opt_config_files': (), 18:29:57 INFO - 'pip_index': False, 18:29:57 INFO - 'sps_profile': False, 18:29:57 INFO - 'sps_profile_interval': 0, 18:29:57 INFO - 'suite': 'dromaeojs-e10s', 18:29:57 INFO - 'system_bits': '32', 18:29:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:29:57 INFO - 'title': 'talos-linux64-ix-013', 18:29:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:29:57 INFO - 'use_talos_json': True, 18:29:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:29:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:29:57 INFO - 'work_dir': 'build'} 18:29:57 INFO - [mozharness: 2016-08-09 01:29:57.484943Z] Running clobber step. 18:29:57 INFO - Running pre-action listener: _resource_record_pre_action 18:29:57 INFO - Running main action method: clobber 18:29:57 INFO - rmtree: /builds/slave/test/build 18:29:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:29:58 INFO - Running post-action listener: _resource_record_post_action 18:29:58 INFO - [mozharness: 2016-08-09 01:29:58.461256Z] Finished clobber step (success) 18:29:58 INFO - [mozharness: 2016-08-09 01:29:58.461356Z] Running read-buildbot-config step. 18:29:58 INFO - Running pre-action listener: _resource_record_pre_action 18:29:58 INFO - Running main action method: read_buildbot_config 18:29:58 INFO - Using buildbot properties: 18:29:58 INFO - { 18:29:58 INFO - "project": "", 18:29:58 INFO - "product": "firefox", 18:29:58 INFO - "script_repo_revision": "production", 18:29:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:29:58 INFO - "repository": "", 18:29:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:29:58 INFO - "buildid": "20160808161220", 18:29:58 INFO - "pgo_build": "False", 18:29:58 INFO - "basedir": "/builds/slave/test", 18:29:58 INFO - "buildnumber": 1741, 18:29:58 INFO - "slavename": "talos-linux64-ix-013", 18:29:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:29:58 INFO - "platform": "ubuntu64_hw", 18:29:58 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 18:29:58 INFO - "branch": "fx-team", 18:29:58 INFO - "repo_path": "integration/fx-team", 18:29:58 INFO - "revision": "5ff96be046af749644327f75b21ce9437d766886", 18:29:58 INFO - "stage_platform": "linux64", 18:29:58 INFO - "builduid": "d3ab91f9e92f439b9a56e8ade74e746e", 18:29:58 INFO - "slavebuilddir": "test" 18:29:58 INFO - } 18:29:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 18:29:58 INFO - Running post-action listener: _resource_record_post_action 18:29:58 INFO - [mozharness: 2016-08-09 01:29:58.464112Z] Finished read-buildbot-config step (success) 18:29:58 INFO - [mozharness: 2016-08-09 01:29:58.464202Z] Running download-and-extract step. 18:29:58 INFO - Running pre-action listener: _resource_record_pre_action 18:29:58 INFO - Running main action method: download_and_extract 18:29:58 INFO - mkdir: /builds/slave/test/build/tests 18:29: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')]} 18:29:58 INFO - trying https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:29:58 INFO - Downloading https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/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 18:29:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/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 18:29:59 INFO - Downloaded 1361 bytes. 18:29:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:29:59 INFO - Using the following test package requirements: 18:29:59 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:29:59 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:29:59 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:29:59 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:59 INFO - u'jsshell-linux-x86_64.zip'], 18:29:59 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:29:59 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:29:59 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:29:59 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:29:59 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:29:59 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:29:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:29:59 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')]} 18:29:59 INFO - trying https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:29:59 INFO - Downloading https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/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 18:29:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/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 18:29:59 INFO - Downloaded 20257787 bytes. 18:29:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:29:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:30:01 INFO - Return code: 0 18:30:01 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 18:30: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')]} 18:30:01 INFO - trying https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:30:01 INFO - Downloading https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/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 18:30:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/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 18:30:02 INFO - Downloaded 20257787 bytes. 18:30:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:30:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:30:03 INFO - Return code: 0 18:30:03 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')]} 18:30:03 INFO - trying https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 18:30:03 INFO - Downloading https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/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 18:30:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/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 18:30:04 INFO - Downloaded 14413723 bytes. 18:30:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:30:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:30:04 INFO - Return code: 0 18:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:04 INFO - trying https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:30:04 INFO - Downloading https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/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 18:30:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/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 18:30:06 INFO - Downloaded 56135236 bytes. 18:30:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:30:06 INFO - mkdir: /builds/slave/test/properties 18:30:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:30:06 INFO - Writing to file /builds/slave/test/properties/build_url 18:30:06 INFO - Contents: 18:30:06 INFO - build_url:https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:30:06 INFO - Running post-action listener: _resource_record_post_action 18:30:06 INFO - Running post-action listener: set_extra_try_arguments 18:30:06 INFO - [mozharness: 2016-08-09 01:30:06.781741Z] Finished download-and-extract step (success) 18:30:06 INFO - [mozharness: 2016-08-09 01:30:06.781972Z] Running populate-webroot step. 18:30:06 INFO - Running pre-action listener: _resource_record_pre_action 18:30:06 INFO - Running main action method: populate_webroot 18:30:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:30:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:30:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:30:06 INFO - '--tppagecycles', 18:30:06 INFO - '7'], 18:30:06 INFO - 'tests': ['tsvgm']}}, 18:30:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:30:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:30:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:30:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:30:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:30:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:30:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:06 INFO - 'talos_options': ['--disable-e10s'], 18:30:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:30:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:30:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:06 INFO - 'talos_options': ['--disable-e10s'], 18:30:06 INFO - 'tests': ['damp', 'tps']}, 18:30:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:06 INFO - 'tests': ['damp', 'tps']}, 18:30:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:30:06 INFO - 'tests': ['dromaeo_dom']}, 18:30:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:30:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:30:06 INFO - 'tests': ['basic_compositor_video']}, 18:30:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:30:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:30:06 INFO - 'tests': ['a11yr', 18:30:06 INFO - 'ts_paint', 18:30:06 INFO - 'tpaint', 18:30:06 INFO - 'sessionrestore', 18:30:06 INFO - 'sessionrestore_no_auto_restore', 18:30:06 INFO - 'tabpaint']}, 18:30:06 INFO - 'other-e10s': {'tests': ['a11yr', 18:30:06 INFO - 'ts_paint', 18:30:06 INFO - 'tpaint', 18:30:06 INFO - 'sessionrestore', 18:30:06 INFO - 'sessionrestore_no_auto_restore', 18:30:06 INFO - 'tabpaint']}, 18:30:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:30:06 INFO - 'ts_paint', 18:30:06 INFO - 'tpaint', 18:30:06 INFO - 'sessionrestore', 18:30:06 INFO - 'sessionrestore_no_auto_restore', 18:30:06 INFO - 'tabpaint']}, 18:30:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:30:06 INFO - 'ts_paint', 18:30:06 INFO - 'tpaint', 18:30:06 INFO - 'sessionrestore', 18:30:06 INFO - 'sessionrestore_no_auto_restore', 18:30:06 INFO - 'tabpaint']}, 18:30:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:30:06 INFO - 'tests': ['a11yr', 18:30:06 INFO - 'ts_paint', 18:30:06 INFO - 'tpaint', 18:30:06 INFO - 'sessionrestore', 18:30:06 INFO - 'sessionrestore_no_auto_restore', 18:30:06 INFO - 'tabpaint']}, 18:30:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:30:06 INFO - 'tests': ['a11yr', 18:30:06 INFO - 'ts_paint', 18:30:06 INFO - 'tpaint', 18:30:06 INFO - 'sessionrestore', 18:30:06 INFO - 'sessionrestore_no_auto_restore', 18:30:06 INFO - 'tabpaint']}, 18:30:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:30:06 INFO - 'tests': ['tsvgx', 18:30:06 INFO - 'tsvgr_opacity', 18:30:06 INFO - 'tart', 18:30:06 INFO - 'tscrollx', 18:30:06 INFO - 'cart']}, 18:30:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:30:06 INFO - 'tsvgr_opacity', 18:30:06 INFO - 'tart', 18:30:06 INFO - 'tscrollx', 18:30:06 INFO - 'cart']}, 18:30:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:06 INFO - 'talos_options': ['--disable-e10s'], 18:30:06 INFO - 'tests': ['tp5o']}, 18:30:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:06 INFO - 'tests': ['tp5o']}, 18:30:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:06 INFO - 'talos_options': ['--disable-e10s', 18:30:06 INFO - '--xperf_path', 18:30:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:30:06 INFO - 'tests': ['tp5n']}, 18:30:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:06 INFO - 'talos_options': ['--xperf_path', 18:30:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:30:06 INFO - 'tests': ['tp5n']}}, 18:30:06 INFO - 'talos.zip': {'path': '', 18:30:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:30:06 INFO - Running post-action listener: _resource_record_post_action 18:30:06 INFO - [mozharness: 2016-08-09 01:30:06.803215Z] Finished populate-webroot step (success) 18:30:06 INFO - [mozharness: 2016-08-09 01:30:06.803303Z] Running create-virtualenv step. 18:30:06 INFO - Running pre-action listener: _resource_record_pre_action 18:30:06 INFO - Running main action method: create_virtualenv 18:30:06 INFO - Creating virtualenv /builds/slave/test/build/venv 18:30:06 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 18:30:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:30:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:30:06 INFO - Using real prefix '/usr' 18:30:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:30:07 INFO - Installing distribute.............................................................................................................................................................................................done. 18:30:09 INFO - Installing pip.................done. 18:30:09 INFO - Return code: 0 18:30:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:30: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')]} 18:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30: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')]} 18:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b85400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c14570>, '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 0x2c15470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c15900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', '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 18:30: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', 'pip>=1.5'] in /builds/slave/test/build 18:30: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 pip>=1.5 18:30:09 INFO - Using env: {'DISPLAY': ':0', 18:30:09 INFO - 'HOME': '/home/cltbld', 18:30:09 INFO - 'LANG': 'en_US.UTF-8', 18:30:09 INFO - 'LANGUAGE': 'en_US:en', 18:30:09 INFO - 'LOGNAME': 'cltbld', 18:30:09 INFO - 'MAIL': '/var/mail/cltbld', 18:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:09 INFO - 'MOZ_NO_REMOTE': '1', 18:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:09 INFO - 'NO_EM_RESTART': '1', 18:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:09 INFO - 'PWD': '/builds/slave/test', 18:30:09 INFO - 'SHELL': '/bin/bash', 18:30:09 INFO - 'SHLVL': '1', 18:30:09 INFO - 'TERM': 'linux', 18:30:09 INFO - 'TMOUT': '86400', 18:30:09 INFO - 'USER': 'cltbld', 18:30:09 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', 18:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:09 INFO - '_': '/tools/buildbot/bin/python'} 18:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:09 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 18:30:09 INFO - Cleaning up... 18:30:09 INFO - Return code: 0 18:30:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:30: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')]} 18:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30: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')]} 18:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30: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', '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 0x2956030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b85400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c14570>, '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 0x2c15470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c15900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', '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 18:30: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:30: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 psutil>=3.1.1 18:30:09 INFO - Using env: {'DISPLAY': ':0', 18:30:09 INFO - 'HOME': '/home/cltbld', 18:30:09 INFO - 'LANG': 'en_US.UTF-8', 18:30:09 INFO - 'LANGUAGE': 'en_US:en', 18:30:09 INFO - 'LOGNAME': 'cltbld', 18:30:09 INFO - 'MAIL': '/var/mail/cltbld', 18:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:09 INFO - 'MOZ_NO_REMOTE': '1', 18:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:09 INFO - 'NO_EM_RESTART': '1', 18:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:09 INFO - 'PWD': '/builds/slave/test', 18:30:09 INFO - 'SHELL': '/bin/bash', 18:30:09 INFO - 'SHLVL': '1', 18:30:09 INFO - 'TERM': 'linux', 18:30:09 INFO - 'TMOUT': '86400', 18:30:09 INFO - 'USER': 'cltbld', 18:30:09 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', 18:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:09 INFO - '_': '/tools/buildbot/bin/python'} 18:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:09 INFO - Downloading/unpacking psutil>=3.1.1 18:30:09 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 18:30:09 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 18:30:09 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 18:30:09 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 18:30:09 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 18:30:09 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 18:30:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:30:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:30:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:30:11 INFO - Installing collected packages: psutil 18:30:11 INFO - Running setup.py install for psutil 18:30:11 INFO - building 'psutil._psutil_linux' extension 18:30:11 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 18:30:12 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 18:30:12 INFO - building 'psutil._psutil_posix' extension 18:30:12 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 18:30:12 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 18:30:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:30:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:30:12 INFO - Successfully installed psutil 18:30:12 INFO - Cleaning up... 18:30:12 INFO - Return code: 0 18:30:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b85400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c14570>, '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 0x2c15470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c15900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', '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 18:30:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:30:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:30:12 INFO - Using env: {'DISPLAY': ':0', 18:30:12 INFO - 'HOME': '/home/cltbld', 18:30:12 INFO - 'LANG': 'en_US.UTF-8', 18:30:12 INFO - 'LANGUAGE': 'en_US:en', 18:30:12 INFO - 'LOGNAME': 'cltbld', 18:30:12 INFO - 'MAIL': '/var/mail/cltbld', 18:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:12 INFO - 'MOZ_NO_REMOTE': '1', 18:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:12 INFO - 'NO_EM_RESTART': '1', 18:30:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:12 INFO - 'PWD': '/builds/slave/test', 18:30:12 INFO - 'SHELL': '/bin/bash', 18:30:12 INFO - 'SHLVL': '1', 18:30:12 INFO - 'TERM': 'linux', 18:30:12 INFO - 'TMOUT': '86400', 18:30:12 INFO - 'USER': 'cltbld', 18:30:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', 18:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:12 INFO - '_': '/tools/buildbot/bin/python'} 18:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:30:14 INFO - Installing collected packages: mozsystemmonitor 18:30:14 INFO - Running setup.py install for mozsystemmonitor 18:30:14 INFO - Successfully installed mozsystemmonitor 18:30:14 INFO - Cleaning up... 18:30:14 INFO - Return code: 0 18:30:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:30:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2956030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b85400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c14570>, '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 0x2c15470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c15900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', '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 18:30:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:30:14 INFO - Using env: {'DISPLAY': ':0', 18:30:14 INFO - 'HOME': '/home/cltbld', 18:30:14 INFO - 'LANG': 'en_US.UTF-8', 18:30:14 INFO - 'LANGUAGE': 'en_US:en', 18:30:14 INFO - 'LOGNAME': 'cltbld', 18:30:14 INFO - 'MAIL': '/var/mail/cltbld', 18:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:14 INFO - 'MOZ_NO_REMOTE': '1', 18:30:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:14 INFO - 'NO_EM_RESTART': '1', 18:30:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:14 INFO - 'PWD': '/builds/slave/test', 18:30:14 INFO - 'SHELL': '/bin/bash', 18:30:14 INFO - 'SHLVL': '1', 18:30:14 INFO - 'TERM': 'linux', 18:30:14 INFO - 'TMOUT': '86400', 18:30:14 INFO - 'USER': 'cltbld', 18:30:14 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', 18:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:14 INFO - '_': '/tools/buildbot/bin/python'} 18:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:14 INFO - Downloading/unpacking jsonschema==2.5.1 18:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:30:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:30:16 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 18:30:16 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 18:30:16 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 18:30:16 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 18:30:16 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 18:30:16 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 18:30:16 INFO - Downloading functools32-3.2.3-2.tar.gz 18:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:30:17 INFO - warning: no files found matching '*.txt' 18:30:17 INFO - no previously-included directories found matching 'build' 18:30:17 INFO - no previously-included directories found matching 'dist' 18:30:17 INFO - no previously-included directories found matching '.git*' 18:30:17 INFO - Installing collected packages: jsonschema, functools32 18:30:17 INFO - Running setup.py install for functools32 18:30:17 INFO - warning: no files found matching '*.txt' 18:30:17 INFO - no previously-included directories found matching 'build' 18:30:17 INFO - no previously-included directories found matching 'dist' 18:30:17 INFO - no previously-included directories found matching '.git*' 18:30:17 INFO - Successfully installed jsonschema functools32 18:30:17 INFO - Cleaning up... 18:30:17 INFO - Return code: 0 18:30:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:30:17 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')]} 18:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:17 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')]} 18:30:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:17 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 0x2956030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b85400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c14570>, '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 0x2c15470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c15900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', '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 18:30:17 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 18:30:17 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 18:30:17 INFO - Using env: {'DISPLAY': ':0', 18:30:17 INFO - 'HOME': '/home/cltbld', 18:30:17 INFO - 'LANG': 'en_US.UTF-8', 18:30:17 INFO - 'LANGUAGE': 'en_US:en', 18:30:17 INFO - 'LOGNAME': 'cltbld', 18:30:17 INFO - 'MAIL': '/var/mail/cltbld', 18:30:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:17 INFO - 'MOZ_NO_REMOTE': '1', 18:30:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:17 INFO - 'NO_EM_RESTART': '1', 18:30:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:17 INFO - 'PWD': '/builds/slave/test', 18:30:17 INFO - 'SHELL': '/bin/bash', 18:30:17 INFO - 'SHLVL': '1', 18:30:17 INFO - 'TERM': 'linux', 18:30:17 INFO - 'TMOUT': '86400', 18:30:17 INFO - 'USER': 'cltbld', 18:30:17 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', 18:30:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:17 INFO - '_': '/tools/buildbot/bin/python'} 18:30:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:30:17 INFO - Cleaning up... 18:30:17 INFO - Return code: 0 18:30:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:30:17 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')]} 18:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:17 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')]} 18:30:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:17 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 0x2956030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b85400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c14570>, '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 0x2c15470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c15900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', '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 18:30:17 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 18:30:17 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 18:30:17 INFO - Using env: {'DISPLAY': ':0', 18:30:17 INFO - 'HOME': '/home/cltbld', 18:30:17 INFO - 'LANG': 'en_US.UTF-8', 18:30:17 INFO - 'LANGUAGE': 'en_US:en', 18:30:17 INFO - 'LOGNAME': 'cltbld', 18:30:17 INFO - 'MAIL': '/var/mail/cltbld', 18:30:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:17 INFO - 'MOZ_NO_REMOTE': '1', 18:30:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:17 INFO - 'NO_EM_RESTART': '1', 18:30:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:17 INFO - 'PWD': '/builds/slave/test', 18:30:17 INFO - 'SHELL': '/bin/bash', 18:30:17 INFO - 'SHLVL': '1', 18:30:17 INFO - 'TERM': 'linux', 18:30:17 INFO - 'TMOUT': '86400', 18:30:17 INFO - 'USER': 'cltbld', 18:30:17 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', 18:30:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:17 INFO - '_': '/tools/buildbot/bin/python'} 18:30:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:17 INFO - Downloading/unpacking blobuploader==1.2.4 18:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:19 INFO - Downloading blobuploader-1.2.4.tar.gz 18:30:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:30:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:30:19 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 18:30:19 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 18:30:19 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 18:30:19 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 18:30:19 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 18:30:19 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 18:30:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:30:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:30:20 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 18:30:20 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 18:30:20 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 18:30:20 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 18:30:20 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 18:30:20 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 18:30:20 INFO - Downloading docopt-0.6.1.tar.gz 18:30:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:30:20 INFO - Installing collected packages: blobuploader, requests, docopt 18:30:20 INFO - Running setup.py install for blobuploader 18:30:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:30:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:30:20 INFO - Running setup.py install for requests 18:30:20 INFO - Running setup.py install for docopt 18:30:20 INFO - Successfully installed blobuploader requests docopt 18:30:20 INFO - Cleaning up... 18:30:20 INFO - Return code: 0 18:30:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:20 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')]} 18:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:20 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')]} 18:30:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:20 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 0x2956030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b85400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c14570>, '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 0x2c15470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c15900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', '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 18:30:20 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 18:30:20 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 18:30:20 INFO - Using env: {'DISPLAY': ':0', 18:30:20 INFO - 'HOME': '/home/cltbld', 18:30:20 INFO - 'LANG': 'en_US.UTF-8', 18:30:20 INFO - 'LANGUAGE': 'en_US:en', 18:30:20 INFO - 'LOGNAME': 'cltbld', 18:30:20 INFO - 'MAIL': '/var/mail/cltbld', 18:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:20 INFO - 'MOZ_NO_REMOTE': '1', 18:30:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:20 INFO - 'NO_EM_RESTART': '1', 18:30:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:20 INFO - 'PWD': '/builds/slave/test', 18:30:20 INFO - 'SHELL': '/bin/bash', 18:30:20 INFO - 'SHLVL': '1', 18:30:20 INFO - 'TERM': 'linux', 18:30:20 INFO - 'TMOUT': '86400', 18:30:20 INFO - 'USER': 'cltbld', 18:30:20 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', 18:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:20 INFO - '_': '/tools/buildbot/bin/python'} 18:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:30:21 INFO - Running setup.py (path:/tmp/pip-TZWrDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:30:21 INFO - Running setup.py (path:/tmp/pip-OaIRIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:30:21 INFO - Running setup.py (path:/tmp/pip-93zq2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:30:21 INFO - Running setup.py (path:/tmp/pip-iORnRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:30:21 INFO - Running setup.py (path:/tmp/pip-C4Nlyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:30:21 INFO - Running setup.py (path:/tmp/pip-7qF6FE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:30:21 INFO - Running setup.py (path:/tmp/pip-txro2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:30:21 INFO - Running setup.py (path:/tmp/pip-6xx7PP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:30:21 INFO - Running setup.py (path:/tmp/pip-TKivpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:30:21 INFO - Running setup.py (path:/tmp/pip-ZbgXHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:30:21 INFO - Running setup.py (path:/tmp/pip-N5brWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:30:21 INFO - Running setup.py (path:/tmp/pip-kuMecc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:30:22 INFO - Running setup.py (path:/tmp/pip-nCDrXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:30:22 INFO - Running setup.py (path:/tmp/pip-bBRpYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:22 INFO - Running setup.py (path:/tmp/pip-mboexH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:30:22 INFO - Running setup.py (path:/tmp/pip-7v5xa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:30:22 INFO - Running setup.py (path:/tmp/pip-723LIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:30:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:30:22 INFO - Running setup.py install for manifestparser 18:30:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:30:22 INFO - Running setup.py install for mozcrash 18:30:22 INFO - Running setup.py install for mozdebug 18:30:22 INFO - Running setup.py install for mozdevice 18:30:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:30:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:30:22 INFO - Running setup.py install for mozfile 18:30:22 INFO - Running setup.py install for mozhttpd 18:30:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:30:23 INFO - Running setup.py install for mozinfo 18:30:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:30:23 INFO - Running setup.py install for mozInstall 18:30:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:30:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:30:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:30:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:30:23 INFO - Running setup.py install for mozleak 18:30:23 INFO - Running setup.py install for mozlog 18:30:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:30:23 INFO - Running setup.py install for moznetwork 18:30:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:30:23 INFO - Running setup.py install for mozprocess 18:30:23 INFO - Running setup.py install for mozprofile 18:30:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:30:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:30:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:30:23 INFO - Running setup.py install for mozrunner 18:30:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:30:23 INFO - Running setup.py install for mozscreenshot 18:30:23 INFO - Running setup.py install for moztest 18:30:24 INFO - Running setup.py install for mozversion 18:30:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:30:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:30:24 INFO - Cleaning up... 18:30:24 INFO - Return code: 0 18:30:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:24 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')]} 18:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:24 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')]} 18:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:24 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 0x2956030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b85400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c14570>, '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 0x2c15470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c15900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', '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 18:30:24 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 18:30:24 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 18:30:24 INFO - Using env: {'DISPLAY': ':0', 18:30:24 INFO - 'HOME': '/home/cltbld', 18:30:24 INFO - 'LANG': 'en_US.UTF-8', 18:30:24 INFO - 'LANGUAGE': 'en_US:en', 18:30:24 INFO - 'LOGNAME': 'cltbld', 18:30:24 INFO - 'MAIL': '/var/mail/cltbld', 18:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:24 INFO - 'MOZ_NO_REMOTE': '1', 18:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:24 INFO - 'NO_EM_RESTART': '1', 18:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:24 INFO - 'PWD': '/builds/slave/test', 18:30:24 INFO - 'SHELL': '/bin/bash', 18:30:24 INFO - 'SHLVL': '1', 18:30:24 INFO - 'TERM': 'linux', 18:30:24 INFO - 'TMOUT': '86400', 18:30:24 INFO - 'USER': 'cltbld', 18:30:24 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', 18:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:24 INFO - '_': '/tools/buildbot/bin/python'} 18:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:30:24 INFO - Running setup.py (path:/tmp/pip-y0A2vE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:30:24 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)) 18:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:30:24 INFO - Running setup.py (path:/tmp/pip-JvFqWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:30:24 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)) 18:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:30:24 INFO - Running setup.py (path:/tmp/pip-EYWW9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:30:24 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)) 18:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:30:24 INFO - Running setup.py (path:/tmp/pip-AEe3VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:30:24 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)) 18:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:30:24 INFO - Running setup.py (path:/tmp/pip-ajMXW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:30:24 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)) 18:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:30:24 INFO - Running setup.py (path:/tmp/pip-TCAvF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:30:24 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)) 18:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:30:24 INFO - Running setup.py (path:/tmp/pip-_Jem3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:30:24 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)) 18:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:30:24 INFO - Running setup.py (path:/tmp/pip-_uFhVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:30:25 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)) 18:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:30:25 INFO - Running setup.py (path:/tmp/pip-sjvEVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:30:25 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)) 18:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:30:25 INFO - Running setup.py (path:/tmp/pip-io75yZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:30:25 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)) 18:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:30:25 INFO - Running setup.py (path:/tmp/pip-hUcwH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:30:25 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)) 18:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:30:25 INFO - Running setup.py (path:/tmp/pip-tOedc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:30:25 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)) 18:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:30:25 INFO - Running setup.py (path:/tmp/pip-P7jKjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:30:25 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)) 18:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:30:25 INFO - Running setup.py (path:/tmp/pip-Nf6ADS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:30:25 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)) 18:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:25 INFO - Running setup.py (path:/tmp/pip-eEZerb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:25 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)) 18:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:30:25 INFO - Running setup.py (path:/tmp/pip-LxDVJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:30:25 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)) 18:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:30:25 INFO - Running setup.py (path:/tmp/pip-kiCQod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:30:25 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)) 18:30:25 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)) 18:30:25 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)) 18:30:25 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)) 18:30:25 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)) 18:30:25 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)) 18:30:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:30:25 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 18:30:25 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 18:30:25 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 18:30:25 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 18:30:25 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 18:30:25 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 18:30:27 INFO - Downloading blessings-1.6.tar.gz 18:30:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:30:27 INFO - Installing collected packages: blessings 18:30:27 INFO - Running setup.py install for blessings 18:30:27 INFO - Successfully installed blessings 18:30:27 INFO - Cleaning up... 18:30:27 INFO - Return code: 0 18:30:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:30:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:28 INFO - Reading from file tmpfile_stdout 18:30:28 INFO - Current package versions: 18:30:28 INFO - argparse == 1.2.1 18:30:28 INFO - blessings == 1.6 18:30:28 INFO - blobuploader == 1.2.4 18:30:28 INFO - docopt == 0.6.1 18:30:28 INFO - functools32 == 3.2.3-2 18:30:28 INFO - jsonschema == 2.5.1 18:30:28 INFO - manifestparser == 1.1 18:30:28 INFO - mozInstall == 1.12 18:30:28 INFO - mozcrash == 0.17 18:30:28 INFO - mozdebug == 0.1 18:30:28 INFO - mozdevice == 0.48 18:30:28 INFO - mozfile == 1.2 18:30:28 INFO - mozhttpd == 0.7 18:30:28 INFO - mozinfo == 0.9 18:30:28 INFO - mozleak == 0.1 18:30:28 INFO - mozlog == 3.3 18:30:28 INFO - moznetwork == 0.27 18:30:28 INFO - mozprocess == 0.23 18:30:28 INFO - mozprofile == 0.28 18:30:28 INFO - mozrunner == 6.12 18:30:28 INFO - mozscreenshot == 0.1 18:30:28 INFO - mozsystemmonitor == 0.3 18:30:28 INFO - moztest == 0.7 18:30:28 INFO - mozversion == 1.4 18:30:28 INFO - psutil == 3.1.1 18:30:28 INFO - requests == 1.2.3 18:30:28 INFO - wsgiref == 0.1.2 18:30:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:28 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')]} 18:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:28 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')]} 18:30:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:28 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 0x2956030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b85400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c14570>, '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 0x2c15470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c15900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', '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 18:30:28 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 18:30:28 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 18:30:28 INFO - Using env: {'DISPLAY': ':0', 18:30:28 INFO - 'HOME': '/home/cltbld', 18:30:28 INFO - 'LANG': 'en_US.UTF-8', 18:30:28 INFO - 'LANGUAGE': 'en_US:en', 18:30:28 INFO - 'LOGNAME': 'cltbld', 18:30:28 INFO - 'MAIL': '/var/mail/cltbld', 18:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:28 INFO - 'MOZ_NO_REMOTE': '1', 18:30:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:28 INFO - 'NO_EM_RESTART': '1', 18:30:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:28 INFO - 'PWD': '/builds/slave/test', 18:30:28 INFO - 'SHELL': '/bin/bash', 18:30:28 INFO - 'SHLVL': '1', 18:30:28 INFO - 'TERM': 'linux', 18:30:28 INFO - 'TMOUT': '86400', 18:30:28 INFO - 'USER': 'cltbld', 18:30:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', 18:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:28 INFO - '_': '/tools/buildbot/bin/python'} 18:30:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:28 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)) 18:30:28 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)) 18:30:28 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)) 18:30:28 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)) 18:30:28 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)) 18:30:28 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)) 18:30:28 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)) 18:30:28 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)) 18:30:28 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)) 18:30:28 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)) 18:30:28 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)) 18:30:28 INFO - Cleaning up... 18:30:28 INFO - Return code: 0 18:30:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:30:28 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')]} 18:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:28 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')]} 18:30:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:28 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 0x2956030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b85400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c14570>, '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 0x2c15470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c15900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', '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 18:30:28 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 18:30:28 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 18:30:28 INFO - Using env: {'DISPLAY': ':0', 18:30:28 INFO - 'HOME': '/home/cltbld', 18:30:28 INFO - 'LANG': 'en_US.UTF-8', 18:30:28 INFO - 'LANGUAGE': 'en_US:en', 18:30:28 INFO - 'LOGNAME': 'cltbld', 18:30:28 INFO - 'MAIL': '/var/mail/cltbld', 18:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:28 INFO - 'MOZ_NO_REMOTE': '1', 18:30:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:28 INFO - 'NO_EM_RESTART': '1', 18:30:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:28 INFO - 'PWD': '/builds/slave/test', 18:30:28 INFO - 'SHELL': '/bin/bash', 18:30:28 INFO - 'SHLVL': '1', 18:30:28 INFO - 'TERM': 'linux', 18:30:28 INFO - 'TMOUT': '86400', 18:30:28 INFO - 'USER': 'cltbld', 18:30:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', 18:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:28 INFO - '_': '/tools/buildbot/bin/python'} 18:30:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:30:28 INFO - Cleaning up... 18:30:28 INFO - Return code: 0 18:30:28 INFO - Running post-action listener: _resource_record_post_action 18:30:28 INFO - Running post-action listener: _start_resource_monitoring 18:30:28 INFO - Starting resource monitoring. 18:30:28 INFO - [mozharness: 2016-08-09 01:30:28.497273Z] Finished create-virtualenv step (success) 18:30:28 INFO - [mozharness: 2016-08-09 01:30:28.497749Z] Running install step. 18:30:28 INFO - Running pre-action listener: _resource_record_pre_action 18:30:28 INFO - Running main action method: install 18:30:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:28 INFO - Reading from file tmpfile_stdout 18:30:28 INFO - Detecting whether we're running mozinstall >=1.0... 18:30:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:30:28 INFO - Reading from file tmpfile_stdout 18:30:28 INFO - Output received: 18:30:28 INFO - Usage: mozinstall [options] installer 18:30:28 INFO - Options: 18:30:28 INFO - -h, --help show this help message and exit 18:30:28 INFO - -d DEST, --destination=DEST 18:30:28 INFO - Directory to install application into. [default: 18:30:28 INFO - "/builds/slave/test"] 18:30:28 INFO - --app=APP Application being installed. [default: firefox] 18:30:28 INFO - mkdir: /builds/slave/test/build/application 18:30:28 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'] 18:30:28 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 18:30:44 INFO - Reading from file tmpfile_stdout 18:30:44 INFO - Output received: 18:30:44 INFO - /builds/slave/test/build/application/firefox/firefox 18:30:44 INFO - Running post-action listener: _resource_record_post_action 18:30:44 INFO - [mozharness: 2016-08-09 01:30:44.997782Z] Finished install step (success) 18:30:44 INFO - [mozharness: 2016-08-09 01:30:44.998028Z] Running run-tests step. 18:30:44 INFO - Running pre-action listener: _resource_record_pre_action 18:30:44 INFO - Running main action method: run_tests 18:30:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:30:45 INFO - Python 2.7.3 18:30:45 INFO - Return code: 0 18:30:45 INFO - grabbing minidump binary from tooltool 18:30: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')]} 18:30:45 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 0x2c14570>, '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 0x2c15470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c15900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:30:45 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 18:30:45 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 18:30:45 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 18:30:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:30:45 INFO - Return code: 0 18:30:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:30:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:30:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:30:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:30:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:30:45 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/R9vVG6J1QmyWht2a_kGOtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:30:45 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/R9vVG6J1QmyWht2a_kGOtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:30:45 INFO - Using env: {'DISPLAY': ':0', 18:30:45 INFO - 'HOME': '/home/cltbld', 18:30:45 INFO - 'LANG': 'en_US.UTF-8', 18:30:45 INFO - 'LANGUAGE': 'en_US:en', 18:30:45 INFO - 'LOGNAME': 'cltbld', 18:30:45 INFO - 'MAIL': '/var/mail/cltbld', 18:30:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:30:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:45 INFO - 'MOZ_NO_REMOTE': '1', 18:30:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:45 INFO - 'NO_EM_RESTART': '1', 18:30:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:45 INFO - 'PWD': '/builds/slave/test', 18:30:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:30:45 INFO - 'SHELL': '/bin/bash', 18:30:45 INFO - 'SHLVL': '1', 18:30:45 INFO - 'TERM': 'linux', 18:30:45 INFO - 'TMOUT': '86400', 18:30:45 INFO - 'USER': 'cltbld', 18:30:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120', 18:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:45 INFO - '_': '/tools/buildbot/bin/python'} 18:30:45 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/R9vVG6J1QmyWht2a_kGOtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:30:45 INFO - mozversion application_buildid: 20160808161220 18:30:45 INFO - mozversion application_changeset: 5ff96be046af749644327f75b21ce9437d766886 18:30:45 INFO - mozversion application_display_name: Nightly 18:30:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:30:45 INFO - mozversion application_name: Firefox 18:30:45 INFO - mozversion application_remotingname: firefox 18:30:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:30:45 INFO - mozversion application_vendor: Mozilla 18:30:45 INFO - mozversion application_version: 51.0a1 18:30:45 INFO - mozversion platform_buildid: 20160808161220 18:30:45 INFO - mozversion platform_changeset: 5ff96be046af749644327f75b21ce9437d766886 18:30:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:30:45 INFO - mozversion platform_version: 51.0a1 18:30:45 INFO - using testdate: 1470706245 18:30:45 INFO - actual date: 1470706245 18:30:45 INFO - starting webserver on 'localhost:50204' 18:30:45 INFO - SUITE-START | Running 2 tests 18:30:45 INFO - TEST-START | dromaeo_css 18:30:45 INFO - operating with platform_type : linux_ 18:30:45 INFO - Initialising browser for dromaeo_css test... 18:30:45 INFO - TEST-INFO | started process 13095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpru7aJe/profile http://localhost:50204/getInfo.html) 18:30:50 INFO - PROCESS | 13095 | __metrics Screen width/height:1600/1200 18:30:50 INFO - PROCESS | 13095 | colorDepth:24 18:30:50 INFO - PROCESS | 13095 | Browser inner width/height: 1024/697 18:30:50 INFO - PROCESS | 13095 | __metrics 18:30:50 ERROR - PROCESS | 13095 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 18:30:51 INFO - TEST-INFO | 13095: exit 0 18:30:51 INFO - Browser initialized. 18:30:51 INFO - Running cycle 1/1 for dromaeo_css test... 18:30:51 INFO - TEST-INFO | started process 13213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpru7aJe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:31:03 INFO - PROCESS | 13213 | RSS: Main: 164773888 18:31:03 INFO - PROCESS | 13213 | 18:31:53 INFO - PROCESS | 13213 | 1470706313226 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] 18:34:05 INFO - PROCESS | 13213 | Cycle 1(1): loaded http://localhost:50204/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50204/tests/dromaeo/cssquery-ext.html) 18:34:06 INFO - PROCESS | 13213 | RSS: Main: 167038976 18:34:06 INFO - PROCESS | 13213 | 18:37:08 INFO - PROCESS | 13213 | Cycle 1(1): loaded http://localhost:50204/tests/dromaeo/cssquery-ext.html (next: http://localhost:50204/tests/dromaeo/cssquery-jquery.html) 18:37:09 INFO - PROCESS | 13213 | RSS: Main: 167006208 18:37:09 INFO - PROCESS | 13213 | 18:40:11 INFO - PROCESS | 13213 | Cycle 1(1): loaded http://localhost:50204/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50204/tests/dromaeo/cssquery-mootools.html) 18:40:12 INFO - PROCESS | 13213 | RSS: Main: 170516480 18:40:12 INFO - PROCESS | 13213 | 18:43:13 INFO - PROCESS | 13213 | Cycle 1(1): loaded http://localhost:50204/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50204/tests/dromaeo/cssquery-prototype.html) 18:43:14 INFO - PROCESS | 13213 | RSS: Main: 165117952 18:43:14 INFO - PROCESS | 13213 | 18:46:17 INFO - PROCESS | 13213 | Cycle 1(1): loaded http://localhost:50204/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50204/tests/dromaeo/cssquery-yui.html) 18:46:17 INFO - PROCESS | 13213 | RSS: Main: 166789120 18:46:17 INFO - PROCESS | 13213 | 18:49:20 INFO - PROCESS | 13213 | Cycle 1(1): loaded http://localhost:50204/tests/dromaeo/cssquery-yui.html (next: http://localhost:50204/tests/dromaeo/cssquery-dojo.html) 18:49:21 INFO - PROCESS | 13213 | RSS: Main: 170737664 18:49:21 INFO - PROCESS | 13213 | 18:49:21 INFO - PROCESS | 13213 | __start_tp_report 18:49:21 INFO - PROCESS | 13213 | _x_x_mozilla_page_load 18:49:21 INFO - PROCESS | 13213 | _x_x_mozilla_page_load_details 18:49:21 INFO - PROCESS | 13213 | |i|pagename|runs| 18:49:21 INFO - PROCESS | 13213 | |0;dojo.html;2663.1877277430385;2672.0647773279366;2691.7442842929922;2703.607976843358;2716;4658.487566367697;4846.4668886422505;4854.781534830932;4869.805207791684;4907.190313598252;4731.219348807451;4797.208460603996;4800.519948005198;4808.807647694097;4834.516548345164;4459.197344477992;4459.26422140348;4471.731696098228;4537.591616754491;4599.494055653892;4430.5790949859875;4485.887852803673;4487.528809475007;4501.189785838547;4558.111168322179;4486.8878278042985;4531.637469002472;4535.523770004152;4540.659450541206;4543.023250001249;4289.056407590325;4362.040351122748;4428.136513379892;4478.104379124188;4489.4612646482465;4366.847160349373;4408.669349798746;4420.160169567804;4460.107978404332;4465.68740188187;4801.615870730333;4822.951770482286;4839.709617422931;4842.951570484285;4843.75781210938;5001.874953126165;5120.18077107661;5193.350831146106;5203.375594928595;5228.058949389108;5188.7146206958605;5198.376194856642;5245.31810864589;5275.129603615399;5286.65636733615;4865.5864251538305;4868.951310486886;4870.464248932614;4876.634252431047;4913.31213630092;5066.544011039025;5203.089459344599;5356.143017117321;5360.865978350573;5376.516113549721;5063.088644044107;5073.847784566469;5098.694078355311;5104.846854594368;5110.97444512775;5205;5209.557187639018;5213.45258747826;5218.530332270114;5259.947400525945;4900.044491324157;4997.450280469146;5164.173732202829;5166.948330516647;5170.40540337866;5140.974295128501;5145.382554093533;5155.149400348975;5160.329157209539;5212.609054320941;4452.398926144929;4452.638258115167;4461.933071003938;4462.9776851116185;4497.707649002869;3726.5900750917376;3775.3770627846648;3801.4297855321925;3880.708946828999;3899.7660140391667;4463.174312752087;4466.352378905106;4476.7090139140855;4487.685861989629;4503.279475284005;5175.120229560984;5201.765920533585;5225.372955245395;5231.110711179109;5234.712090834964;4293.055527783882;4418.226810308183;4459.7993090310365;4461.04087621163;4490.124425737015;4706.058788242297;4728.05438912219;4745.715257084586;4772.212584923449;4792.041591681608;4870.342503762017;4886.877828054327;4894.412670479565;4895.314655948241;4918.827841025547;5012.899742005066;5123.462036486116;5182.948170518246;5245.0558899398475;5265.6840589564745;4814.566688998007;4867.683600565952;4887.535684110004;4896.90206195867;4912.828051018198;5126.743662816919;5127.87180320495;5135.666181698178;5138.972205558978;5184.222366645034;4984.053029924303;5168.612354073534;5191.065608190411;5202.557782588522;5215.243789650555;5060.418051923929;5072.5688316493515;5105.642605017613;5108.642395032312;5123.001014802227;5089.033083714083;5095.974520127375;5098.872528186825;5101.234814777813;5150.536451719363;4705.64707646921;4901.411830580353;4991.301217829434;4992.950070499393;5004.149294619996;5027.296178535081;5109.259157422079;5110.744462776921;5134.948650513447;5145.279660847559;5000.449950505515;5000.699958002531;5019.3976722793495;5027.396712394389;5070.062038522885 18:49:21 INFO - PROCESS | 13213 | |1;ext.html;514.1850167484534;552.8203333916479;555.1561626327981;570.2472735988496;570.4580648384036;38727;40011.19977600446;40076;40145.59854401455;44031.779841100826;41309.58690413095;41871.79064104683;41894.79052604733;41913.37129943046;42091.579084209225;7684.308412242911;7817.413693972946;7838.255365740246;7841.137474877759;7845.843083138334;7724.266194711493;7789.805254868617;7816.960915195416;7818.960905195466;7830.843383132334;7437.4421918356065;7508.662110205027;7533.096028476591;7543.585102819343;7547.094348678166;7825.8826117608;7831.608419579026;7835.804104897366;7843.882341764878;7872.291493765531;7804.297613214781;7857.724979625686;7877.094134174586;7878.330341920943;7882.369410447208;39231.8038409809;39793.60206397957;39840.40239396411;39859.80070099631;40027.59972400268;3100.302431952815;3253.056613582058;3285.211549228192;3385.18755498681;3502.859885604573;29877.402451951057;30109;30235.395292094036;30256.8487157565;31098.37803243945;3352.6312105668358;3361.6806403391884;3369.983150084234;3373.207296285371;3455.775374600668;257880;258122;259380;260670;260914;52714;53125.20312195243;53221.46778532243;53221.73389133107;53241.467585324426;32133.35733285321;32737.508937365958;32856.50715239273;34636.13409664779;34641.48037779435;14306.284685765879;14488.565343039725;14571.41714331415;14575.854241457662;14612;10895.727606809734;10968.287061340987;10977.066949309397;10989.560417583367;11017.889821101846;17740;17814.10929453522;17818.198181081883;17952.102394880203;18000.459986200436;6989.930100698928;7095.680694368766;7102.644867756591;7138.714451421989;7139.6434677411125;762.4586543554028;864.6109250837148;887.0818702642733;889.3063410539789;982.6462473509531;28214.43571128607;28239.57640635392;28386.574201386997;28730.281742956595;28966;866.9306455483546;952.7475219066953;977.7213494154132;985.9260555458226;1071.8017166824163;14964.850351496345;15033.173175475235;15064.171470569005;15182.316795744218;15226.390944362323;399038;400634;401219;401868;402855;49487.505124949006;49750.253746193834;50044.249336259985;50339.24491132636;50369;1002.3234316836107;1144.5250221158292;1179.5222934711455;1187.0207079159554;1189.9286042837457;26524.867375662998;27505.86247068752;27554.724452756018;28430.289242768267;28480.85759571189;43315.35026974661;43508;43512.564874352116;43545.78227108844;43613;353534;353644;353658;353750;356673;24841.50316993614;25056.749432505443;25232.612206328093;25572.360690982874;25604.103856364938;41548.79225603853;42100.789496052326;42724;42907;43217;36151.81924090363;36959;37040.25919481649;38167.618323817514;38188.42717359297;36590.451143233404;36648.45027324645;36909.07727306731;37564.81217593895;37985.24029519339;35228;35337.82331088328;36258.456123157644;36328.09179770527;36396;31828.36343273075;33674;33855;34095.488567672;34295.82852085823;25519.87240063788;25771.871140644176;26171.476570468105;26909.730902691506;27467.450650987266 18:49:21 INFO - PROCESS | 13213 | |2;jquery.html;344.6484585722562;347.82261046866097;353.16476532999457;366.72129181821805;367.36262584416033;16067.437639682614;16910.83089169108;17709.645807083867;17793.644127117448;17801.287948482077;14867.256637168153;15700.764488532652;15761.921190394061;15848.603784905383;15865.206739663;4928.1129396708575;5106.285120083191;5143.408508021588;5144.794208231666;5154.304168937202;3766.8681596144;5120.257562653432;5174.66364686296;5731.742071606767;5964.612300200495;6048.39516048396;6072.7874524391655;6082.787102451415;6090.299615544225;6091.329953705089;5955.672438015908;6052.092186172087;6081.939180608181;6097.146399504073;6098.57309988301;5133.281340612317;5324.307839980777;5331.813386531453;5333.146696528575;5338.225957236218;20936.685949710765;21254.468638284012;21533.56932861334;21593.136274549;21781.34655960308;1940.6894896816582;1953.915576854845;2041.3263623004373;2085.8122768950866;2230.131667371873;13761.587152385444;13773.862261377459;13860.306984650728;14171.716565668628;14300.856991430057;1740.1125426032816;1781.7060185069577;1795.1473050301001;1825.607494388713;1828.5520047588425;67976;69048.30951690469;69191.65404172997;69387;69529.30470695278;8186.426950113554;8701.47791132534;8744.300455963508;8799.29605631548;8969.461832290084;11322.886771132184;11372.14708896836;11380.601678941197;11389.487473063731;11426.600068997544;6752.696128674222;6861.828454288683;6885.345892140239;7084.185318688416;7102.112235970504;7044.788656340318;7082.92917070833;7278.09023872016;7282.417406607458;7331.596762178131;3435.587729472479;3623.2934577757082;3643.9635603644156;3732.122951106488;3837.3668344723364;1664.459050808492;1711.1615308498995;1726.1628110366462;1738.2438639191992;1770.7166853303668;362.49251048532267;381.2165998872344;772.1043589436339;773.9071311442663;833.8784335069322;10126.493675316206;10406.219533535015;10875.891241087487;11049;11197.384143872165;393.9133390654051;400.36741947722527;402.60946881524876;408.075708520202;409.31848472293296;5690.829275121753;5893.882122357614;5916.2013128228;5943.494802941798;5982.1325907744;372220;378051;416767;430892;430955;81441.59279203566;81775;82482.58758706288;83607;84086;414.1158626332741;426.06266214327985;426.44562069310393;426.69917708015777;427.322693530751;10101.898981010096;10111.696649100539;10234.948825255826;10312.896871031193;10397.896021039693;27613.861930691022;34498;37818.81090594529;38518.614813851505;38660.80669596634;51599.226011609106;54692.45307546874;55971.72014140066;56352.71823640855;57285.71357143188;7690.846183076195;7743.225677432437;7896.210378962058;7944.6424910877995;8085.191480851868;10380.48097595102;11242.606508772154;11717;12234.75530489403;12326.137170397986;9283.814323713623;9377.953110234404;9528.52357382142;10125.64560240388;10459.94770026145;7611.657475413509;10652.680419587425;10663.626773062906;10686.89313106859;10766.46167691628;10489.265751397634;10752.354858708502;10895.462722366517;11104.774844912754;11110.44447777624;7757;7832.451728378959;7870.606469676379;7887.369010479033;7997;7913.9604301978125;10152.340097893613;10184.694459166238;10187;10213.978602139727 18:49:21 INFO - PROCESS | 13213 | |3;mootools.html;1327.575175943698;1348.2584578481833;1420.2117824607344;1646.3908353909055;1668.7914010748657;6590.143281373426;7285.672144753486;7312.744053958106;7915.4854934429295;7940.04719433668;7618.4286178536695;7682.1549629540705;7697.191794861543;7711.961440192791;7718.536887786737;2080;2110.873347599149;2116.2169997101096;2122.034474314191;2129.55279391328;2058.6294466995937;2074.3051077888927;2150.860194087379;2163.556470923457;2166.306781829815;2128.4466038829937;2134.4557137929805;2145.6459684152096;2154.2890846020855;2165.8700477971292;2107.7681455039933;2110.767815540289;2110.8522403431766;2112.6302896993043;2114.7990940860595;2020.1515363547346;2090.4146838885135;2093.5080256139795;2101.2750601042617;2112.345172996361;7771.339436147934;7796.844063118762;7796.922030779676;7803.1416544180665;7821.608919554;4251.744895306291;4270.658347332206;4281.05816720321;4286.39990401344;4422.933655995163;2707.5667893137;2760.2271364018106;2786.3452088759127;2802.425502771927;2876.3384421582946;832.8084540555645;877.9648814047431;884.4869975414244;889.3952112563454;891.8974317953454;10437.68686939393;10493.265471417004;10501.789964200672;10549.525271362807;10557.102646275076;3800.4869342638945;3916.8433262669746;4048.4939382577177;4068.816903239361;4080.510338759368;9049.909500904907;9075.727728168165;9081.59132839024;9096.545172741337;9138.406003609876;4226.915461690811;4251.256030194703;4307.935380969288;4311.698181127354;4316.050468896838;3402.4726167444087;3835.0987517933263;3909.2963266612282;3923.7449565778134;3933.331333673282;3515.191505953594;3548.1661809474754;3616.222512159898;3640.745147839679;3708.740388172802;1102.7518808268076;1105.4086063955745;1117.1900372230068;1121.7027487715761;1123.6852084705533;621.5152181298595;643.5527308520533;683.5693513086823;694.7151667816272;719.129852878013;4943.826966056171;4945.208766597327;5029.924551131736;5030.4215015272985;5090.745462726849;392.95088113985753;398.14994985705727;401.08352414732195;412.80598118884075;416.0223474834116;3394.3890099781784;3396.896008797151;3452.5511683480986;3459.896203113911;3512.7892326460496;8977.147171018743;9392.06079392069;9464.19554337889;9493;9500.42997420157;9443.669471568463;9445.19715824149;9446.669366572138;9447.669331573363;9455.054494550628;7233.710651573878;7287.890681639779;7328.047353843966;7331.926680733124;7333.743318983917;4931.802727890844;4956.727379994135;4997.525235102659;5014.824481143142;5157.690538567698;8586.742397728078;8704.956475217838;8745.300375970035;8827.602757875782;8866.911330886867;8665.220130188314;8833.469991800512;8838.690645827364;8930.464172149692;8972.564389697616;5549.805756798492;6201;6261.8747625046335;6390.041493775971;6525.3800888915475;6850.314968503109;6899.103116594811;6912.861742765217;6917.965410172917;6921.515493915377;6152.692365381802;6154.969225154025;6268.404501572343;6295.213098362705;6368.872622547616;6256.530760192913;6268.561200715906;6277.18396608438;6326.6520341381665;6337.36626337381;5608.10270356741;5699.601027928005;5704.971475142598;5725.8568535786935;5732.713364331683;4352.390665306796;4371.759553224603;4409.096135292321;4423.137488189772;4515.819367225406;4368.170047690928;4398.164348773723;4428.557144285674;4495.651304608539;4597.839075632337 18:49:21 INFO - PROCESS | 13213 | |4;prototype.html;283.40202173414093;288.4375467837716;293.73710529076493;296.0983804315858;296.94654962106824;4908.631852611051;5054.646174767768;5122.436531981479;5183.300254465646;5204.687718736878;4966.304717339575;5059;5081.771320290586;5088.949110508894;5093.6943783372935;4008.5790991945864;4013.7391069580385;4021.336479480882;4021.939670904939;4026.4966879140106;3915.1190982028957;3979.5025621797276;3993.600639936012;3994.48071750672;4011.498562679665;3904.511936007999;3925.450436938831;3926.82329295181;3928.2536318099615;3974.066094467812;3938.326211360175;3949.526056873165;3952.7628342299554;3975.1056012397266;3988.162485877969;3492.161881148506;3521.3485505181366;3526.6297038810812;3528.153243221608;3528.8764893228613;4888.633352498577;4967.286286231244;4972.279019542182;4992.925106123411;5064.164412871872;4497.123061003105;4500.167469018242;4507.932381014288;4519.118771839492;4537.954620453786;5328.573714102901;5338.279332290169;5374.602603323125;5383.650062745948;5396.136618141118;3690.741648084635;3776.3580191367532;3793.468914351993;3821.541415030214;3845.1732877431205;5538.667679939176;5580.637258578179;5582.609217354787;5582.972085139549;5612.550995920316;3951.920961580752;3961.6632586230494;3965.2466031453932;3973.6225058619384;3977.661898738582;3811.198768904853;4021.8994525137105;4022.2357752027606;4023.979880100581;4024.1146947671464;4533.274676051816;4533.32000199966;4571.977140114278;4589.862304130881;4595.586397224266;5387.622866399314;5398.514133727984;5412.972935135299;5448.155535891943;5448.264484294648;1289.0847498276328;1350.7636163671318;1363.8158848555317;1368.2884899852022;1384.3977869626544;932.8880534335923;937.1237892570468;956.3879117364892;960.9759756006156;964.9083337082966;4608.539146085364;4637.304404339376;4637.350770892078;4656.32483289921;4663.160631086369;5484.396716361197;5494.313210848644;5500.22996780451;5512.586556008235;5516.972415137899;4410.735355878657;4614.869357007555;4622.95377046232;4632.953670463319;4640.907181856412;2552.591585346373;2578.7034491033396;2589.210290861268;2599.583227141213;2616.659834221539;4562.634989200856;4577.977110114494;4593.955689718044;4609.562091601292;4613.63897650194;4885.145099607555;4909.2881532177635;4956.975215123901;5009.699418034929;5202.583793296527;5159.871003224875;5161.535461808456;5171.974140129275;5179.430262671179;5186.688798672092;5515.834524964257;5532.2254884315425;5544.251526044094;5554.305711786027;5556.332680548358;5178.9444227905715;5371.516563509303;5374;5375.489328513785;5429.375621803543;5169.948300517097;5173.92239116406;5182.481751824787;5183.81856635016;5204.34945631796;3759.3984962405884;3811.5045044144085;3822.8279727411777;3831.7892515911894;3843.135294558702;5333.973330133324;5523.4200408956485;5532.391436941853;5532.778688852401;5562.276904002454;5268.394134674408;5304.28392167068;5319.547838433622;5356.276902618252;5368.9463105370005;5310.654807437504;5351.598630102836;5355.4376790436445;5361.220339660452;5371.677699338053;5005.499450054966;5268.2361057647195;5306.204069389622;5311.49540793624;5333.919991200212;5438.981365342273;5442.918356224581;5453.618246722692;5468.207109968953;5478.671564584955;5103.617228707788;5274.4198138204;5292.9735351323;5347.919781203207;5366.785328586969 18:49:21 INFO - PROCESS | 13213 | |5;yui.html;574.6494638270655;681.5297444763113;710.9111361079865;722.8301349182941;756.5120497279253;12303.138780285384;12871.420786064626;13004.349782510872;13044.347782610866;14837.25813709313;13613.115147515404;13932.233727145003;14163.716725665507;14186.858131418683;14192;754.7018927523638;779.9938079876952;782.7143092771126;782.8199514111758;782.9647665855022;630.272035798651;740.1155619035255;759.2445516710853;761.478387304698;767.2902565127235;811.4806523824757;811.9797005074861;813.6297984417106;816.1308206759782;817.6851912013858;812.7683610171102;813.32494029955;814.6944895664126;815.1848151848152;815.3192084609358;593.2051051590846;594.5095296380504;594.9643021418685;594.9910751338733;595.4551585299446;13129.60611181666;13230.536931207458;13231;13233.933830330787;13247.271400072992;13121.278329691862;13236.470541178342;13292.867071329356;13468.865311346859;13537.526186583422;11207.60773372928;11269.887301127048;11319.151063670257;11338.489767960462;11379.374134422604;3242.481203007531;3266.5100234964707;3298.884539041122;3304.074859039473;3379.0538649178025;54324.72837635787;55867.44132558663;56058.71970640121;70895;71276.64361678211;9973.950130249448;10448.216383771247;10490.423026733602;10706.46467676613;10715.892841071645;18134.365297214536;18211.908940455214;18385;18423.170957306953;18469.168887400097;6852.211995620468;6926.930730692729;6936.930630693629;6992.056072430157;7017.193022802341;3652.680547852133;3844.4809950656304;3858.9614103858603;3923.097687531884;3975.224831157954;2879.1650421377985;2998.14552852436;3191.569138166364;3349.547811045478;3354.8993530194134;511.8131881863168;513.1481740311066;523.6099106165855;525.0811080608935;527.941926388097;437.3680032353219;448.81149917034924;478.80847660935206;508.7913955278318;547.9397266300704;7782.6886924523515;7912.762617121495;7950.920490795133;8263.710770123138;8421.24208821209;490.2132078014806;509.8648858052619;526.2579762534807;530.7792078220078;532.4515748778764;3688.7233457490797;3745.6254374562327;3755.605661405568;3779.7526816150603;3966.861159859391;58853.41146588565;59036.11445828316;60562.09156862651;72763;105373.47313263538;80682;87606.56196718976;87719.12280877109;88466;88547.55726221327;48082;48252.5174748255;48406.51593484091;48954.51045489571;54273;6905.091050134824;7181.569105853666;7331.78004659861;7378.790226251598;7445.478816482794;47697;48318.27522587094;48769.2684609724;49103.26345104755;49789.502104978485;38708.41937370998;40047.799761001006;40157.196856063296;67795.32204678087;68701;9715.854262186214;9785.461799601091;9831.164351029956;9903.108720215216;9932.602695892083;10731.40977246259;10953.616623418142;10980.615678451215;11123.72190695239;11448.725175721573;10416.376825996344;10556.788864222826;10766.569337226423;10834.566617335533;11064.059554937921;10438.791224175626;10563.260571759904;10603.780565234789;10950.178736594946;10998.505067271832;9704.660336888175;9936.801263974825;9951.751206219902;10074.14369778577;10294.639687610897;8323;8591.31269498426;8675.436096653697;8773.517456539952;9088.954555227181;8691.913080869363;8726.476411415335;8979.551022448983;9414.15272625467;9483.478408687588 18:49:21 INFO - PROCESS | 13213 | __end_tp_report 18:49:21 INFO - PROCESS | 13213 | __start_cc_report 18:49:21 INFO - PROCESS | 13213 | _x_x_mozilla_cycle_collect,367 18:49:21 INFO - PROCESS | 13213 | __end_cc_report 18:49:21 INFO - PROCESS | 13213 | __startTimestamp1470707361111__endTimestamp 18:49:21 INFO - PROCESS | 13213 | 18:49:21 INFO - PROCESS | 13213 | ------- Summary: start ------- 18:49:21 INFO - PROCESS | 13213 | Number of tests: 6 18:49:21 INFO - PROCESS | 13213 | 18:49:21 INFO - PROCESS | 13213 | [#0] dojo.html Cycles:165 Average:4794.63 Median:4900.04 stddev:504.50 (10.3%) stddev-sans-first:477.54 18:49:21 INFO - PROCESS | 13213 | Values: 2663.2 2672.1 2691.7 2703.6 2716.0 4658.5 4846.5 4854.8 4869.8 4907.2 4731.2 4797.2 4800.5 4808.8 4834.5 4459.2 4459.3 4471.7 4537.6 4599.5 4430.6 4485.9 4487.5 4501.2 4558.1 4486.9 4531.6 4535.5 4540.7 4543.0 4289.1 4362.0 4428.1 4478.1 4489.5 4366.8 4408.7 4420.2 4460.1 4465.7 4801.6 4823.0 4839.7 4843.0 4843.8 5001.9 5120.2 5193.4 5203.4 5228.1 5188.7 5198.4 5245.3 5275.1 5286.7 4865.6 4869.0 4870.5 4876.6 4913.3 5066.5 5203.1 5356.1 5360.9 5376.5 5063.1 5073.8 5098.7 5104.8 5111.0 5205.0 5209.6 5213.5 5218.5 5259.9 4900.0 4997.5 5164.2 5166.9 5170.4 5141.0 5145.4 5155.1 5160.3 5212.6 4452.4 4452.6 4461.9 4463.0 4497.7 3726.6 3775.4 3801.4 3880.7 3899.8 4463.2 4466.4 4476.7 4487.7 4503.3 5175.1 5201.8 5225.4 5231.1 5234.7 4293.1 4418.2 4459.8 4461.0 4490.1 4706.1 4728.1 4745.7 4772.2 4792.0 4870.3 4886.9 4894.4 4895.3 4918.8 5012.9 5123.5 5182.9 5245.1 5265.7 4814.6 4867.7 4887.5 4896.9 4912.8 5126.7 5127.9 5135.7 5139.0 5184.2 4984.1 5168.6 5191.1 5202.6 5215.2 5060.4 5072.6 5105.6 5108.6 5123.0 5089.0 5096.0 5098.9 5101.2 5150.5 4705.6 4901.4 4991.3 4993.0 5004.1 5027.3 5109.3 5110.7 5134.9 5145.3 5000.4 5000.7 5019.4 5027.4 5070.1 18:49:21 INFO - PROCESS | 13213 | 18:49:21 INFO - PROCESS | 13213 | [#1] ext.html Cycles:180 Average:48779.64 Median:36999.63 stddev:90531.60 (244.7%) stddev-sans-first:90713.04 18:49:21 INFO - PROCESS | 13213 | Values: 514.2 552.8 555.2 570.2 570.5 38727.0 40011.2 40076.0 40145.6 44031.8 41309.6 41871.8 41894.8 41913.4 42091.6 7684.3 7817.4 7838.3 7841.1 7845.8 7724.3 7789.8 7817.0 7819.0 7830.8 7437.4 7508.7 7533.1 7543.6 7547.1 7825.9 7831.6 7835.8 7843.9 7872.3 7804.3 7857.7 7877.1 7878.3 7882.4 39231.8 39793.6 39840.4 39859.8 40027.6 3100.3 3253.1 3285.2 3385.2 3502.9 29877.4 30109.0 30235.4 30256.8 31098.4 3352.6 3361.7 3370.0 3373.2 3455.8 257880.0 258122.0 259380.0 260670.0 260914.0 52714.0 53125.2 53221.5 53221.7 53241.5 32133.4 32737.5 32856.5 34636.1 34641.5 14306.3 14488.6 14571.4 14575.9 14612.0 10895.7 10968.3 10977.1 10989.6 11017.9 17740.0 17814.1 17818.2 17952.1 18000.5 6989.9 7095.7 7102.6 7138.7 7139.6 762.5 864.6 887.1 889.3 982.6 28214.4 28239.6 28386.6 28730.3 28966.0 866.9 952.7 977.7 985.9 1071.8 14964.9 15033.2 15064.2 15182.3 15226.4 399038.0 400634.0 401219.0 401868.0 402855.0 49487.5 49750.3 50044.2 50339.2 50369.0 1002.3 1144.5 1179.5 1187.0 1189.9 26524.9 27505.9 27554.7 28430.3 28480.9 43315.4 43508.0 43512.6 43545.8 43613.0 353534.0 353644.0 353658.0 353750.0 356673.0 24841.5 25056.7 25232.6 25572.4 25604.1 41548.8 42100.8 42724.0 42907.0 43217.0 36151.8 36959.0 37040.3 38167.6 38188.4 36590.5 36648.5 36909.1 37564.8 37985.2 35228.0 35337.8 36258.5 36328.1 36396.0 31828.4 33674.0 33855.0 34095.5 34295.8 25519.9 25771.9 26171.5 26909.7 27467.5 18:49:21 INFO - PROCESS | 13213 | 18:49:21 INFO - PROCESS | 13213 | [#2] jquery.html Cycles:180 Average:24551.30 Median:397.14 stddev:67298.24 (16945.7%) stddev-sans-first:67462.49 18:49:21 INFO - PROCESS | 13213 | Values: 344.6 347.8 353.2 366.7 367.4 16067.4 16910.8 17709.6 17793.6 17801.3 14867.3 15700.8 15761.9 15848.6 15865.2 4928.1 5106.3 5143.4 5144.8 5154.3 3766.9 5120.3 5174.7 5731.7 5964.6 6048.4 6072.8 6082.8 6090.3 6091.3 5955.7 6052.1 6081.9 6097.1 6098.6 5133.3 5324.3 5331.8 5333.1 5338.2 20936.7 21254.5 21533.6 21593.1 21781.3 1940.7 1953.9 2041.3 2085.8 2230.1 13761.6 13773.9 13860.3 14171.7 14300.9 1740.1 1781.7 1795.1 1825.6 1828.6 67976.0 69048.3 69191.7 69387.0 69529.3 8186.4 8701.5 8744.3 8799.3 8969.5 11322.9 11372.1 11380.6 11389.5 11426.6 6752.7 6861.8 6885.3 7084.2 7102.1 7044.8 7082.9 7278.1 7282.4 7331.6 3435.6 3623.3 3644.0 3732.1 3837.4 1664.5 1711.2 1726.2 1738.2 1770.7 362.5 381.2 772.1 773.9 833.9 10126.5 10406.2 10875.9 11049.0 11197.4 393.9 400.4 402.6 408.1 409.3 5690.8 5893.9 5916.2 5943.5 5982.1 372220.0 378051.0 416767.0 430892.0 430955.0 81441.6 81775.0 82482.6 83607.0 84086.0 414.1 426.1 426.4 426.7 427.3 10101.9 10111.7 10234.9 10312.9 10397.9 27613.9 34498.0 37818.8 38518.6 38660.8 51599.2 54692.5 55971.7 56352.7 57285.7 7690.8 7743.2 7896.2 7944.6 8085.2 10380.5 11242.6 11717.0 12234.8 12326.1 9283.8 9378.0 9528.5 10125.6 10459.9 7611.7 10652.7 10663.6 10686.9 10766.5 10489.3 10752.4 10895.5 11104.8 11110.4 7757.0 7832.5 7870.6 7887.4 7997.0 7914.0 10152.3 10184.7 10187.0 10214.0 18:49:21 INFO - PROCESS | 13213 | 18:49:21 INFO - PROCESS | 13213 | [#3] mootools.html Cycles:180 Average:4937.25 Median:4937.81 stddev:2842.95 (57.6%) stddev-sans-first:2837.99 18:49:21 INFO - PROCESS | 13213 | Values: 1327.6 1348.3 1420.2 1646.4 1668.8 6590.1 7285.7 7312.7 7915.5 7940.0 7618.4 7682.2 7697.2 7712.0 7718.5 2080.0 2110.9 2116.2 2122.0 2129.6 2058.6 2074.3 2150.9 2163.6 2166.3 2128.4 2134.5 2145.6 2154.3 2165.9 2107.8 2110.8 2110.9 2112.6 2114.8 2020.2 2090.4 2093.5 2101.3 2112.3 7771.3 7796.8 7796.9 7803.1 7821.6 4251.7 4270.7 4281.1 4286.4 4422.9 2707.6 2760.2 2786.3 2802.4 2876.3 832.8 878.0 884.5 889.4 891.9 10437.7 10493.3 10501.8 10549.5 10557.1 3800.5 3916.8 4048.5 4068.8 4080.5 9049.9 9075.7 9081.6 9096.5 9138.4 4226.9 4251.3 4307.9 4311.7 4316.1 3402.5 3835.1 3909.3 3923.7 3933.3 3515.2 3548.2 3616.2 3640.7 3708.7 1102.8 1105.4 1117.2 1121.7 1123.7 621.5 643.6 683.6 694.7 719.1 4943.8 4945.2 5029.9 5030.4 5090.7 393.0 398.1 401.1 412.8 416.0 3394.4 3396.9 3452.6 3459.9 3512.8 8977.1 9392.1 9464.2 9493.0 9500.4 9443.7 9445.2 9446.7 9447.7 9455.1 7233.7 7287.9 7328.0 7331.9 7333.7 4931.8 4956.7 4997.5 5014.8 5157.7 8586.7 8705.0 8745.3 8827.6 8866.9 8665.2 8833.5 8838.7 8930.5 8972.6 5549.8 6201.0 6261.9 6390.0 6525.4 6850.3 6899.1 6912.9 6918.0 6921.5 6152.7 6155.0 6268.4 6295.2 6368.9 6256.5 6268.6 6277.2 6326.7 6337.4 5608.1 5699.6 5705.0 5725.9 5732.7 4352.4 4371.8 4409.1 4423.1 4515.8 4368.2 4398.2 4428.6 4495.7 4597.8 18:49:21 INFO - PROCESS | 13213 | 18:49:21 INFO - PROCESS | 13213 | [#4] prototype.html Cycles:180 Average:4400.20 Median:4966.80 stddev:1287.61 (25.9%) stddev-sans-first:1253.60 18:49:21 INFO - PROCESS | 13213 | Values: 283.4 288.4 293.7 296.1 296.9 4908.6 5054.6 5122.4 5183.3 5204.7 4966.3 5059.0 5081.8 5088.9 5093.7 4008.6 4013.7 4021.3 4021.9 4026.5 3915.1 3979.5 3993.6 3994.5 4011.5 3904.5 3925.5 3926.8 3928.3 3974.1 3938.3 3949.5 3952.8 3975.1 3988.2 3492.2 3521.3 3526.6 3528.2 3528.9 4888.6 4967.3 4972.3 4992.9 5064.2 4497.1 4500.2 4507.9 4519.1 4538.0 5328.6 5338.3 5374.6 5383.7 5396.1 3690.7 3776.4 3793.5 3821.5 3845.2 5538.7 5580.6 5582.6 5583.0 5612.6 3951.9 3961.7 3965.2 3973.6 3977.7 3811.2 4021.9 4022.2 4024.0 4024.1 4533.3 4533.3 4572.0 4589.9 4595.6 5387.6 5398.5 5413.0 5448.2 5448.3 1289.1 1350.8 1363.8 1368.3 1384.4 932.9 937.1 956.4 961.0 964.9 4608.5 4637.3 4637.4 4656.3 4663.2 5484.4 5494.3 5500.2 5512.6 5517.0 4410.7 4614.9 4623.0 4633.0 4640.9 2552.6 2578.7 2589.2 2599.6 2616.7 4562.6 4578.0 4594.0 4609.6 4613.6 4885.1 4909.3 4957.0 5009.7 5202.6 5159.9 5161.5 5172.0 5179.4 5186.7 5515.8 5532.2 5544.3 5554.3 5556.3 5178.9 5371.5 5374.0 5375.5 5429.4 5169.9 5173.9 5182.5 5183.8 5204.3 3759.4 3811.5 3822.8 3831.8 3843.1 5334.0 5523.4 5532.4 5532.8 5562.3 5268.4 5304.3 5319.5 5356.3 5368.9 5310.7 5351.6 5355.4 5361.2 5371.7 5005.5 5268.2 5306.2 5311.5 5333.9 5439.0 5442.9 5453.6 5468.2 5478.7 5103.6 5274.4 5293.0 5347.9 5366.8 18:49:21 INFO - PROCESS | 13213 | 18:49:21 INFO - PROCESS | 13213 | [#5] yui.html Cycles:180 Average:15978.99 Median:512.48 stddev:22081.23 (4308.7%) stddev-sans-first:22112.87 18:49:21 INFO - PROCESS | 13213 | Values: 574.6 681.5 710.9 722.8 756.5 12303.1 12871.4 13004.3 13044.3 14837.3 13613.1 13932.2 14163.7 14186.9 14192.0 754.7 780.0 782.7 782.8 783.0 630.3 740.1 759.2 761.5 767.3 811.5 812.0 813.6 816.1 817.7 812.8 813.3 814.7 815.2 815.3 593.2 594.5 595.0 595.0 595.5 13129.6 13230.5 13231.0 13233.9 13247.3 13121.3 13236.5 13292.9 13468.9 13537.5 11207.6 11269.9 11319.2 11338.5 11379.4 3242.5 3266.5 3298.9 3304.1 3379.1 54324.7 55867.4 56058.7 70895.0 71276.6 9974.0 10448.2 10490.4 10706.5 10715.9 18134.4 18211.9 18385.0 18423.2 18469.2 6852.2 6926.9 6936.9 6992.1 7017.2 3652.7 3844.5 3859.0 3923.1 3975.2 2879.2 2998.1 3191.6 3349.5 3354.9 511.8 513.1 523.6 525.1 527.9 437.4 448.8 478.8 508.8 547.9 7782.7 7912.8 7950.9 8263.7 8421.2 490.2 509.9 526.3 530.8 532.5 3688.7 3745.6 3755.6 3779.8 3966.9 58853.4 59036.1 60562.1 72763.0 105373.5 80682.0 87606.6 87719.1 88466.0 88547.6 48082.0 48252.5 48406.5 48954.5 54273.0 6905.1 7181.6 7331.8 7378.8 7445.5 47697.0 48318.3 48769.3 49103.3 49789.5 38708.4 40047.8 40157.2 67795.3 68701.0 9715.9 9785.5 9831.2 9903.1 9932.6 10731.4 10953.6 10980.6 11123.7 11448.7 10416.4 10556.8 10766.6 10834.6 11064.1 10438.8 10563.3 10603.8 10950.2 10998.5 9704.7 9936.8 9951.8 10074.1 10294.6 8323.0 8591.3 8675.4 8773.5 9089.0 8691.9 8726.5 8979.6 9414.2 9483.5 18:49:21 INFO - PROCESS | 13213 | -------- Summary: end -------- 18:49:21 INFO - PROCESS | 13213 | 18:49:21 INFO - TEST-INFO | 13213: exit 0 18:49:21 INFO - TEST-OK | dromaeo_css | took 1116694ms 18:49:21 INFO - TEST-START | kraken 18:49:21 INFO - operating with platform_type : linux_ 18:49:21 INFO - Initialising browser for kraken test... 18:49:21 INFO - TEST-INFO | started process 13465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzloHWN/profile http://localhost:50204/getInfo.html) 18:49:26 INFO - PROCESS | 13465 | __metrics Screen width/height:1600/1200 18:49:26 INFO - PROCESS | 13465 | colorDepth:24 18:49:26 INFO - PROCESS | 13465 | Browser inner width/height: 1024/697 18:49:26 INFO - PROCESS | 13465 | __metrics 18:49:27 ERROR - PROCESS | 13465 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 18:49:28 INFO - TEST-INFO | 13465: exit 0 18:49:28 INFO - Browser initialized. 18:49:28 INFO - Running cycle 1/1 for kraken test... 18:49:28 INFO - TEST-INFO | started process 13582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzloHWN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:49:40 INFO - PROCESS | 13582 | RSS: Main: 165126144 18:49:40 INFO - PROCESS | 13582 | 18:49:42 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:50204/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50204/tests/kraken/driver.html?testName=audio-beat-detection) 18:49:43 INFO - PROCESS | 13582 | RSS: Main: 170409984 18:49:43 INFO - PROCESS | 13582 | 18:49:46 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:50204/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50204/tests/kraken/driver.html?testName=audio-dft) 18:49:47 INFO - PROCESS | 13582 | RSS: Main: 169623552 18:49:47 INFO - PROCESS | 13582 | 18:49:50 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:50204/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50204/tests/kraken/driver.html?testName=audio-fft) 18:49:50 INFO - PROCESS | 13582 | RSS: Main: 165359616 18:49:50 INFO - PROCESS | 13582 | 18:49:53 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:50204/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50204/tests/kraken/driver.html?testName=audio-oscillator) 18:49:53 INFO - PROCESS | 13582 | RSS: Main: 166117376 18:49:53 INFO - PROCESS | 13582 | 18:49:55 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:50204/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50204/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:49:56 INFO - PROCESS | 13582 | RSS: Main: 166436864 18:49:56 INFO - PROCESS | 13582 | 18:49:59 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:50204/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50204/tests/kraken/driver.html?testName=imaging-darkroom) 18:50:00 INFO - PROCESS | 13582 | RSS: Main: 166821888 18:50:00 INFO - PROCESS | 13582 | 18:50:04 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:50204/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50204/tests/kraken/driver.html?testName=imaging-desaturate) 18:50:04 INFO - PROCESS | 13582 | RSS: Main: 163852288 18:50:04 INFO - PROCESS | 13582 | 18:50:07 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:50204/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50204/tests/kraken/driver.html?testName=json-parse-financial) 18:50:08 INFO - PROCESS | 13582 | RSS: Main: 165646336 18:50:08 INFO - PROCESS | 13582 | 18:50:09 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:50204/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50204/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:50:10 INFO - PROCESS | 13582 | RSS: Main: 165871616 18:50:10 INFO - PROCESS | 13582 | 18:50:12 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:50204/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50204/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:50:13 INFO - PROCESS | 13582 | RSS: Main: 165761024 18:50:13 INFO - PROCESS | 13582 | 18:50:15 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:50204/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50204/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:50:16 INFO - PROCESS | 13582 | RSS: Main: 166129664 18:50:16 INFO - PROCESS | 13582 | 18:50:18 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:50204/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:50:19 INFO - PROCESS | 13582 | RSS: Main: 166592512 18:50:19 INFO - PROCESS | 13582 | 18:50:22 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:50204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:50:22 INFO - PROCESS | 13582 | RSS: Main: 166727680 18:50:22 INFO - PROCESS | 13582 | 18:50:24 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:50204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50204/tests/kraken/driver.html?testName=ai-astar) 18:50:24 INFO - PROCESS | 13582 | RSS: Main: 167481344 18:50:24 INFO - PROCESS | 13582 | 18:50:24 INFO - PROCESS | 13582 | __start_tp_report 18:50:24 INFO - PROCESS | 13582 | _x_x_mozilla_page_load 18:50:24 INFO - PROCESS | 13582 | _x_x_mozilla_page_load_details 18:50:24 INFO - PROCESS | 13582 | |i|pagename|runs| 18:50:24 INFO - PROCESS | 13582 | |0;ai-astar;105;118;110;116;115;116;115;116;114;114 18:50:24 INFO - PROCESS | 13582 | |1;audio-beat-detection;161;124;147;193;122;155;150;128;183;134 18:50:24 INFO - PROCESS | 13582 | |2;audio-dft;165;162;164;178;165;165;164;165;165;163 18:50:24 INFO - PROCESS | 13582 | |3;audio-fft;77;75;77;177;76;77;78;75;156;78 18:50:24 INFO - PROCESS | 13582 | |4;audio-oscillator;87;86;149;85;86;86;137;85;85;142 18:50:24 INFO - PROCESS | 13582 | |5;imaging-gaussian-blur;118;117;118;118;118;118;117;117;119;118 18:50:24 INFO - PROCESS | 13582 | |6;imaging-darkroom;147;147;147;149;148;147;147;149;147;148 18:50:24 INFO - PROCESS | 13582 | |7;imaging-desaturate;95;97;95;96;95;96;96;96;96;96 18:50:24 INFO - PROCESS | 13582 | |8;json-parse-financial;62;63;64;63;66;62;63;63;63;65 18:50:24 INFO - PROCESS | 13582 | |9;json-stringify-tinderbox;65;65;66;67;65;65;65;65;66;66 18:50:24 INFO - PROCESS | 13582 | |10;stanford-crypto-aes;83;85;83;85;80;81;78;80;85;84 18:50:24 INFO - PROCESS | 13582 | |11;stanford-crypto-ccm;134;133;134;130;131;150;130;134;151;144 18:50:24 INFO - PROCESS | 13582 | |12;stanford-crypto-pbkdf2;170;169;166;169;171;170;174;171;173;165 18:50:24 INFO - PROCESS | 13582 | |13;stanford-crypto-sha256-iterative;69;68;71;68;70;69;69;67;69;68 18:50:24 INFO - PROCESS | 13582 | __end_tp_report 18:50:24 INFO - PROCESS | 13582 | __start_cc_report 18:50:24 INFO - PROCESS | 13582 | _x_x_mozilla_cycle_collect,928 18:50:24 INFO - PROCESS | 13582 | __end_cc_report 18:50:24 INFO - PROCESS | 13582 | __startTimestamp1470707424991__endTimestamp 18:50:24 INFO - PROCESS | 13582 | 18:50:25 INFO - PROCESS | 13582 | ------- Summary: start ------- 18:50:25 INFO - PROCESS | 13582 | Number of tests: 14 18:50:25 INFO - PROCESS | 13582 | 18:50:25 INFO - PROCESS | 13582 | [#0] ai-astar Cycles:10 Average:113.90 Median:115.50 stddev:3.75 (3.3%) stddev-sans-first:2.20 18:50:25 INFO - PROCESS | 13582 | Values: 105.0 118.0 110.0 116.0 115.0 116.0 115.0 116.0 114.0 114.0 18:50:25 INFO - PROCESS | 13582 | 18:50:25 INFO - PROCESS | 13582 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:152.50 stddev:24.25 (15.9%) stddev-sans-first:25.37 18:50:25 INFO - PROCESS | 13582 | Values: 161.0 124.0 147.0 193.0 122.0 155.0 150.0 128.0 183.0 134.0 18:50:25 INFO - PROCESS | 13582 | 18:50:25 INFO - PROCESS | 13582 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.00 stddev:4.48 (2.7%) stddev-sans-first:4.74 18:50:25 INFO - PROCESS | 13582 | Values: 165.0 162.0 164.0 178.0 165.0 165.0 164.0 165.0 165.0 163.0 18:50:25 INFO - PROCESS | 13582 | 18:50:25 INFO - PROCESS | 13582 | [#3] audio-fft Cycles:10 Average:94.60 Median:77.00 stddev:38.23 (49.7%) stddev-sans-first:40.02 18:50:25 INFO - PROCESS | 13582 | Values: 77.0 75.0 77.0 177.0 76.0 77.0 78.0 75.0 156.0 78.0 18:50:25 INFO - PROCESS | 13582 | 18:50:25 INFO - PROCESS | 13582 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:85.50 stddev:27.66 (32.4%) stddev-sans-first:28.75 18:50:25 INFO - PROCESS | 13582 | Values: 87.0 86.0 149.0 85.0 86.0 86.0 137.0 85.0 85.0 142.0 18:50:25 INFO - PROCESS | 13582 | 18:50:25 INFO - PROCESS | 13582 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 18:50:25 INFO - PROCESS | 13582 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 117.0 117.0 119.0 118.0 18:50:25 INFO - PROCESS | 13582 | 18:50:25 INFO - PROCESS | 13582 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 18:50:25 INFO - PROCESS | 13582 | Values: 147.0 147.0 147.0 149.0 148.0 147.0 147.0 149.0 147.0 148.0 18:50:25 INFO - PROCESS | 13582 | 18:50:25 INFO - PROCESS | 13582 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 18:50:25 INFO - PROCESS | 13582 | Values: 95.0 97.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 18:50:25 INFO - PROCESS | 13582 | 18:50:25 INFO - PROCESS | 13582 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.00 stddev:1.26 (2.0%) stddev-sans-first:1.24 18:50:25 INFO - PROCESS | 13582 | Values: 62.0 63.0 64.0 63.0 66.0 62.0 63.0 63.0 63.0 65.0 18:50:25 INFO - PROCESS | 13582 | 18:50:25 INFO - PROCESS | 13582 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 18:50:25 INFO - PROCESS | 13582 | Values: 65.0 65.0 66.0 67.0 65.0 65.0 65.0 65.0 66.0 66.0 18:50:25 INFO - PROCESS | 13582 | 18:50:25 INFO - PROCESS | 13582 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.50 stddev:2.50 (3.0%) stddev-sans-first:2.65 18:50:25 INFO - PROCESS | 13582 | Values: 83.0 85.0 83.0 85.0 80.0 81.0 78.0 80.0 85.0 84.0 18:50:25 INFO - PROCESS | 13582 | 18:50:25 INFO - PROCESS | 13582 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:134.00 stddev:8.10 (6.0%) stddev-sans-first:8.52 18:50:25 INFO - PROCESS | 13582 | Values: 134.0 133.0 134.0 130.0 131.0 150.0 130.0 134.0 151.0 144.0 18:50:25 INFO - PROCESS | 13582 | 18:50:25 INFO - PROCESS | 13582 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:170.50 stddev:2.78 (1.6%) stddev-sans-first:2.95 18:50:25 INFO - PROCESS | 13582 | Values: 170.0 169.0 166.0 169.0 171.0 170.0 174.0 171.0 173.0 165.0 18:50:25 INFO - PROCESS | 13582 | 18:50:25 INFO - PROCESS | 13582 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.14 (1.6%) stddev-sans-first:1.20 18:50:25 INFO - PROCESS | 13582 | Values: 69.0 68.0 71.0 68.0 70.0 69.0 69.0 67.0 69.0 68.0 18:50:25 INFO - PROCESS | 13582 | -------- Summary: end -------- 18:50:25 INFO - PROCESS | 13582 | 18:50:26 INFO - TEST-INFO | 13582: exit 0 18:50:26 INFO - TEST-OK | kraken | took 64125ms 18:50:26 INFO - SUITE-END | took 1180s 18:50:26 INFO - Completed test suite (00:19:40) 18:50:26 INFO - javascript benchmark 18:50:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6268.764358959266, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2663.1877277430385, 2672.0647773279366, 2691.7442842929922, 2703.607976843358, 2716.0, 4658.487566367697, 4846.4668886422505, 4854.781534830932, 4869.805207791684, 4907.190313598252, 4731.219348807451, 4797.208460603996, 4800.519948005198, 4808.807647694097, 4834.516548345164, 4459.197344477992, 4459.26422140348, 4471.731696098228, 4537.591616754491, 4599.494055653892, 4430.5790949859875, 4485.887852803673, 4487.528809475007, 4501.189785838547, 4558.111168322179, 4486.8878278042985, 4531.637469002472, 4535.523770004152, 4540.659450541206, 4543.023250001249, 4289.056407590325, 4362.040351122748, 4428.136513379892, 4478.104379124188, 4489.4612646482465, 4366.847160349373, 4408.669349798746, 4420.160169567804, 4460.107978404332, 4465.68740188187, 4801.615870730333, 4822.951770482286, 4839.709617422931, 4842.951570484285, 4843.75781210938, 5001.874953126165, 5120.18077107661, 5193.350831146106, 5203.375594928595, 5228.058949389108, 5188.7146206958605, 5198.376194856642, 5245.31810864589, 5275.129603615399, 5286.65636733615, 4865.5864251538305, 4868.951310486886, 4870.464248932614, 4876.634252431047, 4913.31213630092, 5066.544011039025, 5203.089459344599, 5356.143017117321, 5360.865978350573, 5376.516113549721, 5063.088644044107, 5073.847784566469, 5098.694078355311, 5104.846854594368, 5110.97444512775, 5205.0, 5209.557187639018, 5213.45258747826, 5218.530332270114, 5259.947400525945, 4900.044491324157, 4997.450280469146, 5164.173732202829, 5166.948330516647, 5170.40540337866, 5140.974295128501, 5145.382554093533, 5155.149400348975, 5160.329157209539, 5212.609054320941, 4452.398926144929, 4452.638258115167, 4461.933071003938, 4462.9776851116185, 4497.707649002869, 3726.5900750917376, 3775.3770627846648, 3801.4297855321925, 3880.708946828999, 3899.7660140391667, 4463.174312752087, 4466.352378905106, 4476.7090139140855, 4487.685861989629, 4503.279475284005, 5175.120229560984, 5201.765920533585, 5225.372955245395, 5231.110711179109, 5234.712090834964, 4293.055527783882, 4418.226810308183, 4459.7993090310365, 4461.04087621163, 4490.124425737015, 4706.058788242297, 4728.05438912219, 4745.715257084586, 4772.212584923449, 4792.041591681608, 4870.342503762017, 4886.877828054327, 4894.412670479565, 4895.314655948241, 4918.827841025547, 5012.899742005066, 5123.462036486116, 5182.948170518246, 5245.0558899398475, 5265.6840589564745, 4814.566688998007, 4867.683600565952, 4887.535684110004, 4896.90206195867, 4912.828051018198, 5126.743662816919, 5127.87180320495, 5135.666181698178, 5138.972205558978, 5184.222366645034, 4984.053029924303, 5168.612354073534, 5191.065608190411, 5202.557782588522, 5215.243789650555, 5060.418051923929, 5072.5688316493515, 5105.642605017613, 5108.642395032312, 5123.001014802227, 5089.033083714083, 5095.974520127375, 5098.872528186825, 5101.234814777813, 5150.536451719363, 4705.64707646921, 4901.411830580353, 4991.301217829434, 4992.950070499393, 5004.149294619996, 5027.296178535081, 5109.259157422079, 5110.744462776921, 5134.948650513447, 5145.279660847559, 5000.449950505515, 5000.699958002531, 5019.3976722793495, 5027.396712394389, 5070.062038522885], "value": 4762.170022387472, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.1850167484534, 552.8203333916479, 555.1561626327981, 570.2472735988496, 570.4580648384036, 38727.0, 40011.19977600446, 40076.0, 40145.59854401455, 44031.779841100826, 41309.58690413095, 41871.79064104683, 41894.79052604733, 41913.37129943046, 42091.579084209225, 7684.308412242911, 7817.413693972946, 7838.255365740246, 7841.137474877759, 7845.843083138334, 7724.266194711493, 7789.805254868617, 7816.960915195416, 7818.960905195466, 7830.843383132334, 7437.4421918356065, 7508.662110205027, 7533.096028476591, 7543.585102819343, 7547.094348678166, 7825.8826117608, 7831.608419579026, 7835.804104897366, 7843.882341764878, 7872.291493765531, 7804.297613214781, 7857.724979625686, 7877.094134174586, 7878.330341920943, 7882.369410447208, 39231.8038409809, 39793.60206397957, 39840.40239396411, 39859.80070099631, 40027.59972400268, 3100.302431952815, 3253.056613582058, 3285.211549228192, 3385.18755498681, 3502.859885604573, 29877.402451951057, 30109.0, 30235.395292094036, 30256.8487157565, 31098.37803243945, 3352.6312105668358, 3361.6806403391884, 3369.983150084234, 3373.207296285371, 3455.775374600668, 257880.0, 258122.0, 259380.0, 260670.0, 260914.0, 52714.0, 53125.20312195243, 53221.46778532243, 53221.73389133107, 53241.467585324426, 32133.35733285321, 32737.508937365958, 32856.50715239273, 34636.13409664779, 34641.48037779435, 14306.284685765879, 14488.565343039725, 14571.41714331415, 14575.854241457662, 14612.0, 10895.727606809734, 10968.287061340987, 10977.066949309397, 10989.560417583367, 11017.889821101846, 17740.0, 17814.10929453522, 17818.198181081883, 17952.102394880203, 18000.459986200436, 6989.930100698928, 7095.680694368766, 7102.644867756591, 7138.714451421989, 7139.6434677411125, 762.4586543554028, 864.6109250837148, 887.0818702642733, 889.3063410539789, 982.6462473509531, 28214.43571128607, 28239.57640635392, 28386.574201386997, 28730.281742956595, 28966.0, 866.9306455483546, 952.7475219066953, 977.7213494154132, 985.9260555458226, 1071.8017166824163, 14964.850351496345, 15033.173175475235, 15064.171470569005, 15182.316795744218, 15226.390944362323, 399038.0, 400634.0, 401219.0, 401868.0, 402855.0, 49487.505124949006, 49750.253746193834, 50044.249336259985, 50339.24491132636, 50369.0, 1002.3234316836107, 1144.5250221158292, 1179.5222934711455, 1187.0207079159554, 1189.9286042837457, 26524.867375662998, 27505.86247068752, 27554.724452756018, 28430.289242768267, 28480.85759571189, 43315.35026974661, 43508.0, 43512.564874352116, 43545.78227108844, 43613.0, 353534.0, 353644.0, 353658.0, 353750.0, 356673.0, 24841.50316993614, 25056.749432505443, 25232.612206328093, 25572.360690982874, 25604.103856364938, 41548.79225603853, 42100.789496052326, 42724.0, 42907.0, 43217.0, 36151.81924090363, 36959.0, 37040.25919481649, 38167.618323817514, 38188.42717359297, 36590.451143233404, 36648.45027324645, 36909.07727306731, 37564.81217593895, 37985.24029519339, 35228.0, 35337.82331088328, 36258.456123157644, 36328.09179770527, 36396.0, 31828.36343273075, 33674.0, 33855.0, 34095.488567672, 34295.82852085823, 25519.87240063788, 25771.871140644176, 26171.476570468105, 26909.730902691506, 27467.450650987266], "value": 17500.245989468058, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.6484585722562, 347.82261046866097, 353.16476532999457, 366.72129181821805, 367.36262584416033, 16067.437639682614, 16910.83089169108, 17709.645807083867, 17793.644127117448, 17801.287948482077, 14867.256637168153, 15700.764488532652, 15761.921190394061, 15848.603784905383, 15865.206739663, 4928.1129396708575, 5106.285120083191, 5143.408508021588, 5144.794208231666, 5154.304168937202, 3766.8681596144, 5120.257562653432, 5174.66364686296, 5731.742071606767, 5964.612300200495, 6048.39516048396, 6072.7874524391655, 6082.787102451415, 6090.299615544225, 6091.329953705089, 5955.672438015908, 6052.092186172087, 6081.939180608181, 6097.146399504073, 6098.57309988301, 5133.281340612317, 5324.307839980777, 5331.813386531453, 5333.146696528575, 5338.225957236218, 20936.685949710765, 21254.468638284012, 21533.56932861334, 21593.136274549, 21781.34655960308, 1940.6894896816582, 1953.915576854845, 2041.3263623004373, 2085.8122768950866, 2230.131667371873, 13761.587152385444, 13773.862261377459, 13860.306984650728, 14171.716565668628, 14300.856991430057, 1740.1125426032816, 1781.7060185069577, 1795.1473050301001, 1825.607494388713, 1828.5520047588425, 67976.0, 69048.30951690469, 69191.65404172997, 69387.0, 69529.30470695278, 8186.426950113554, 8701.47791132534, 8744.300455963508, 8799.29605631548, 8969.461832290084, 11322.886771132184, 11372.14708896836, 11380.601678941197, 11389.487473063731, 11426.600068997544, 6752.696128674222, 6861.828454288683, 6885.345892140239, 7084.185318688416, 7102.112235970504, 7044.788656340318, 7082.92917070833, 7278.09023872016, 7282.417406607458, 7331.596762178131, 3435.587729472479, 3623.2934577757082, 3643.9635603644156, 3732.122951106488, 3837.3668344723364, 1664.459050808492, 1711.1615308498995, 1726.1628110366462, 1738.2438639191992, 1770.7166853303668, 362.49251048532267, 381.2165998872344, 772.1043589436339, 773.9071311442663, 833.8784335069322, 10126.493675316206, 10406.219533535015, 10875.891241087487, 11049.0, 11197.384143872165, 393.9133390654051, 400.36741947722527, 402.60946881524876, 408.075708520202, 409.31848472293296, 5690.829275121753, 5893.882122357614, 5916.2013128228, 5943.494802941798, 5982.1325907744, 372220.0, 378051.0, 416767.0, 430892.0, 430955.0, 81441.59279203566, 81775.0, 82482.58758706288, 83607.0, 84086.0, 414.1158626332741, 426.06266214327985, 426.44562069310393, 426.69917708015777, 427.322693530751, 10101.898981010096, 10111.696649100539, 10234.948825255826, 10312.896871031193, 10397.896021039693, 27613.861930691022, 34498.0, 37818.81090594529, 38518.614813851505, 38660.80669596634, 51599.226011609106, 54692.45307546874, 55971.72014140066, 56352.71823640855, 57285.71357143188, 7690.846183076195, 7743.225677432437, 7896.210378962058, 7944.6424910877995, 8085.191480851868, 10380.48097595102, 11242.606508772154, 11717.0, 12234.75530489403, 12326.137170397986, 9283.814323713623, 9377.953110234404, 9528.52357382142, 10125.64560240388, 10459.94770026145, 7611.657475413509, 10652.680419587425, 10663.626773062906, 10686.89313106859, 10766.46167691628, 10489.265751397634, 10752.354858708502, 10895.462722366517, 11104.774844912754, 11110.44447777624, 7757.0, 7832.451728378959, 7870.606469676379, 7887.369010479033, 7997.0, 7913.9604301978125, 10152.340097893613, 10184.694459166238, 10187.0, 10213.978602139727], "value": 7544.927343847692, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.575175943698, 1348.2584578481833, 1420.2117824607344, 1646.3908353909055, 1668.7914010748657, 6590.143281373426, 7285.672144753486, 7312.744053958106, 7915.4854934429295, 7940.04719433668, 7618.4286178536695, 7682.1549629540705, 7697.191794861543, 7711.961440192791, 7718.536887786737, 2080.0, 2110.873347599149, 2116.2169997101096, 2122.034474314191, 2129.55279391328, 2058.6294466995937, 2074.3051077888927, 2150.860194087379, 2163.556470923457, 2166.306781829815, 2128.4466038829937, 2134.4557137929805, 2145.6459684152096, 2154.2890846020855, 2165.8700477971292, 2107.7681455039933, 2110.767815540289, 2110.8522403431766, 2112.6302896993043, 2114.7990940860595, 2020.1515363547346, 2090.4146838885135, 2093.5080256139795, 2101.2750601042617, 2112.345172996361, 7771.339436147934, 7796.844063118762, 7796.922030779676, 7803.1416544180665, 7821.608919554, 4251.744895306291, 4270.658347332206, 4281.05816720321, 4286.39990401344, 4422.933655995163, 2707.5667893137, 2760.2271364018106, 2786.3452088759127, 2802.425502771927, 2876.3384421582946, 832.8084540555645, 877.9648814047431, 884.4869975414244, 889.3952112563454, 891.8974317953454, 10437.68686939393, 10493.265471417004, 10501.789964200672, 10549.525271362807, 10557.102646275076, 3800.4869342638945, 3916.8433262669746, 4048.4939382577177, 4068.816903239361, 4080.510338759368, 9049.909500904907, 9075.727728168165, 9081.59132839024, 9096.545172741337, 9138.406003609876, 4226.915461690811, 4251.256030194703, 4307.935380969288, 4311.698181127354, 4316.050468896838, 3402.4726167444087, 3835.0987517933263, 3909.2963266612282, 3923.7449565778134, 3933.331333673282, 3515.191505953594, 3548.1661809474754, 3616.222512159898, 3640.745147839679, 3708.740388172802, 1102.7518808268076, 1105.4086063955745, 1117.1900372230068, 1121.7027487715761, 1123.6852084705533, 621.5152181298595, 643.5527308520533, 683.5693513086823, 694.7151667816272, 719.129852878013, 4943.826966056171, 4945.208766597327, 5029.924551131736, 5030.4215015272985, 5090.745462726849, 392.95088113985753, 398.14994985705727, 401.08352414732195, 412.80598118884075, 416.0223474834116, 3394.3890099781784, 3396.896008797151, 3452.5511683480986, 3459.896203113911, 3512.7892326460496, 8977.147171018743, 9392.06079392069, 9464.19554337889, 9493.0, 9500.42997420157, 9443.669471568463, 9445.19715824149, 9446.669366572138, 9447.669331573363, 9455.054494550628, 7233.710651573878, 7287.890681639779, 7328.047353843966, 7331.926680733124, 7333.743318983917, 4931.802727890844, 4956.727379994135, 4997.525235102659, 5014.824481143142, 5157.690538567698, 8586.742397728078, 8704.956475217838, 8745.300375970035, 8827.602757875782, 8866.911330886867, 8665.220130188314, 8833.469991800512, 8838.690645827364, 8930.464172149692, 8972.564389697616, 5549.805756798492, 6201.0, 6261.8747625046335, 6390.041493775971, 6525.3800888915475, 6850.314968503109, 6899.103116594811, 6912.861742765217, 6917.965410172917, 6921.515493915377, 6152.692365381802, 6154.969225154025, 6268.404501572343, 6295.213098362705, 6368.872622547616, 6256.530760192913, 6268.561200715906, 6277.18396608438, 6326.6520341381665, 6337.36626337381, 5608.10270356741, 5699.601027928005, 5704.971475142598, 5725.8568535786935, 5732.713364331683, 4352.390665306796, 4371.759553224603, 4409.096135292321, 4423.137488189772, 4515.819367225406, 4368.170047690928, 4398.164348773723, 4428.557144285674, 4495.651304608539, 4597.839075632337], "value": 3882.4278034915305, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.40202173414093, 288.4375467837716, 293.73710529076493, 296.0983804315858, 296.94654962106824, 4908.631852611051, 5054.646174767768, 5122.436531981479, 5183.300254465646, 5204.687718736878, 4966.304717339575, 5059.0, 5081.771320290586, 5088.949110508894, 5093.6943783372935, 4008.5790991945864, 4013.7391069580385, 4021.336479480882, 4021.939670904939, 4026.4966879140106, 3915.1190982028957, 3979.5025621797276, 3993.600639936012, 3994.48071750672, 4011.498562679665, 3904.511936007999, 3925.450436938831, 3926.82329295181, 3928.2536318099615, 3974.066094467812, 3938.326211360175, 3949.526056873165, 3952.7628342299554, 3975.1056012397266, 3988.162485877969, 3492.161881148506, 3521.3485505181366, 3526.6297038810812, 3528.153243221608, 3528.8764893228613, 4888.633352498577, 4967.286286231244, 4972.279019542182, 4992.925106123411, 5064.164412871872, 4497.123061003105, 4500.167469018242, 4507.932381014288, 4519.118771839492, 4537.954620453786, 5328.573714102901, 5338.279332290169, 5374.602603323125, 5383.650062745948, 5396.136618141118, 3690.741648084635, 3776.3580191367532, 3793.468914351993, 3821.541415030214, 3845.1732877431205, 5538.667679939176, 5580.637258578179, 5582.609217354787, 5582.972085139549, 5612.550995920316, 3951.920961580752, 3961.6632586230494, 3965.2466031453932, 3973.6225058619384, 3977.661898738582, 3811.198768904853, 4021.8994525137105, 4022.2357752027606, 4023.979880100581, 4024.1146947671464, 4533.274676051816, 4533.32000199966, 4571.977140114278, 4589.862304130881, 4595.586397224266, 5387.622866399314, 5398.514133727984, 5412.972935135299, 5448.155535891943, 5448.264484294648, 1289.0847498276328, 1350.7636163671318, 1363.8158848555317, 1368.2884899852022, 1384.3977869626544, 932.8880534335923, 937.1237892570468, 956.3879117364892, 960.9759756006156, 964.9083337082966, 4608.539146085364, 4637.304404339376, 4637.350770892078, 4656.32483289921, 4663.160631086369, 5484.396716361197, 5494.313210848644, 5500.22996780451, 5512.586556008235, 5516.972415137899, 4410.735355878657, 4614.869357007555, 4622.95377046232, 4632.953670463319, 4640.907181856412, 2552.591585346373, 2578.7034491033396, 2589.210290861268, 2599.583227141213, 2616.659834221539, 4562.634989200856, 4577.977110114494, 4593.955689718044, 4609.562091601292, 4613.63897650194, 4885.145099607555, 4909.2881532177635, 4956.975215123901, 5009.699418034929, 5202.583793296527, 5159.871003224875, 5161.535461808456, 5171.974140129275, 5179.430262671179, 5186.688798672092, 5515.834524964257, 5532.2254884315425, 5544.251526044094, 5554.305711786027, 5556.332680548358, 5178.9444227905715, 5371.516563509303, 5374.0, 5375.489328513785, 5429.375621803543, 5169.948300517097, 5173.92239116406, 5182.481751824787, 5183.81856635016, 5204.34945631796, 3759.3984962405884, 3811.5045044144085, 3822.8279727411777, 3831.7892515911894, 3843.135294558702, 5333.973330133324, 5523.4200408956485, 5532.391436941853, 5532.778688852401, 5562.276904002454, 5268.394134674408, 5304.28392167068, 5319.547838433622, 5356.276902618252, 5368.9463105370005, 5310.654807437504, 5351.598630102836, 5355.4376790436445, 5361.220339660452, 5371.677699338053, 5005.499450054966, 5268.2361057647195, 5306.204069389622, 5311.49540793624, 5333.919991200212, 5438.981365342273, 5442.918356224581, 5453.618246722692, 5468.207109968953, 5478.671564584955, 5103.617228707788, 5274.4198138204, 5292.9735351323, 5347.919781203207, 5366.785328586969], "value": 3986.816333926208, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.6494638270655, 681.5297444763113, 710.9111361079865, 722.8301349182941, 756.5120497279253, 12303.138780285384, 12871.420786064626, 13004.349782510872, 13044.347782610866, 14837.25813709313, 13613.115147515404, 13932.233727145003, 14163.716725665507, 14186.858131418683, 14192.0, 754.7018927523638, 779.9938079876952, 782.7143092771126, 782.8199514111758, 782.9647665855022, 630.272035798651, 740.1155619035255, 759.2445516710853, 761.478387304698, 767.2902565127235, 811.4806523824757, 811.9797005074861, 813.6297984417106, 816.1308206759782, 817.6851912013858, 812.7683610171102, 813.32494029955, 814.6944895664126, 815.1848151848152, 815.3192084609358, 593.2051051590846, 594.5095296380504, 594.9643021418685, 594.9910751338733, 595.4551585299446, 13129.60611181666, 13230.536931207458, 13231.0, 13233.933830330787, 13247.271400072992, 13121.278329691862, 13236.470541178342, 13292.867071329356, 13468.865311346859, 13537.526186583422, 11207.60773372928, 11269.887301127048, 11319.151063670257, 11338.489767960462, 11379.374134422604, 3242.481203007531, 3266.5100234964707, 3298.884539041122, 3304.074859039473, 3379.0538649178025, 54324.72837635787, 55867.44132558663, 56058.71970640121, 70895.0, 71276.64361678211, 9973.950130249448, 10448.216383771247, 10490.423026733602, 10706.46467676613, 10715.892841071645, 18134.365297214536, 18211.908940455214, 18385.0, 18423.170957306953, 18469.168887400097, 6852.211995620468, 6926.930730692729, 6936.930630693629, 6992.056072430157, 7017.193022802341, 3652.680547852133, 3844.4809950656304, 3858.9614103858603, 3923.097687531884, 3975.224831157954, 2879.1650421377985, 2998.14552852436, 3191.569138166364, 3349.547811045478, 3354.8993530194134, 511.8131881863168, 513.1481740311066, 523.6099106165855, 525.0811080608935, 527.941926388097, 437.3680032353219, 448.81149917034924, 478.80847660935206, 508.7913955278318, 547.9397266300704, 7782.6886924523515, 7912.762617121495, 7950.920490795133, 8263.710770123138, 8421.24208821209, 490.2132078014806, 509.8648858052619, 526.2579762534807, 530.7792078220078, 532.4515748778764, 3688.7233457490797, 3745.6254374562327, 3755.605661405568, 3779.7526816150603, 3966.861159859391, 58853.41146588565, 59036.11445828316, 60562.09156862651, 72763.0, 105373.47313263538, 80682.0, 87606.56196718976, 87719.12280877109, 88466.0, 88547.55726221327, 48082.0, 48252.5174748255, 48406.51593484091, 48954.51045489571, 54273.0, 6905.091050134824, 7181.569105853666, 7331.78004659861, 7378.790226251598, 7445.478816482794, 47697.0, 48318.27522587094, 48769.2684609724, 49103.26345104755, 49789.502104978485, 38708.41937370998, 40047.799761001006, 40157.196856063296, 67795.32204678087, 68701.0, 9715.854262186214, 9785.461799601091, 9831.164351029956, 9903.108720215216, 9932.602695892083, 10731.40977246259, 10953.616623418142, 10980.615678451215, 11123.72190695239, 11448.725175721573, 10416.376825996344, 10556.788864222826, 10766.569337226423, 10834.566617335533, 11064.059554937921, 10438.791224175626, 10563.260571759904, 10603.780565234789, 10950.178736594946, 10998.505067271832, 9704.660336888175, 9936.801263974825, 9951.751206219902, 10074.14369778577, 10294.639687610897, 8323.0, 8591.31269498426, 8675.436096653697, 8773.517456539952, 9088.954555227181, 8691.913080869363, 8726.476411415335, 8979.551022448983, 9414.15272625467, 9483.478408687588], "value": 6234.614474987235, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1574.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 110.0, 116.0, 115.0, 116.0, 115.0, 116.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 124.0, 147.0, 193.0, 122.0, 155.0, 150.0, 128.0, 183.0, 134.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 164.0, 178.0, 165.0, 165.0, 164.0, 165.0, 165.0, 163.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 177.0, 76.0, 77.0, 78.0, 75.0, 156.0, 78.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 149.0, 85.0, 86.0, 86.0, 137.0, 85.0, 85.0, 142.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 119.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 149.0, 148.0, 147.0, 147.0, 149.0, 147.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 63.0, 66.0, 62.0, 63.0, 63.0, 63.0, 65.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 67.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 83.0, 85.0, 80.0, 81.0, 78.0, 80.0, 85.0, 84.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 134.0, 130.0, 131.0, 150.0, 130.0, 134.0, 151.0, 144.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 166.0, 169.0, 171.0, 170.0, 174.0, 171.0, 173.0, 165.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 71.0, 68.0, 70.0, 69.0, 69.0, 67.0, 69.0, 68.0], "value": 68.8, "unit": "score"}]}]} 18:50:26 INFO - Return code: 0 18:50:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:50:26 ERROR - # TBPL SUCCESS # 18:50:26 INFO - Running post-action listener: _resource_record_post_action 18:50:26 INFO - [mozharness: 2016-08-09 01:50:26.270141Z] Finished run-tests step (success) 18:50:26 INFO - Running post-run listener: _resource_record_post_run 18:50:26 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 546697216; Read time: 56; Write time: 490380 18:50:26 INFO - TinderboxPrint: CPU usage
13.3% 18:50:26 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 56 18:50:26 INFO - TinderboxPrint: I/O write bytes / time
546,697,216 / 490,380 18:50:26 INFO - TinderboxPrint: CPU idle
8,277.2 (86.7%) 18:50:26 INFO - TinderboxPrint: CPU user
1,217.8 (12.7%) 18:50:26 INFO - TinderboxPrint: Swap in / out
0 / 0 18:50:26 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 257896448; Read time: 0; Write time: 257688 18:50:26 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288272384; Read time: 52; Write time: 232664 18:50:26 INFO - Running post-run listener: _upload_blobber_files 18:50:26 INFO - Blob upload gear active. 18:50:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:50:26 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 18:50:26 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'] 18:50:26 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 18:50:27 INFO - (blobuploader) - INFO - Open directory for files ... 18:50:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:50:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:50:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:28 INFO - (blobuploader) - INFO - Done attempting. 18:50:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:50:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:50:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:28 INFO - (blobuploader) - INFO - Done attempting. 18:50:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:50:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:50:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:34 INFO - (blobuploader) - INFO - Done attempting. 18:50:34 INFO - (blobuploader) - INFO - Iteration through files over. 18:50:34 INFO - Return code: 0 18:50:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:50:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:50:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60669b2f9af328e6e6ae8044bb36901603a4a644d8fcb2957c0cce5a11fda6e54d536de66689f35beb8f610f03305e082663678e5ed0f12d914fe3093f4f169d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e19594a73d4ca354039e77468a98111e277d42cbcf40677b8c27a56012ff3b598a5b38bb5c16243df68fb7135089dead8a6e109c16f6ebc13870b325ca83586", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5efaa256998a347ccf4dbb90efa3e23da7ef2dbd70fba6eb3c99abb689a3a2eecfb3a8fc4f01863da03ab220b50561eab15dda74fc032f954b8c3a3ebfc6b290"} 18:50:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:50:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:50:34 INFO - Contents: 18:50:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60669b2f9af328e6e6ae8044bb36901603a4a644d8fcb2957c0cce5a11fda6e54d536de66689f35beb8f610f03305e082663678e5ed0f12d914fe3093f4f169d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e19594a73d4ca354039e77468a98111e277d42cbcf40677b8c27a56012ff3b598a5b38bb5c16243df68fb7135089dead8a6e109c16f6ebc13870b325ca83586", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5efaa256998a347ccf4dbb90efa3e23da7ef2dbd70fba6eb3c99abb689a3a2eecfb3a8fc4f01863da03ab220b50561eab15dda74fc032f954b8c3a3ebfc6b290"} 18:50:34 INFO - Running post-run listener: copy_logs_to_upload_dir 18:50:34 INFO - Copying logs to upload dir... 18:50:34 INFO - mkdir: /builds/slave/test/build/upload/logs 18:50:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.349726 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-08 18:50:34.358119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 18:50:34.361975) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120 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/60669b2f9af328e6e6ae8044bb36901603a4a644d8fcb2957c0cce5a11fda6e54d536de66689f35beb8f610f03305e082663678e5ed0f12d914fe3093f4f169d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e19594a73d4ca354039e77468a98111e277d42cbcf40677b8c27a56012ff3b598a5b38bb5c16243df68fb7135089dead8a6e109c16f6ebc13870b325ca83586", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5efaa256998a347ccf4dbb90efa3e23da7ef2dbd70fba6eb3c99abb689a3a2eecfb3a8fc4f01863da03ab220b50561eab15dda74fc032f954b8c3a3ebfc6b290"} build_url:https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/R9vVG6J1QmyWht2a_kGOtA/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/60669b2f9af328e6e6ae8044bb36901603a4a644d8fcb2957c0cce5a11fda6e54d536de66689f35beb8f610f03305e082663678e5ed0f12d914fe3093f4f169d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e19594a73d4ca354039e77468a98111e277d42cbcf40677b8c27a56012ff3b598a5b38bb5c16243df68fb7135089dead8a6e109c16f6ebc13870b325ca83586", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5efaa256998a347ccf4dbb90efa3e23da7ef2dbd70fba6eb3c99abb689a3a2eecfb3a8fc4f01863da03ab220b50561eab15dda74fc032f954b8c3a3ebfc6b290"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 18:50:34.388597) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 18:50:34.389152) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1470706194.640147-368439120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 18:50:34.472124) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 18:50:34.472800) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 18:50:34.473385) ========= ========= Total master_lag: 0.18 =========