builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1471947928.5 results: success (0) buildid: 20160823025246 builduid: 7699ad1aa5254074b5c713bc959349ae revision: c2208aa0321830a520d2aea54c536ee981bb93c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 03:25:28.501786) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 03:25:28.502289) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 03:25:28.502643) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 03:25:28.536788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 03:25:28.537123) ========= 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-1471945677.832856-1968408251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 03:25:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.9M=0s 2016-08-23 03:25:29 (66.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.606266 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 03:25:29.167586) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 03:25:29.167952) ========= 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-1471945677.832856-1968408251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019948 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 03:25:29.219951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 03:25:29.220957) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c2208aa0321830a520d2aea54c536ee981bb93c5 --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 c2208aa0321830a520d2aea54c536ee981bb93c5 --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-1471945677.832856-1968408251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 03:25:29,646 truncating revision to first 12 chars 2016-08-23 03:25:29,647 Setting DEBUG logging. 2016-08-23 03:25:29,647 attempt 1/10 2016-08-23 03:25:29,647 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c2208aa03218?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 03:25:29,931 unpacking tar archive at: fx-team-c2208aa03218/testing/mozharness/ program finished with exit code 0 elapsedTime=0.580843 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 03:25:29.818612) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 03:25:29.818988) ========= script_repo_revision: c2208aa0321830a520d2aea54c536ee981bb93c5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 03:25:29.819463) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 03:25:29.819848) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 03:25:29.831068) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-23 03:25:29.831441) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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-1471945677.832856-1968408251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:25:30 INFO - MultiFileLogger online at 20160823 03:25:30 in /builds/slave/test 03:25:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 03:25:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:25:30 INFO - {'append_to_log': False, 03:25:30 INFO - 'base_work_dir': '/builds/slave/test', 03:25:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:25:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:25:30 INFO - 'branch': 'Fx-Team-Non-PGO', 03:25:30 INFO - 'buildbot_json_path': 'buildprops.json', 03:25:30 INFO - 'config_files': ('talos/linux_config.py',), 03:25:30 INFO - 'default_actions': ('clobber', 03:25:30 INFO - 'read-buildbot-config', 03:25:30 INFO - 'download-and-extract', 03:25:30 INFO - 'populate-webroot', 03:25:30 INFO - 'create-virtualenv', 03:25:30 INFO - 'install', 03:25:30 INFO - 'run-tests'), 03:25:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:25:30 INFO - 'download_minidump_stackwalk': True, 03:25:30 INFO - 'download_symbols': 'ondemand', 03:25:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:25:30 INFO - 'tooltool.py': '/tools/tooltool.py', 03:25:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:25:30 INFO - '/tools/misc-python/virtualenv.py')}, 03:25:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:25:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:25:30 INFO - 'installer_path': 'installer.exe', 03:25:30 INFO - 'log_level': 'info', 03:25:30 INFO - 'log_name': 'talos', 03:25:30 INFO - 'log_to_console': True, 03:25:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:25:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:25:30 INFO - 'opt_config_files': (), 03:25:30 INFO - 'pip_index': False, 03:25:30 INFO - 'sps_profile': False, 03:25:30 INFO - 'sps_profile_interval': 0, 03:25:30 INFO - 'suite': 'dromaeojs', 03:25:30 INFO - 'system_bits': '32', 03:25:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:25:30 INFO - 'title': 'talos-linux64-ix-013', 03:25:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:25:30 INFO - 'use_talos_json': True, 03:25:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:25:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:25:30 INFO - 'work_dir': 'build'} 03:25:30 INFO - [mozharness: 2016-08-23 10:25:30.355999Z] Running clobber step. 03:25:30 INFO - Running pre-action listener: _resource_record_pre_action 03:25:30 INFO - Running main action method: clobber 03:25:30 INFO - rmtree: /builds/slave/test/build 03:25:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:25:31 INFO - Running post-action listener: _resource_record_post_action 03:25:31 INFO - [mozharness: 2016-08-23 10:25:31.338151Z] Finished clobber step (success) 03:25:31 INFO - [mozharness: 2016-08-23 10:25:31.338250Z] Running read-buildbot-config step. 03:25:31 INFO - Running pre-action listener: _resource_record_pre_action 03:25:31 INFO - Running main action method: read_buildbot_config 03:25:31 INFO - Using buildbot properties: 03:25:31 INFO - { 03:25:31 INFO - "project": "", 03:25:31 INFO - "product": "firefox", 03:25:31 INFO - "script_repo_revision": "production", 03:25:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:25:31 INFO - "repository": "", 03:25:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:25:31 INFO - "buildid": "20160823025246", 03:25:31 INFO - "pgo_build": "False", 03:25:31 INFO - "basedir": "/builds/slave/test", 03:25:31 INFO - "buildnumber": 3254, 03:25:31 INFO - "slavename": "talos-linux64-ix-013", 03:25:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:25:31 INFO - "platform": "ubuntu64_hw", 03:25:31 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 03:25:31 INFO - "branch": "fx-team", 03:25:31 INFO - "repo_path": "integration/fx-team", 03:25:31 INFO - "revision": "c2208aa0321830a520d2aea54c536ee981bb93c5", 03:25:31 INFO - "stage_platform": "linux64", 03:25:31 INFO - "builduid": "7699ad1aa5254074b5c713bc959349ae", 03:25:31 INFO - "slavebuilddir": "test" 03:25:31 INFO - } 03:25:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 03:25:31 INFO - Running post-action listener: _resource_record_post_action 03:25:31 INFO - [mozharness: 2016-08-23 10:25:31.340658Z] Finished read-buildbot-config step (success) 03:25:31 INFO - [mozharness: 2016-08-23 10:25:31.340746Z] Running download-and-extract step. 03:25:31 INFO - Running pre-action listener: _resource_record_pre_action 03:25:31 INFO - Running main action method: download_and_extract 03:25:31 INFO - mkdir: /builds/slave/test/build/tests 03:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:31 INFO - trying https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:25:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/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 03:25:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/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 03:25:31 INFO - Downloaded 1361 bytes. 03:25:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:25:31 INFO - Using the following test package requirements: 03:25:31 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:25:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:25:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:25:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:31 INFO - u'jsshell-linux-x86_64.zip'], 03:25:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:25:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:25:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:25:31 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:25:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:25:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:25:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:31 INFO - trying https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:25:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/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 03:25:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/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 03:25:32 INFO - Downloaded 20330904 bytes. 03:25:32 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 03:25:36 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 03:25:36 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')]} 03:25:36 INFO - trying https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:25:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/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 03:25:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/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 03:25:37 INFO - Downloaded 20330904 bytes. 03:25:37 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 03:25:42 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')]} 03:25:42 INFO - trying https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:25:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/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 03:25:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/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 03:25:43 INFO - Downloaded 14413981 bytes. 03:25:43 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 03:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:43 INFO - trying https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:25:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/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 03:25:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/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 03:25:44 INFO - Downloaded 55764483 bytes. 03:25:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:25:44 INFO - mkdir: /builds/slave/test/properties 03:25:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:44 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:44 INFO - Contents: 03:25:44 INFO - build_url:https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:25:45 INFO - Running post-action listener: _resource_record_post_action 03:25:45 INFO - Running post-action listener: set_extra_try_arguments 03:25:45 INFO - [mozharness: 2016-08-23 10:25:45.113296Z] Finished download-and-extract step (success) 03:25:45 INFO - [mozharness: 2016-08-23 10:25:45.113519Z] Running populate-webroot step. 03:25:45 INFO - Running pre-action listener: _resource_record_pre_action 03:25:45 INFO - Running main action method: populate_webroot 03:25:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:25:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:25:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:25:45 INFO - '--tppagecycles', 03:25:45 INFO - '7'], 03:25:45 INFO - 'tests': ['tsvgm']}}, 03:25:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:25:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:25:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:25:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:25:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:45 INFO - 'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:45 INFO - 'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['damp', 'tps']}, 03:25:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:45 INFO - 'tests': ['damp', 'tps']}, 03:25:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['dromaeo_dom']}, 03:25:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['basic_compositor_video']}, 03:25:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:25:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['a11yr', 03:25:45 INFO - 'ts_paint', 03:25:45 INFO - 'tpaint', 03:25:45 INFO - 'sessionrestore', 03:25:45 INFO - 'sessionrestore_no_auto_restore', 03:25:45 INFO - 'tabpaint']}, 03:25:45 INFO - 'other-e10s': {'tests': ['a11yr', 03:25:45 INFO - 'ts_paint', 03:25:45 INFO - 'tpaint', 03:25:45 INFO - 'sessionrestore', 03:25:45 INFO - 'sessionrestore_no_auto_restore', 03:25:45 INFO - 'tabpaint']}, 03:25:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:25:45 INFO - 'ts_paint', 03:25:45 INFO - 'tpaint', 03:25:45 INFO - 'sessionrestore', 03:25:45 INFO - 'sessionrestore_no_auto_restore', 03:25:45 INFO - 'tabpaint']}, 03:25:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:25:45 INFO - 'ts_paint', 03:25:45 INFO - 'tpaint', 03:25:45 INFO - 'sessionrestore', 03:25:45 INFO - 'sessionrestore_no_auto_restore', 03:25:45 INFO - 'tabpaint']}, 03:25:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['a11yr', 03:25:45 INFO - 'ts_paint', 03:25:45 INFO - 'tpaint', 03:25:45 INFO - 'sessionrestore', 03:25:45 INFO - 'sessionrestore_no_auto_restore', 03:25:45 INFO - 'tabpaint']}, 03:25:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['a11yr', 03:25:45 INFO - 'ts_paint', 03:25:45 INFO - 'tpaint', 03:25:45 INFO - 'sessionrestore', 03:25:45 INFO - 'sessionrestore_no_auto_restore', 03:25:45 INFO - 'tabpaint']}, 03:25:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['tsvgx', 03:25:45 INFO - 'tsvgr_opacity', 03:25:45 INFO - 'tart', 03:25:45 INFO - 'tscrollx', 03:25:45 INFO - 'cart']}, 03:25:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:25:45 INFO - 'tsvgr_opacity', 03:25:45 INFO - 'tart', 03:25:45 INFO - 'tscrollx', 03:25:45 INFO - 'cart']}, 03:25:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:45 INFO - 'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['tp5o']}, 03:25:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:45 INFO - 'tests': ['tp5o']}, 03:25:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:45 INFO - 'talos_options': ['--disable-e10s', 03:25:45 INFO - '--xperf_path', 03:25:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:45 INFO - 'tests': ['tp5n']}, 03:25:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:45 INFO - 'talos_options': ['--xperf_path', 03:25:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:45 INFO - 'tests': ['tp5n']}}, 03:25:45 INFO - 'talos.zip': {'path': '', 03:25:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:25:45 INFO - Running post-action listener: _resource_record_post_action 03:25:45 INFO - [mozharness: 2016-08-23 10:25:45.134657Z] Finished populate-webroot step (success) 03:25:45 INFO - [mozharness: 2016-08-23 10:25:45.134745Z] Running create-virtualenv step. 03:25:45 INFO - Running pre-action listener: _resource_record_pre_action 03:25:45 INFO - Running main action method: create_virtualenv 03:25:45 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:45 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 03:25:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:25:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:45 INFO - Using real prefix '/usr' 03:25:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:45 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:47 INFO - Installing pip.................done. 03:25:47 INFO - Return code: 0 03:25:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:25:47 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')]} 03:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:47 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')]} 03:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:47 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 0x7fa793f8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98090>, '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 0x2a9b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9be40>, '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-1471945677.832856-1968408251', '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 03:25:47 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 03:25:47 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 03:25:47 INFO - Using env: {'DISPLAY': ':0', 03:25:47 INFO - 'HOME': '/home/cltbld', 03:25:47 INFO - 'LANG': 'en_US.UTF-8', 03:25:47 INFO - 'LANGUAGE': 'en_US:en', 03:25:47 INFO - 'LOGNAME': 'cltbld', 03:25:47 INFO - 'MAIL': '/var/mail/cltbld', 03:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:47 INFO - 'MOZ_NO_REMOTE': '1', 03:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:47 INFO - 'NO_EM_RESTART': '1', 03:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:47 INFO - 'PWD': '/builds/slave/test', 03:25:47 INFO - 'SHELL': '/bin/bash', 03:25:47 INFO - 'SHLVL': '1', 03:25:47 INFO - 'TERM': 'linux', 03:25:47 INFO - 'TMOUT': '86400', 03:25:47 INFO - 'USER': 'cltbld', 03:25:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471945677.832856-1968408251', 03:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:47 INFO - '_': '/tools/buildbot/bin/python'} 03:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:47 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 03:25:47 INFO - Cleaning up... 03:25:47 INFO - Return code: 0 03:25:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:25:47 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')]} 03:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:47 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')]} 03:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:47 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 0x7fa793f8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98090>, '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 0x2a9b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9be40>, '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-1471945677.832856-1968408251', '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 03:25:47 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 03:25:47 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 03:25:47 INFO - Using env: {'DISPLAY': ':0', 03:25:47 INFO - 'HOME': '/home/cltbld', 03:25:47 INFO - 'LANG': 'en_US.UTF-8', 03:25:47 INFO - 'LANGUAGE': 'en_US:en', 03:25:47 INFO - 'LOGNAME': 'cltbld', 03:25:47 INFO - 'MAIL': '/var/mail/cltbld', 03:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:47 INFO - 'MOZ_NO_REMOTE': '1', 03:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:47 INFO - 'NO_EM_RESTART': '1', 03:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:47 INFO - 'PWD': '/builds/slave/test', 03:25:47 INFO - 'SHELL': '/bin/bash', 03:25:47 INFO - 'SHLVL': '1', 03:25:47 INFO - 'TERM': 'linux', 03:25:47 INFO - 'TMOUT': '86400', 03:25:47 INFO - 'USER': 'cltbld', 03:25:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471945677.832856-1968408251', 03:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:47 INFO - '_': '/tools/buildbot/bin/python'} 03:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:48 INFO - Downloading/unpacking psutil>=3.1.1 03:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:25:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:50 INFO - Installing collected packages: psutil 03:25:50 INFO - Running setup.py install for psutil 03:25:50 INFO - building 'psutil._psutil_linux' extension 03:25:50 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 03:25:50 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 03:25:50 INFO - building 'psutil._psutil_posix' extension 03:25:50 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 03:25:50 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 03:25:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:50 INFO - Successfully installed psutil 03:25:50 INFO - Cleaning up... 03:25:50 INFO - Return code: 0 03:25:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa793f8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98090>, '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 0x2a9b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9be40>, '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-1471945677.832856-1968408251', '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 03:25:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:25:50 INFO - Using env: {'DISPLAY': ':0', 03:25:50 INFO - 'HOME': '/home/cltbld', 03:25:50 INFO - 'LANG': 'en_US.UTF-8', 03:25:50 INFO - 'LANGUAGE': 'en_US:en', 03:25:50 INFO - 'LOGNAME': 'cltbld', 03:25:50 INFO - 'MAIL': '/var/mail/cltbld', 03:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:50 INFO - 'MOZ_NO_REMOTE': '1', 03:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:50 INFO - 'NO_EM_RESTART': '1', 03:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:50 INFO - 'PWD': '/builds/slave/test', 03:25:50 INFO - 'SHELL': '/bin/bash', 03:25:50 INFO - 'SHLVL': '1', 03:25:50 INFO - 'TERM': 'linux', 03:25:50 INFO - 'TMOUT': '86400', 03:25:50 INFO - 'USER': 'cltbld', 03:25:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471945677.832856-1968408251', 03:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:50 INFO - '_': '/tools/buildbot/bin/python'} 03:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:25:52 INFO - Installing collected packages: mozsystemmonitor 03:25:52 INFO - Running setup.py install for mozsystemmonitor 03:25:52 INFO - Successfully installed mozsystemmonitor 03:25:52 INFO - Cleaning up... 03:25:52 INFO - Return code: 0 03:25:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:52 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 0x7fa793f8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98090>, '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 0x2a9b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9be40>, '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-1471945677.832856-1968408251', '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 03:25:52 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 03:25:52 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 03:25:52 INFO - Using env: {'DISPLAY': ':0', 03:25:52 INFO - 'HOME': '/home/cltbld', 03:25:52 INFO - 'LANG': 'en_US.UTF-8', 03:25:52 INFO - 'LANGUAGE': 'en_US:en', 03:25:52 INFO - 'LOGNAME': 'cltbld', 03:25:52 INFO - 'MAIL': '/var/mail/cltbld', 03:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:52 INFO - 'MOZ_NO_REMOTE': '1', 03:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:52 INFO - 'NO_EM_RESTART': '1', 03:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:52 INFO - 'PWD': '/builds/slave/test', 03:25:52 INFO - 'SHELL': '/bin/bash', 03:25:52 INFO - 'SHLVL': '1', 03:25:52 INFO - 'TERM': 'linux', 03:25:52 INFO - 'TMOUT': '86400', 03:25:52 INFO - 'USER': 'cltbld', 03:25:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471945677.832856-1968408251', 03:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:52 INFO - '_': '/tools/buildbot/bin/python'} 03:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:53 INFO - Downloading/unpacking jsonschema==2.5.1 03:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:25:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:25:55 INFO - warning: no files found matching '*.txt' 03:25:55 INFO - no previously-included directories found matching 'build' 03:25:55 INFO - no previously-included directories found matching 'dist' 03:25:55 INFO - no previously-included directories found matching '.git*' 03:25:55 INFO - Installing collected packages: jsonschema, functools32 03:25:55 INFO - Running setup.py install for functools32 03:25:55 INFO - warning: no files found matching '*.txt' 03:25:55 INFO - no previously-included directories found matching 'build' 03:25:55 INFO - no previously-included directories found matching 'dist' 03:25:55 INFO - no previously-included directories found matching '.git*' 03:25:55 INFO - Successfully installed jsonschema functools32 03:25:55 INFO - Cleaning up... 03:25:55 INFO - Return code: 0 03:25:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa793f8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98090>, '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 0x2a9b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9be40>, '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-1471945677.832856-1968408251', '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 03:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:25:55 INFO - Using env: {'DISPLAY': ':0', 03:25:55 INFO - 'HOME': '/home/cltbld', 03:25:55 INFO - 'LANG': 'en_US.UTF-8', 03:25:55 INFO - 'LANGUAGE': 'en_US:en', 03:25:55 INFO - 'LOGNAME': 'cltbld', 03:25:55 INFO - 'MAIL': '/var/mail/cltbld', 03:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:55 INFO - 'MOZ_NO_REMOTE': '1', 03:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:55 INFO - 'NO_EM_RESTART': '1', 03:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:55 INFO - 'PWD': '/builds/slave/test', 03:25:55 INFO - 'SHELL': '/bin/bash', 03:25:55 INFO - 'SHLVL': '1', 03:25:55 INFO - 'TERM': 'linux', 03:25:55 INFO - 'TMOUT': '86400', 03:25:55 INFO - 'USER': 'cltbld', 03:25:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471945677.832856-1968408251', 03:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:55 INFO - '_': '/tools/buildbot/bin/python'} 03:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:25:55 INFO - Cleaning up... 03:25:55 INFO - Return code: 0 03:25:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa793f8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98090>, '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 0x2a9b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9be40>, '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-1471945677.832856-1968408251', '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 03:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:25:55 INFO - Using env: {'DISPLAY': ':0', 03:25:55 INFO - 'HOME': '/home/cltbld', 03:25:55 INFO - 'LANG': 'en_US.UTF-8', 03:25:55 INFO - 'LANGUAGE': 'en_US:en', 03:25:55 INFO - 'LOGNAME': 'cltbld', 03:25:55 INFO - 'MAIL': '/var/mail/cltbld', 03:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:55 INFO - 'MOZ_NO_REMOTE': '1', 03:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:55 INFO - 'NO_EM_RESTART': '1', 03:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:55 INFO - 'PWD': '/builds/slave/test', 03:25:55 INFO - 'SHELL': '/bin/bash', 03:25:55 INFO - 'SHLVL': '1', 03:25:55 INFO - 'TERM': 'linux', 03:25:55 INFO - 'TMOUT': '86400', 03:25:55 INFO - 'USER': 'cltbld', 03:25:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471945677.832856-1968408251', 03:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:55 INFO - '_': '/tools/buildbot/bin/python'} 03:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:25:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:25:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:58 INFO - Downloading docopt-0.6.1.tar.gz 03:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:25:58 INFO - Installing collected packages: blobuploader, requests, docopt 03:25:58 INFO - Running setup.py install for blobuploader 03:25:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:25:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:25:58 INFO - Running setup.py install for requests 03:25:59 INFO - Running setup.py install for docopt 03:25:59 INFO - Successfully installed blobuploader requests docopt 03:25:59 INFO - Cleaning up... 03:25:59 INFO - Return code: 0 03:25:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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')]} 03:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:59 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 0x7fa793f8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98090>, '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 0x2a9b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9be40>, '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-1471945677.832856-1968408251', '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 03:25:59 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 03:25:59 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 03:25:59 INFO - Using env: {'DISPLAY': ':0', 03:25:59 INFO - 'HOME': '/home/cltbld', 03:25:59 INFO - 'LANG': 'en_US.UTF-8', 03:25:59 INFO - 'LANGUAGE': 'en_US:en', 03:25:59 INFO - 'LOGNAME': 'cltbld', 03:25:59 INFO - 'MAIL': '/var/mail/cltbld', 03:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:59 INFO - 'MOZ_NO_REMOTE': '1', 03:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:59 INFO - 'NO_EM_RESTART': '1', 03:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:59 INFO - 'PWD': '/builds/slave/test', 03:25:59 INFO - 'SHELL': '/bin/bash', 03:25:59 INFO - 'SHLVL': '1', 03:25:59 INFO - 'TERM': 'linux', 03:25:59 INFO - 'TMOUT': '86400', 03:25:59 INFO - 'USER': 'cltbld', 03:25:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471945677.832856-1968408251', 03:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:59 INFO - '_': '/tools/buildbot/bin/python'} 03:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:59 INFO - Running setup.py (path:/tmp/pip-BB0OL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:59 INFO - Running setup.py (path:/tmp/pip-UzxxE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:59 INFO - Running setup.py (path:/tmp/pip-KWFeMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:59 INFO - Running setup.py (path:/tmp/pip-QRilUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:59 INFO - Running setup.py (path:/tmp/pip-og3QC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:59 INFO - Running setup.py (path:/tmp/pip-bfiNCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:59 INFO - Running setup.py (path:/tmp/pip-cpBVxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:59 INFO - Running setup.py (path:/tmp/pip-w7TrbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:00 INFO - Running setup.py (path:/tmp/pip-3WM2Gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:00 INFO - Running setup.py (path:/tmp/pip-zpn6Ei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:00 INFO - Running setup.py (path:/tmp/pip-Wv7ggS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:00 INFO - Running setup.py (path:/tmp/pip-uE6wUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:00 INFO - Running setup.py (path:/tmp/pip-iVHNA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:00 INFO - Running setup.py (path:/tmp/pip-2CLGR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:00 INFO - Running setup.py (path:/tmp/pip-F9qqpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:00 INFO - Running setup.py (path:/tmp/pip-k4PWY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:00 INFO - Running setup.py (path:/tmp/pip-Dwn_HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:00 INFO - Running setup.py install for manifestparser 03:26:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:00 INFO - Running setup.py install for mozcrash 03:26:00 INFO - Running setup.py install for mozdebug 03:26:00 INFO - Running setup.py install for mozdevice 03:26:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for mozfile 03:26:01 INFO - Running setup.py install for mozhttpd 03:26:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for mozinfo 03:26:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for mozInstall 03:26:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for mozleak 03:26:01 INFO - Running setup.py install for mozlog 03:26:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for moznetwork 03:26:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for mozprocess 03:26:01 INFO - Running setup.py install for mozprofile 03:26:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:02 INFO - Running setup.py install for mozrunner 03:26:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:02 INFO - Running setup.py install for mozscreenshot 03:26:02 INFO - Running setup.py install for moztest 03:26:02 INFO - Running setup.py install for mozversion 03:26:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:02 INFO - Cleaning up... 03:26:02 INFO - Return code: 0 03:26:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:02 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')]} 03:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:02 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')]} 03:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:02 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 0x7fa793f8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98090>, '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 0x2a9b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9be40>, '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-1471945677.832856-1968408251', '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 03:26:02 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 03:26:02 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 03:26:02 INFO - Using env: {'DISPLAY': ':0', 03:26:02 INFO - 'HOME': '/home/cltbld', 03:26:02 INFO - 'LANG': 'en_US.UTF-8', 03:26:02 INFO - 'LANGUAGE': 'en_US:en', 03:26:02 INFO - 'LOGNAME': 'cltbld', 03:26:02 INFO - 'MAIL': '/var/mail/cltbld', 03:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:02 INFO - 'MOZ_NO_REMOTE': '1', 03:26:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:02 INFO - 'NO_EM_RESTART': '1', 03:26:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:02 INFO - 'PWD': '/builds/slave/test', 03:26:02 INFO - 'SHELL': '/bin/bash', 03:26:02 INFO - 'SHLVL': '1', 03:26:02 INFO - 'TERM': 'linux', 03:26:02 INFO - 'TMOUT': '86400', 03:26:02 INFO - 'USER': 'cltbld', 03:26:02 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471945677.832856-1968408251', 03:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:02 INFO - '_': '/tools/buildbot/bin/python'} 03:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:02 INFO - Running setup.py (path:/tmp/pip-9iBL_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:02 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)) 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:02 INFO - Running setup.py (path:/tmp/pip-Zp12xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:02 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)) 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:02 INFO - Running setup.py (path:/tmp/pip-nTdXdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:02 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)) 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:02 INFO - Running setup.py (path:/tmp/pip-4eD103-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:02 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)) 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:02 INFO - Running setup.py (path:/tmp/pip-azKXyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:03 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)) 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:03 INFO - Running setup.py (path:/tmp/pip-UtRhf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:03 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)) 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:03 INFO - Running setup.py (path:/tmp/pip-1ALt8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:03 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)) 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:03 INFO - Running setup.py (path:/tmp/pip-otLAII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:03 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)) 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:03 INFO - Running setup.py (path:/tmp/pip-oS15db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:03 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)) 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:03 INFO - Running setup.py (path:/tmp/pip-zWhuFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:03 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)) 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:03 INFO - Running setup.py (path:/tmp/pip-JB7ACE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:03 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)) 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:03 INFO - Running setup.py (path:/tmp/pip-ECKC1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:03 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)) 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:03 INFO - Running setup.py (path:/tmp/pip-VE3zve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:03 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)) 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:03 INFO - Running setup.py (path:/tmp/pip-IRQjm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:03 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)) 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:03 INFO - Running setup.py (path:/tmp/pip-TdKfCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:03 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)) 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:03 INFO - Running setup.py (path:/tmp/pip-1uz5Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:03 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)) 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:03 INFO - Running setup.py (path:/tmp/pip-RGMaIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:03 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)) 03:26:03 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)) 03:26:03 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)) 03:26:03 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)) 03:26:03 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)) 03:26:03 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)) 03:26:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:03 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 03:26:03 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 03:26:03 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 03:26:03 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 03:26:03 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 03:26:03 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 03:26:05 INFO - Downloading blessings-1.6.tar.gz 03:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:05 INFO - Installing collected packages: blessings 03:26:05 INFO - Running setup.py install for blessings 03:26:05 INFO - Successfully installed blessings 03:26:05 INFO - Cleaning up... 03:26:06 INFO - Return code: 0 03:26:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:06 INFO - Reading from file tmpfile_stdout 03:26:06 INFO - Current package versions: 03:26:06 INFO - argparse == 1.2.1 03:26:06 INFO - blessings == 1.6 03:26:06 INFO - blobuploader == 1.2.4 03:26:06 INFO - docopt == 0.6.1 03:26:06 INFO - functools32 == 3.2.3-2 03:26:06 INFO - jsonschema == 2.5.1 03:26:06 INFO - manifestparser == 1.1 03:26:06 INFO - mozInstall == 1.12 03:26:06 INFO - mozcrash == 0.17 03:26:06 INFO - mozdebug == 0.1 03:26:06 INFO - mozdevice == 0.48 03:26:06 INFO - mozfile == 1.2 03:26:06 INFO - mozhttpd == 0.7 03:26:06 INFO - mozinfo == 0.9 03:26:06 INFO - mozleak == 0.1 03:26:06 INFO - mozlog == 3.3 03:26:06 INFO - moznetwork == 0.27 03:26:06 INFO - mozprocess == 0.23 03:26:06 INFO - mozprofile == 0.28 03:26:06 INFO - mozrunner == 6.12 03:26:06 INFO - mozscreenshot == 0.1 03:26:06 INFO - mozsystemmonitor == 0.3 03:26:06 INFO - moztest == 0.7 03:26:06 INFO - mozversion == 1.4 03:26:06 INFO - psutil == 3.1.1 03:26:06 INFO - requests == 1.2.3 03:26:06 INFO - wsgiref == 0.1.2 03:26:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:06 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 0x7fa793f8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98090>, '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 0x2a9b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9be40>, '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-1471945677.832856-1968408251', '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 03:26:06 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 03:26:06 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 03:26:06 INFO - Using env: {'DISPLAY': ':0', 03:26:06 INFO - 'HOME': '/home/cltbld', 03:26:06 INFO - 'LANG': 'en_US.UTF-8', 03:26:06 INFO - 'LANGUAGE': 'en_US:en', 03:26:06 INFO - 'LOGNAME': 'cltbld', 03:26:06 INFO - 'MAIL': '/var/mail/cltbld', 03:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:06 INFO - 'MOZ_NO_REMOTE': '1', 03:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:06 INFO - 'NO_EM_RESTART': '1', 03:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:06 INFO - 'PWD': '/builds/slave/test', 03:26:06 INFO - 'SHELL': '/bin/bash', 03:26:06 INFO - 'SHLVL': '1', 03:26:06 INFO - 'TERM': 'linux', 03:26:06 INFO - 'TMOUT': '86400', 03:26:06 INFO - 'USER': 'cltbld', 03:26:06 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471945677.832856-1968408251', 03:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:06 INFO - '_': '/tools/buildbot/bin/python'} 03:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:06 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)) 03:26:06 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)) 03:26:06 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)) 03:26:06 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)) 03:26:06 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)) 03:26:06 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)) 03:26:06 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)) 03:26:06 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)) 03:26:06 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)) 03:26:06 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)) 03:26:06 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)) 03:26:06 INFO - Cleaning up... 03:26:06 INFO - Return code: 0 03:26:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa793f8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98090>, '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 0x2a9b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9be40>, '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-1471945677.832856-1968408251', '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 03:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:26:06 INFO - Using env: {'DISPLAY': ':0', 03:26:06 INFO - 'HOME': '/home/cltbld', 03:26:06 INFO - 'LANG': 'en_US.UTF-8', 03:26:06 INFO - 'LANGUAGE': 'en_US:en', 03:26:06 INFO - 'LOGNAME': 'cltbld', 03:26:06 INFO - 'MAIL': '/var/mail/cltbld', 03:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:06 INFO - 'MOZ_NO_REMOTE': '1', 03:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:06 INFO - 'NO_EM_RESTART': '1', 03:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:06 INFO - 'PWD': '/builds/slave/test', 03:26:06 INFO - 'SHELL': '/bin/bash', 03:26:06 INFO - 'SHLVL': '1', 03:26:06 INFO - 'TERM': 'linux', 03:26:06 INFO - 'TMOUT': '86400', 03:26:06 INFO - 'USER': 'cltbld', 03:26:06 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471945677.832856-1968408251', 03:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:06 INFO - '_': '/tools/buildbot/bin/python'} 03:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:26:06 INFO - Cleaning up... 03:26:06 INFO - Return code: 0 03:26:06 INFO - Running post-action listener: _resource_record_post_action 03:26:06 INFO - Running post-action listener: _start_resource_monitoring 03:26:06 INFO - Starting resource monitoring. 03:26:06 INFO - [mozharness: 2016-08-23 10:26:06.707472Z] Finished create-virtualenv step (success) 03:26:06 INFO - [mozharness: 2016-08-23 10:26:06.707932Z] Running install step. 03:26:06 INFO - Running pre-action listener: _resource_record_pre_action 03:26:06 INFO - Running main action method: install 03:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:06 INFO - Reading from file tmpfile_stdout 03:26:06 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:06 INFO - Reading from file tmpfile_stdout 03:26:06 INFO - Output received: 03:26:06 INFO - Usage: mozinstall [options] installer 03:26:06 INFO - Options: 03:26:06 INFO - -h, --help show this help message and exit 03:26:07 INFO - -d DEST, --destination=DEST 03:26:07 INFO - Directory to install application into. [default: 03:26:07 INFO - "/builds/slave/test"] 03:26:07 INFO - --app=APP Application being installed. [default: firefox] 03:26:07 INFO - mkdir: /builds/slave/test/build/application 03:26:07 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'] 03:26:07 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 03:26:23 INFO - Reading from file tmpfile_stdout 03:26:23 INFO - Output received: 03:26:23 INFO - /builds/slave/test/build/application/firefox/firefox 03:26:23 INFO - Running post-action listener: _resource_record_post_action 03:26:23 INFO - [mozharness: 2016-08-23 10:26:23.138921Z] Finished install step (success) 03:26:23 INFO - [mozharness: 2016-08-23 10:26:23.139170Z] Running run-tests step. 03:26:23 INFO - Running pre-action listener: _resource_record_pre_action 03:26:23 INFO - Running main action method: run_tests 03:26:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:26:23 INFO - Python 2.7.3 03:26:23 INFO - Return code: 0 03:26:23 INFO - grabbing minidump binary from tooltool 03:26:23 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')]} 03:26:23 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 0x2a98090>, '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 0x2a9b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9be40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:26:23 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 03:26:23 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 03:26:23 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 03:26:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:26:23 INFO - Return code: 0 03:26:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:26:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:26:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:26:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:26:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:26:23 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:26:23 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:26:23 INFO - Using env: {'DISPLAY': ':0', 03:26:23 INFO - 'HOME': '/home/cltbld', 03:26:23 INFO - 'LANG': 'en_US.UTF-8', 03:26:23 INFO - 'LANGUAGE': 'en_US:en', 03:26:23 INFO - 'LOGNAME': 'cltbld', 03:26:23 INFO - 'MAIL': '/var/mail/cltbld', 03:26:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:23 INFO - 'MOZ_NO_REMOTE': '1', 03:26:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:23 INFO - 'NO_EM_RESTART': '1', 03:26:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:23 INFO - 'PWD': '/builds/slave/test', 03:26:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:23 INFO - 'SHELL': '/bin/bash', 03:26:23 INFO - 'SHLVL': '1', 03:26:23 INFO - 'TERM': 'linux', 03:26:23 INFO - 'TMOUT': '86400', 03:26:23 INFO - 'USER': 'cltbld', 03:26:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471945677.832856-1968408251', 03:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:23 INFO - '_': '/tools/buildbot/bin/python'} 03:26:23 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:26:23 INFO - mozversion application_buildid: 20160823025246 03:26:23 INFO - mozversion application_changeset: c2208aa0321830a520d2aea54c536ee981bb93c5 03:26:23 INFO - mozversion application_display_name: Nightly 03:26:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:26:23 INFO - mozversion application_name: Firefox 03:26:23 INFO - mozversion application_remotingname: firefox 03:26:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:26:23 INFO - mozversion application_vendor: Mozilla 03:26:23 INFO - mozversion application_version: 51.0a1 03:26:23 INFO - mozversion platform_buildid: 20160823025246 03:26:23 INFO - mozversion platform_changeset: c2208aa0321830a520d2aea54c536ee981bb93c5 03:26:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:26:23 INFO - mozversion platform_version: 51.0a1 03:26:23 INFO - using testdate: 1471947983 03:26:23 INFO - actual date: 1471947983 03:26:23 INFO - starting webserver on 'localhost:51499' 03:26:23 INFO - SUITE-START | Running 2 tests 03:26:23 INFO - TEST-START | dromaeo_css 03:26:23 INFO - operating with platform_type : linux_ 03:26:23 INFO - Initialising browser for dromaeo_css test... 03:26:23 INFO - TEST-INFO | started process 24031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDOv7gp/profile http://localhost:51499/getInfo.html) 03:26:27 INFO - PROCESS | 24031 | __metrics Screen width/height:1600/1200 03:26:27 INFO - PROCESS | 24031 | colorDepth:24 03:26:27 INFO - PROCESS | 24031 | Browser inner width/height: 1024/697 03:26:27 INFO - PROCESS | 24031 | __metrics 03:26:28 INFO - PROCESS | 24031 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:26:28 INFO - PROCESS | 24031 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:26:29 INFO - PROCESS | 24031 | console.error: PushService: 03:26:29 INFO - PROCESS | 24031 | stateChangeProcessEnqueue: Error transitioning state 03:26:29 INFO - PROCESS | 24031 | UnknownError 03:26:29 INFO - TEST-INFO | 24031: exit 0 03:26:29 INFO - Browser initialized. 03:26:29 INFO - Running cycle 1/1 for dromaeo_css test... 03:26:29 INFO - TEST-INFO | started process 24110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDOv7gp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:42 INFO - PROCESS | 24110 | RSS: Main: 177594368 03:26:42 INFO - PROCESS | 24110 | 03:27:33 INFO - PROCESS | 24110 | 1471948053992 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] 03:29:46 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:51499/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51499/tests/dromaeo/cssquery-ext.html) 03:29:47 INFO - PROCESS | 24110 | RSS: Main: 269295616 03:29:47 INFO - PROCESS | 24110 | 03:32:49 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:51499/tests/dromaeo/cssquery-ext.html (next: http://localhost:51499/tests/dromaeo/cssquery-jquery.html) 03:32:50 INFO - PROCESS | 24110 | RSS: Main: 279191552 03:32:50 INFO - PROCESS | 24110 | 03:35:52 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:51499/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51499/tests/dromaeo/cssquery-mootools.html) 03:35:53 INFO - PROCESS | 24110 | RSS: Main: 219766784 03:35:53 INFO - PROCESS | 24110 | 03:38:55 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:51499/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51499/tests/dromaeo/cssquery-prototype.html) 03:38:56 INFO - PROCESS | 24110 | RSS: Main: 219824128 03:38:56 INFO - PROCESS | 24110 | 03:41:59 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:51499/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51499/tests/dromaeo/cssquery-yui.html) 03:42:00 INFO - PROCESS | 24110 | RSS: Main: 218464256 03:42:00 INFO - PROCESS | 24110 | 03:45:03 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:51499/tests/dromaeo/cssquery-yui.html (next: http://localhost:51499/tests/dromaeo/cssquery-dojo.html) 03:45:03 INFO - PROCESS | 24110 | RSS: Main: 308277248 03:45:03 INFO - PROCESS | 24110 | 03:45:03 INFO - PROCESS | 24110 | __start_tp_report 03:45:03 INFO - PROCESS | 24110 | _x_x_mozilla_page_load 03:45:03 INFO - PROCESS | 24110 | _x_x_mozilla_page_load_details 03:45:03 INFO - PROCESS | 24110 | |i|pagename|runs| 03:45:03 INFO - PROCESS | 24110 | |0;dojo.html;2541.288439237014;2596.8312059716104;2599.9350016249596;2608.1653870761365;2618.1229288188456;4588.747618880969;4689.624830013599;4689.69516981396;4709.246520556711;4736.1711700452415;4704.623630109591;4714.764261786905;4751.9762401187945;4787.904241915159;4814.518548145184;4311.439512863323;4345.065810850667;4397.538258482861;4426.092651006536;4438.979034821977;4392.912141757163;4427.026054268056;4435.62297204738;4435.8225670973125;4454.710443821141;4207.64235040022;4293.914121717579;4390;4393.165298593257;4437.290033594625;4305.440292761952;4382.233109205877;4388.956110438887;4401.471823381215;4411.647068234533;4347.586979236968;4349.826006959718;4360.585744354281;4365.279728844736;4367.519572846984;4568.474625418053;4641.930371044437;4754.286856971447;4756.6432517561325;4773.952260477386;5035.77339019745;5104.387473503203;5110.310108135392;5133.101707201225;5133.691978481265;5113.923291150636;5137.38351397831;5144.099782538078;5145.30538377318;5149.150390185615;4603.654725895572;4706.482286948433;4818.253170758538;4819.228923372244;4831.758412079382;5172.870678233075;5265.736713164327;5284.5772338212855;5292.232626269247;5293.57651387888;5030.547250747377;5066.847994560169;5068.366454193226;5068.518490743373;5072.416672082684;4913.238448040559;5107.182850743863;5115.462876397999;5115.488451154929;5122.820701275437;4960.50394960501;4990.251462280687;5017.949820501822;5061.291419201315;5063.417706963673;5047.747612619354;5061.493850614983;5065.822696205615;5066.771995260222;5070.163423035158;4169.687273454503;4290.506591741927;4299.656027517791;4301.634361079281;4302.806373713128;3683.318586061587;3726.720495962814;3763.6612704856693;3781.8487260509273;3835.271298453285;4358.106588149421;4392.363107349481;4396.736195828196;4397.714148580332;4403.119376124788;4958.9504104959215;5156.587473002151;5161.716105614228;5167.405748338914;5172.9741351293005;4269;4295.613394794484;4302.612764851116;4333.241682705514;4341.826326946887;4536.274196128604;4551.749653769009;4560.361549383089;4560.657950653715;4563.38394316763;4670.649701272486;4784.784684689197;4789.425268967746;4793.161196790617;4796.880077998078;5073.315102461121;5088.720120393414;5108.182690769459;5115.4373018967135;5166.45752196014;4821.807127714992;4822.638302127425;4823.686460380064;4828.758562071812;4845.079434907357;4880.487548807466;5042.168042272984;5072.949270507248;5081.669691470042;5119.052975199451;5035.144025515598;5092.159793634009;5094.7962081516325;5145;5166.328377310925;5016.974915125401;5029.798808047637;5030.270610761492;5031.195008798721;5032.798688052437;4850.6362022847725;4988.750562471934;5012.724300163526;5016.322796422436;5019.0463811875625;4818.759062046814;4846;4883.951160488492;4931.802727890844;4968.080905032436;5018.648694591344;5037.949620503748;5044.218146187347;5045.596352291881;5077.568406685473;4760;4918;4964.280179374043;4966;4974.9751251243515 03:45:03 INFO - PROCESS | 24110 | |1;ext.html;562.8058319879641;565.355494736001;575.6431012772082;579.5682216748521;585.3765739487449;38491.61508384919;40108.39837402438;40286.798566007164;43348.566514334845;43373;40681.59318406815;40698.18603627933;40808;41168;41280.79359603198;7613.2386761323705;7766.611669416507;7783.221677832228;7790.909272701826;7815.882761758578;7749.457537972316;7841.843163136762;7843.64703588337;7846.293833554979;7853.214678532158;7843.764687059397;7880;7884;7884.4875083119705;7886.763397098096;7810.531368117902;7851.960740196262;7860.724874629418;7860.842783144305;7863.488873223251;7735.535867847947;7792.376609871197;7803.531788092732;7810.492317999368;7812.375009999187;37838.243235135145;38204.23591528154;38261.42607860884;38278;38284.23431531381;2680.6113113598417;2694.8517831519257;2734.398432344901;2790.4279622677304;3078.122735020531;28761.856190718914;28908;28936;29326.85336573325;29791.255218619706;3416.40212962733;3464.20323325634;3513.6662017108333;3571.482135090397;3635.1093981974323;251947;253649;256369;256482;257582;49552.256716149284;50325.49674503281;50328.24507632388;50328.496715033114;50446;32640;53319.73340133352;53457.7327113362;53470.73264633652;53472.73263633657;12738.617841464771;13436.19382837033;13444.395002224923;13454.394552245172;13487.258200798855;10000;10097.636819029338;10107.494625268855;10114.848277275847;10117.342372745748;17940.372086976895;18030.549236268937;18048.548786280186;18054.277828886698;18078;6606.570572912745;6634.701438435282;6660.467162626978;6733.966330168416;6991.545549539263;795.9243871832167;824.5464994253136;960.7942032748855;971.718201721507;984.5175863826673;27645.723542764717;28017.57973630397;28413.147605571867;28772.712272877423;28813.56779648307;904.7285814255829;913.0869130869131;915.0803442540205;928.8095940332215;956.0773853231526;14139.50511732105;14864.702705946036;14908.62728431798;14912.105273683614;15248.390064397521;370261;373100;373878;373880;374595;48437;48921.510784891696;48957.510424896005;49008.754956225705;49122.75438622784;1069.9358038517714;1157.2477889371976;1165.685264978451;1173.906087513014;1180.4418168018133;27277.318067048483;28649.42701146007;28967.130986070453;29290.41842040109;29396.41207175802;41039.38440923329;41668;41853.372199417645;41874.58125418707;41883.581164189185;294279;296024;296118;296209;297064;22089.889550552143;25409.61885571755;25568.23295301144;25945.6108158374;26719.866400667874;40302.19395612013;40788.59211407848;40946.385804213554;41093.38359924544;42164.156716866106;35328.233588320996;35613.64386356103;35804.28391432209;36044.81977590095;36330.55587489932;34871;35149;35579.35043965456;35675.82162089173;35847.10382240465;34545.65454345424;34829.65170348264;35820;35939.64060359363;36509.26981460303;30566.84716576403;32716;33067.66932330646;33420.49869251915;33508.329833402706;24929.376765581004;25597.3600659985;25704.228873133838;25894.87052564725;26325.605115922892 03:45:03 INFO - PROCESS | 24110 | |2;jquery.html;340.45867071356537;342.88170581149495;350.8368608597002;356.3994668982764;366.0665303476137;12827.679308017305;16195.514134575968;16708.74936875946;16759.91620041901;17681.7347739784;15005.92497037516;15099.471518496855;15489.535313940572;15856;15995.680086398264;4357;4937.284093806405;5075.873103172414;5114.977004599076;5132.40977287613;5008.29883816266;5091.567216786559;5093.414257360414;5095.108356037697;5096.719680417576;4835.911919818048;4988;5015.924761128586;5073.188289873621;5074.949250507485;4926.211806111023;5045.823396181153;5046.84859454217;5051.3433253676785;5052.242163675442;4411.933820992687;4470.128324976631;4505.932411013838;4513.435820522434;4575.771211439414;19810.504737381536;19939.30212442572;20083.89958050215;20411.183552657876;20552.177912883468;2038.347728726808;2177.2488491470417;2383.249276477904;2406.891689873942;2468.7037555493275;12415.93792031034;13053.282069486175;13400.5309814157;13753.931230343884;13822;1705.84647381735;1730.7576939228518;1737.661156074566;1755.604988877505;1801.5766294920684;64949.67525162344;65560;66787;68621.65689171522;68679.65660171717;8922.107789221156;8998.50508222041;9073.863892041625;9570.090841370058;9917.950410248048;12949.741005179843;12967.351632418342;12986.35068246584;12986.870131298756;12987.675308117372;6776.42400395962;7117.958000367978;7217.603031833194;7269;7279.490435669452;6715.7985260442265;6783.457323414115;6788.898166527506;6928.549644273106;6962.338577835098;6107.953835465169;6134.2332208473945;6189.6286222826775;6200.410960958701;6283.685815709287;1711.2128420926265;1728.6749322161672;1734.9479515614553;1781.0738416023596;1784.9375271865422;807.4307613132727;835.3233880556647;874.4359887872287;909.7316291693966;933.7292185266197;16983.036954848452;16996.660066798842;17556.824431755773;17623;17990.1004949752;854.9059603443616;863.3783675753448;875.4309698695898;907.7004588485784;955.9235261179089;9977;10013.499325033865;10089.192864570818;10093.444860532594;10143.898561014295;368631;369218;369727;390808;393292;67105.6644716783;67826.321736782;68184;68199.3180068193;69614.3038569618;905.4024343932973;917.8531434970373;923.9769005774775;931.6971984105057;933.3093510801957;15018.324175412352;15152.318145683692;15623.843761562239;16026.439074632332;16139.75790363122;33751.83124084364;34677.82661086678;35430;35445.82277088598;38562.421563677126;45174.77412612916;48407;49685.75157124191;49813.501864980884;51114.23328649999;6520.706568204348;6595.538312318092;6667.299933506912;7223.205447400676;7588.430867684835;10754.784904301714;11462;11612.825807612724;11666.533338666359;12086.818697719717;9734.296498112944;10101.949490252502;10291.125254353465;10458.006489383497;10509.632162874263;10003.149732272546;10012.44931528773;10060.446675432922;10483.47582620881;10573.8942610576;9969.102780749767;10073.84889226677;10280.485975701335;10574.89425105739;10653.147748180281;6612.70242839083;6753.189617245962;6761.594304341756;6790.049393085071;6982.825429364307;9485.668001620186;9720.833499979764;9839.85240221383;10031.039705991672;10463.162946964072 03:45:03 INFO - PROCESS | 24110 | |3;mootools.html;1227.7667243223782;1235.5366737473448;1340.939657715403;1372.6842826149984;1650.4306014425026;6669.866602667944;7292.927070729291;7573;7577.545347279167;7598.73404430845;7333.633318334076;7462.21646727094;7477.962610186955;7662.693492260317;7674.040744906887;2091.4875855415407;2133.57328534293;2137.7007218989274;2137.9893100534478;2139.764625891151;2073.6163809695254;2122.2359950417836;2161.7081693971268;2163.653815389538;2163.8593491423085;2103.053625868358;2123.6495978163584;2124.4476436126643;2126.1176611706123;2160.4274867160216;2108.8207502362316;2112.0390222448827;2112.6936594193758;2113.323736404351;2116.365090472852;2062.4019034479984;2093.769685334612;2094.675325324577;2095.3609149209483;2096.811286984179;7326.04761381017;7365.742199023062;7391.889121663179;7439.032925719676;7443.478956473049;4053.61490658387;4234.597713217239;4235.428217190702;4243.469566304212;4247.68142389322;2761.62718033067;2936.2365784896083;2952.409518096389;2959.3045634275927;2993.4911065118763;932.8787257656461;935.1023017902821;939.056248470283;949.4113649537262;951.0537015669453;10327.79344413115;10512.632057877938;10514.421706806123;10523.684789346331;10525.736856578571;3980.960190398117;4031.1333063390925;4105.158442519277;4125.257453658371;4186.727862688916;8187.058488273806;8339.624716887754;8349.666013359398;8352.958235208785;8357.373197010249;4328.394024836525;4329.76186309756;4331.97834010828;4339.891502712394;4354.760488173118;3526.3828829954655;3759.830807613664;3892.2020985697864;3995;3996.7801770902297;3338.315645292709;3372.8482218299746;3472.2013936794174;3478.9652103478643;3525.3125640499857;1017.862588550551;1018.2821111116644;1036.6838114375037;1039.3555995282973;1041.703114612347;620.4694985787178;665.2848188197706;734.930181632744;736.7347754808264;751.8345963887936;4819.927701084486;4935.457099719028;5114.6931184128325;5201.713905735145;5340.839774806762;786;814.8818421328992;844.6536919862826;868.2142660891903;899.4198741811625;3253.6258330291844;3254.2515221498716;3259.9837000814846;3319.186799234155;3478.826058697055;9198.908010919939;9553.952230238805;9578.090081442251;9586.712398628053;9587.616495340248;9523.714288571355;9528.475933823567;9529.047095290416;9532;9554.856677149848;7303.160136584254;7347.595882226529;7404.481686282016;7430.851382972311;7439.404847612178;4893.486183950634;4939.160342741814;4978.377702787152;5018.698878067327;5133.101707201299;8641.308695304235;8819.470831750115;8927.196552310323;8956.507392093497;9019.81960360776;8861.158189971942;8991.91008089937;9039.819203616022;9099.636014559343;9108.134727200906;6028.668423236764;6173.104899789595;6212.285587157354;6218.253809542884;6226.283977342482;7176.9641151795995;7215.567065976058;7223.1693355264815;7224.458165637703;7228.89156662661;6370;6447.838804029937;6474.320196379501;6491.870162596627;6583.63789991555;6390.680465976776;6495.382938620824;6521.608703477807;6647.767328143492;6685.264620891795;5800.8259752207505;5880.617759845596;5884.617499862496;5885.440883116097;5887.52899768009;4457.353683715778;4481.865544033684;4565.863024109282;4612.192866248461;4615.676902616785;4422.601965823092;4478.104379124123;4573.81704731807;4598.8620341389815;4796.208625576741 03:45:03 INFO - PROCESS | 24110 | |4;prototype.html;285.9728325809048;288.97977141600086;295.9215807810929;299.34742261869116;299.9681097026231;4678.181318269306;4682.695624784391;4696.882577935549;4710.57604815567;4726.314684370765;4655.4878963314;4683.50823163568;4686.179918514264;4695.131400690874;4704.4589872164715;3505.3865573524595;3581.158427769472;3581.4985901973614;3683.37382644951;3713.1274150574595;3685.649863262986;3697.9445308320396;3706.7219958503083;3715.1640880801738;3719.79541125238;3670.522832031832;3672.320620685182;3678.50340204073;3678.9448158277646;3694.833732482045;3488.947665785015;3564.4475106358686;3643.107438677541;3707.2029513654425;3720.6465385788306;3271.7055465008025;3279.196596833767;3281.7210537104374;3282.688144626257;3282.7045565899184;4610.654200934943;4612.863252987967;4613.930791038104;4615.192341340286;4638.234691275936;3987;4163.271427500175;4225.492940847087;4238.533761286256;4242.978785106055;4856.732879691615;4891.8287859925085;4905.23968784839;4916.1888288432365;4931.235658472942;3605.278944211142;3615.7107431405425;3616.9276614467826;3622.1487950331652;3633.8909832705062;4945.307656928033;5132;5170.836561773608;5171.456997015334;5171.793128274864;3658.5061016762397;3678.1172518595345;3682.3739964205615;3682.502862113634;3684.7604905681046;3707.277080969185;3709.554853417553;3714.9071273218387;3720.1257704439436;3721.4975978243133;4193.161367726467;4201.382467749877;4214.262504061777;4222.535521092677;4226.5773422657485;4771.475137734847;4890.315355850184;4923.187674033744;4926.1379258629595;4926.950730492649;1277.2528071078336;1289.7484990426965;1291.6383412644475;1293.353323338331;1293.7089154940063;837.8073043200098;841.7769291137853;850.6724910909345;856.6016802187013;884.8716936044366;4264.296391095435;4274.615284624399;4277.230098582285;4279.636230920344;4290.957090429056;4968.180250258739;4972.477889821516;4973.278874563168;4976.855323275667;4977.726225057657;4212.304969679968;4256.021115143534;4268.722533035343;4270.679699022586;4278.914421711548;2534.0741036811787;2652.58884872845;2690.502257082446;2696.934710789227;2698.9595156072673;4791.257355109963;4795.904081918412;4802.375691160127;4805.3512775775525;4812.590929771009;4966.701997880139;5189;5207.713575753294;5212.791488340424;5213.947860521346;4774.856754297377;4786.736729479772;4800.423949126058;4800.783964721596;4804.807807687654;5018.787975695484;5023.522765337433;5042.546170844642;5045.571126454292;5048.671836330626;4732.02993386348;4977.776000080077;4978.352814134139;4979.3277907482025;4981.501849814989;4763.7856296467435;4817.373741413594;4819.542143496362;4819.975610243636;4820.39745031871;3586.677199052098;3594.4608308753895;3600.4599310103695;3610.4403817408343;3612.1330880587943;5015.649063540108;5044.722540260174;5083.364579427572;5103.515166059218;5126.820561280338;4860.3195552623365;4917.508249175054;4952.653314267966;4964.354633897715;4964.578010869117;4939.135651260943;4950.391122885005;4950.752462376795;4951.9752401237765;4961.454240033521;4870.147724148189;4883.633727470525;4890.6087512998165;4891.877703057452;4909;4746.2168742157155;4767;4821.710697358169;4947.3321101652255;4982;4828.734419606955;4842.4673285937815;4844.733539655353;4845.6608037438455;4888.144574699342 03:45:03 INFO - PROCESS | 24110 | |5;yui.html;567.531786276322;570.1220121013637;577.3043482603463;585.7598384662286;628.1237673445543;12302.692432689177;12494.687632809184;13057.216567005986;13118.081734278605;13124.409401576928;11701.23941943773;11742.589009384674;11752.294862308247;11775.528978840857;11795.761445048254;605.4036773777825;747.0512449189513;766.3103207113587;768.0629631849135;768.1473564343574;731.6926890705889;764.8661484240264;765.3609236287706;769.6651956398956;769.7767647382252;808.3654331349892;810.3233799777194;811.2050190813006;812.1310198088048;812.212154210415;626.5081910700125;801.2428255298745;801.9077806052292;802.626778547975;802.8273921106932;565.3837317324095;580.051615608479;585.6134950932365;587.157429089254;587.6679675983056;11971.281723096643;12031.578894738643;12061.155719099666;12094.637160885188;12098;11649.301041937426;12212.755744885053;12418.689532761662;12421.254724716455;12612.684682883002;11317.377544235063;11386.544538218544;11653.067754579613;11661.650150495414;11910.404479775976;4056.553779084298;4107.944383833247;4137.089840235173;4140.426637877617;4150.730202536825;65473.3452665472;67114;67355.32644673588;67662.32337676658;67733.66133169303;9962.750931226632;10002.549885255181;10189.745256368502;10409.219308551888;10584.312019718695;19297.807021929882;19361.903190483958;19374.515637109183;19417.805821941598;19426.22295108208;6469.223693156851;6530.902036469457;6767.39093481589;6815.659217039129;6864.21061577925;3616.367135751233;3627.818609069536;3632.9636703632627;3716.6655001050035;3720.2187540616774;2562.551553478134;2631.2632462910415;2654.2170059832397;2658.9895839581222;2666.080202330193;482.82859584847574;485.97944316934155;489.4273699771276;495.55895253224656;501.48347202381603;436.0254830453933;456.51609294148307;462.89353448706987;463.2264118921342;479.1112486337793;6996.790096297119;7244.710211591583;7654.119776225694;7908.090569584571;7944.721934732257;435.20357745325975;479.1662507237451;496.3473032961644;510.9208072748656;520.2352541763602;3281.967180328214;3417.111550996709;3478.4956181353564;3479.8434070466888;3654.6710796028483;53367;58652;101030.49484752676;104316.47841760743;104610;86765.98510223391;89971.55014225018;91055.54472227597;91280.54359728159;91627.54186229027;55386.72306638441;75694.62152689311;76151.61924190343;76419;80386.19613803788;6714.227863795726;6838.760643377458;6876.724931002904;6927.272636373108;7002;48118.9999999986;48396.5160348392;48568.271475928595;48569.27146092882;50066.749666252894;51761.741191293804;58501.70749146227;65690.67154664196;70375.29624703892;71017.28982710106;11170.157444047658;11353.318800871974;11622.825657614974;11649.708757281136;12006.819897701716;12638.92569131634;12642.367881606067;13538.59384218475;13542.255175965023;13548.661283467993;11036.889631103908;11119.888801112209;11519.712007199887;11658.533658653898;12017.63947081589;10944;11312.6040588579;11328;11383.373914434454;11550.768984620092;10912.181586380895;11559.537618495166;11630;11847.646037479628;11998.940005299917;9882.802343952937;9995.150897084062;10374.844377334497;10624.575016999543;10973.231873769078;9913.30606857513;9919.305648604528;10005.349652272578;10006.29955903109;10011.949940250252 03:45:03 INFO - PROCESS | 24110 | __end_tp_report 03:45:03 INFO - PROCESS | 24110 | __start_cc_report 03:45:03 INFO - PROCESS | 24110 | _x_x_mozilla_cycle_collect,1019 03:45:03 INFO - PROCESS | 24110 | __end_cc_report 03:45:03 INFO - PROCESS | 24110 | __startTimestamp1471949103439__endTimestamp 03:45:03 INFO - PROCESS | 24110 | 03:45:03 INFO - PROCESS | 24110 | ------- Summary: start ------- 03:45:03 INFO - PROCESS | 24110 | Number of tests: 6 03:45:03 INFO - PROCESS | 24110 | 03:45:03 INFO - PROCESS | 24110 | [#0] dojo.html Cycles:165 Average:4703.49 Median:4822.64 stddev:512.01 (10.6%) stddev-sans-first:484.67 03:45:03 INFO - PROCESS | 24110 | Values: 2541.3 2596.8 2599.9 2608.2 2618.1 4588.7 4689.6 4689.7 4709.2 4736.2 4704.6 4714.8 4752.0 4787.9 4814.5 4311.4 4345.1 4397.5 4426.1 4439.0 4392.9 4427.0 4435.6 4435.8 4454.7 4207.6 4293.9 4390.0 4393.2 4437.3 4305.4 4382.2 4389.0 4401.5 4411.6 4347.6 4349.8 4360.6 4365.3 4367.5 4568.5 4641.9 4754.3 4756.6 4774.0 5035.8 5104.4 5110.3 5133.1 5133.7 5113.9 5137.4 5144.1 5145.3 5149.2 4603.7 4706.5 4818.3 4819.2 4831.8 5172.9 5265.7 5284.6 5292.2 5293.6 5030.5 5066.8 5068.4 5068.5 5072.4 4913.2 5107.2 5115.5 5115.5 5122.8 4960.5 4990.3 5017.9 5061.3 5063.4 5047.7 5061.5 5065.8 5066.8 5070.2 4169.7 4290.5 4299.7 4301.6 4302.8 3683.3 3726.7 3763.7 3781.8 3835.3 4358.1 4392.4 4396.7 4397.7 4403.1 4959.0 5156.6 5161.7 5167.4 5173.0 4269.0 4295.6 4302.6 4333.2 4341.8 4536.3 4551.7 4560.4 4560.7 4563.4 4670.6 4784.8 4789.4 4793.2 4796.9 5073.3 5088.7 5108.2 5115.4 5166.5 4821.8 4822.6 4823.7 4828.8 4845.1 4880.5 5042.2 5072.9 5081.7 5119.1 5035.1 5092.2 5094.8 5145.0 5166.3 5017.0 5029.8 5030.3 5031.2 5032.8 4850.6 4988.8 5012.7 5016.3 5019.0 4818.8 4846.0 4884.0 4931.8 4968.1 5018.6 5037.9 5044.2 5045.6 5077.6 4760.0 4918.0 4964.3 4966.0 4975.0 03:45:03 INFO - PROCESS | 24110 | 03:45:03 INFO - PROCESS | 24110 | [#1] ext.html Cycles:180 Average:46221.98 Median:203385.13 stddev:81968.79 (40.3%) stddev-sans-first:82127.04 03:45:03 INFO - PROCESS | 24110 | Values: 562.8 565.4 575.6 579.6 585.4 38491.6 40108.4 40286.8 43348.6 43373.0 40681.6 40698.2 40808.0 41168.0 41280.8 7613.2 7766.6 7783.2 7790.9 7815.9 7749.5 7841.8 7843.6 7846.3 7853.2 7843.8 7880.0 7884.0 7884.5 7886.8 7810.5 7852.0 7860.7 7860.8 7863.5 7735.5 7792.4 7803.5 7810.5 7812.4 37838.2 38204.2 38261.4 38278.0 38284.2 2680.6 2694.9 2734.4 2790.4 3078.1 28761.9 28908.0 28936.0 29326.9 29791.3 3416.4 3464.2 3513.7 3571.5 3635.1 251947.0 253649.0 256369.0 256482.0 257582.0 49552.3 50325.5 50328.2 50328.5 50446.0 32640.0 53319.7 53457.7 53470.7 53472.7 12738.6 13436.2 13444.4 13454.4 13487.3 10000.0 10097.6 10107.5 10114.8 10117.3 17940.4 18030.5 18048.5 18054.3 18078.0 6606.6 6634.7 6660.5 6734.0 6991.5 795.9 824.5 960.8 971.7 984.5 27645.7 28017.6 28413.1 28772.7 28813.6 904.7 913.1 915.1 928.8 956.1 14139.5 14864.7 14908.6 14912.1 15248.4 370261.0 373100.0 373878.0 373880.0 374595.0 48437.0 48921.5 48957.5 49008.8 49122.8 1069.9 1157.2 1165.7 1173.9 1180.4 27277.3 28649.4 28967.1 29290.4 29396.4 41039.4 41668.0 41853.4 41874.6 41883.6 294279.0 296024.0 296118.0 296209.0 297064.0 22089.9 25409.6 25568.2 25945.6 26719.9 40302.2 40788.6 40946.4 41093.4 42164.2 35328.2 35613.6 35804.3 36044.8 36330.6 34871.0 35149.0 35579.4 35675.8 35847.1 34545.7 34829.7 35820.0 35939.6 36509.3 30566.8 32716.0 33067.7 33420.5 33508.3 24929.4 25597.4 25704.2 25894.9 26325.6 03:45:03 INFO - PROCESS | 24110 | 03:45:03 INFO - PROCESS | 24110 | [#2] jquery.html Cycles:180 Average:23543.31 Median:4441.03 stddev:62310.08 (1403.1%) stddev-sans-first:62460.52 03:45:03 INFO - PROCESS | 24110 | Values: 340.5 342.9 350.8 356.4 366.1 12827.7 16195.5 16708.7 16759.9 17681.7 15005.9 15099.5 15489.5 15856.0 15995.7 4357.0 4937.3 5075.9 5115.0 5132.4 5008.3 5091.6 5093.4 5095.1 5096.7 4835.9 4988.0 5015.9 5073.2 5074.9 4926.2 5045.8 5046.8 5051.3 5052.2 4411.9 4470.1 4505.9 4513.4 4575.8 19810.5 19939.3 20083.9 20411.2 20552.2 2038.3 2177.2 2383.2 2406.9 2468.7 12415.9 13053.3 13400.5 13753.9 13822.0 1705.8 1730.8 1737.7 1755.6 1801.6 64949.7 65560.0 66787.0 68621.7 68679.7 8922.1 8998.5 9073.9 9570.1 9918.0 12949.7 12967.4 12986.4 12986.9 12987.7 6776.4 7118.0 7217.6 7269.0 7279.5 6715.8 6783.5 6788.9 6928.5 6962.3 6108.0 6134.2 6189.6 6200.4 6283.7 1711.2 1728.7 1734.9 1781.1 1784.9 807.4 835.3 874.4 909.7 933.7 16983.0 16996.7 17556.8 17623.0 17990.1 854.9 863.4 875.4 907.7 955.9 9977.0 10013.5 10089.2 10093.4 10143.9 368631.0 369218.0 369727.0 390808.0 393292.0 67105.7 67826.3 68184.0 68199.3 69614.3 905.4 917.9 924.0 931.7 933.3 15018.3 15152.3 15623.8 16026.4 16139.8 33751.8 34677.8 35430.0 35445.8 38562.4 45174.8 48407.0 49685.8 49813.5 51114.2 6520.7 6595.5 6667.3 7223.2 7588.4 10754.8 11462.0 11612.8 11666.5 12086.8 9734.3 10101.9 10291.1 10458.0 10509.6 10003.1 10012.4 10060.4 10483.5 10573.9 9969.1 10073.8 10280.5 10574.9 10653.1 6612.7 6753.2 6761.6 6790.0 6982.8 9485.7 9720.8 9839.9 10031.0 10463.2 03:45:03 INFO - PROCESS | 24110 | 03:45:03 INFO - PROCESS | 24110 | [#3] mootools.html Cycles:180 Average:4956.85 Median:5066.70 stddev:2817.39 (55.6%) stddev-sans-first:2811.36 03:45:03 INFO - PROCESS | 24110 | Values: 1227.8 1235.5 1340.9 1372.7 1650.4 6669.9 7292.9 7573.0 7577.5 7598.7 7333.6 7462.2 7478.0 7662.7 7674.0 2091.5 2133.6 2137.7 2138.0 2139.8 2073.6 2122.2 2161.7 2163.7 2163.9 2103.1 2123.6 2124.4 2126.1 2160.4 2108.8 2112.0 2112.7 2113.3 2116.4 2062.4 2093.8 2094.7 2095.4 2096.8 7326.0 7365.7 7391.9 7439.0 7443.5 4053.6 4234.6 4235.4 4243.5 4247.7 2761.6 2936.2 2952.4 2959.3 2993.5 932.9 935.1 939.1 949.4 951.1 10327.8 10512.6 10514.4 10523.7 10525.7 3981.0 4031.1 4105.2 4125.3 4186.7 8187.1 8339.6 8349.7 8353.0 8357.4 4328.4 4329.8 4332.0 4339.9 4354.8 3526.4 3759.8 3892.2 3995.0 3996.8 3338.3 3372.8 3472.2 3479.0 3525.3 1017.9 1018.3 1036.7 1039.4 1041.7 620.5 665.3 734.9 736.7 751.8 4819.9 4935.5 5114.7 5201.7 5340.8 786.0 814.9 844.7 868.2 899.4 3253.6 3254.3 3260.0 3319.2 3478.8 9198.9 9554.0 9578.1 9586.7 9587.6 9523.7 9528.5 9529.0 9532.0 9554.9 7303.2 7347.6 7404.5 7430.9 7439.4 4893.5 4939.2 4978.4 5018.7 5133.1 8641.3 8819.5 8927.2 8956.5 9019.8 8861.2 8991.9 9039.8 9099.6 9108.1 6028.7 6173.1 6212.3 6218.3 6226.3 7177.0 7215.6 7223.2 7224.5 7228.9 6370.0 6447.8 6474.3 6491.9 6583.6 6390.7 6495.4 6521.6 6647.8 6685.3 5800.8 5880.6 5884.6 5885.4 5887.5 4457.4 4481.9 4565.9 4612.2 4615.7 4422.6 4478.1 4573.8 4598.9 4796.2 03:45:03 INFO - PROCESS | 24110 | 03:45:03 INFO - PROCESS | 24110 | [#4] prototype.html Cycles:180 Average:4096.69 Median:4696.01 stddev:1178.73 (25.1%) stddev-sans-first:1146.81 03:45:03 INFO - PROCESS | 24110 | Values: 286.0 289.0 295.9 299.3 300.0 4678.2 4682.7 4696.9 4710.6 4726.3 4655.5 4683.5 4686.2 4695.1 4704.5 3505.4 3581.2 3581.5 3683.4 3713.1 3685.6 3697.9 3706.7 3715.2 3719.8 3670.5 3672.3 3678.5 3678.9 3694.8 3488.9 3564.4 3643.1 3707.2 3720.6 3271.7 3279.2 3281.7 3282.7 3282.7 4610.7 4612.9 4613.9 4615.2 4638.2 3987.0 4163.3 4225.5 4238.5 4243.0 4856.7 4891.8 4905.2 4916.2 4931.2 3605.3 3615.7 3616.9 3622.1 3633.9 4945.3 5132.0 5170.8 5171.5 5171.8 3658.5 3678.1 3682.4 3682.5 3684.8 3707.3 3709.6 3714.9 3720.1 3721.5 4193.2 4201.4 4214.3 4222.5 4226.6 4771.5 4890.3 4923.2 4926.1 4927.0 1277.3 1289.7 1291.6 1293.4 1293.7 837.8 841.8 850.7 856.6 884.9 4264.3 4274.6 4277.2 4279.6 4291.0 4968.2 4972.5 4973.3 4976.9 4977.7 4212.3 4256.0 4268.7 4270.7 4278.9 2534.1 2652.6 2690.5 2696.9 2699.0 4791.3 4795.9 4802.4 4805.4 4812.6 4966.7 5189.0 5207.7 5212.8 5213.9 4774.9 4786.7 4800.4 4800.8 4804.8 5018.8 5023.5 5042.5 5045.6 5048.7 4732.0 4977.8 4978.4 4979.3 4981.5 4763.8 4817.4 4819.5 4820.0 4820.4 3586.7 3594.5 3600.5 3610.4 3612.1 5015.6 5044.7 5083.4 5103.5 5126.8 4860.3 4917.5 4952.7 4964.4 4964.6 4939.1 4950.4 4950.8 4952.0 4961.5 4870.1 4883.6 4890.6 4891.9 4909.0 4746.2 4767.0 4821.7 4947.3 4982.0 4828.7 4842.5 4844.7 4845.7 4888.1 03:45:03 INFO - PROCESS | 24110 | 03:45:03 INFO - PROCESS | 24110 | [#5] yui.html Cycles:180 Average:17689.30 Median:459.70 stddev:25450.63 (5536.3%) stddev-sans-first:25489.56 03:45:03 INFO - PROCESS | 24110 | Values: 567.5 570.1 577.3 585.8 628.1 12302.7 12494.7 13057.2 13118.1 13124.4 11701.2 11742.6 11752.3 11775.5 11795.8 605.4 747.1 766.3 768.1 768.1 731.7 764.9 765.4 769.7 769.8 808.4 810.3 811.2 812.1 812.2 626.5 801.2 801.9 802.6 802.8 565.4 580.1 585.6 587.2 587.7 11971.3 12031.6 12061.2 12094.6 12098.0 11649.3 12212.8 12418.7 12421.3 12612.7 11317.4 11386.5 11653.1 11661.7 11910.4 4056.6 4107.9 4137.1 4140.4 4150.7 65473.3 67114.0 67355.3 67662.3 67733.7 9962.8 10002.5 10189.7 10409.2 10584.3 19297.8 19361.9 19374.5 19417.8 19426.2 6469.2 6530.9 6767.4 6815.7 6864.2 3616.4 3627.8 3633.0 3716.7 3720.2 2562.6 2631.3 2654.2 2659.0 2666.1 482.8 486.0 489.4 495.6 501.5 436.0 456.5 462.9 463.2 479.1 6996.8 7244.7 7654.1 7908.1 7944.7 435.2 479.2 496.3 510.9 520.2 3282.0 3417.1 3478.5 3479.8 3654.7 53367.0 58652.0 101030.5 104316.5 104610.0 86766.0 89971.6 91055.5 91280.5 91627.5 55386.7 75694.6 76151.6 76419.0 80386.2 6714.2 6838.8 6876.7 6927.3 7002.0 48119.0 48396.5 48568.3 48569.3 50066.7 51761.7 58501.7 65690.7 70375.3 71017.3 11170.2 11353.3 11622.8 11649.7 12006.8 12638.9 12642.4 13538.6 13542.3 13548.7 11036.9 11119.9 11519.7 11658.5 12017.6 10944.0 11312.6 11328.0 11383.4 11550.8 10912.2 11559.5 11630.0 11847.6 11998.9 9882.8 9995.2 10374.8 10624.6 10973.2 9913.3 9919.3 10005.3 10006.3 10011.9 03:45:03 INFO - PROCESS | 24110 | -------- Summary: end -------- 03:45:03 INFO - PROCESS | 24110 | 03:45:04 INFO - TEST-INFO | 24110: exit 0 03:45:04 INFO - TEST-OK | dromaeo_css | took 1121061ms 03:45:04 INFO - TEST-START | kraken 03:45:04 INFO - operating with platform_type : linux_ 03:45:04 INFO - Initialising browser for kraken test... 03:45:04 INFO - TEST-INFO | started process 24424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeCTfYj/profile http://localhost:51499/getInfo.html) 03:45:08 INFO - PROCESS | 24424 | __metrics Screen width/height:1600/1200 03:45:08 INFO - PROCESS | 24424 | colorDepth:24 03:45:08 INFO - PROCESS | 24424 | Browser inner width/height: 1024/697 03:45:08 INFO - PROCESS | 24424 | __metrics 03:45:09 INFO - PROCESS | 24424 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:45:09 INFO - PROCESS | 24424 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:45:10 INFO - PROCESS | 24424 | console.error: PushService: 03:45:10 INFO - PROCESS | 24424 | stateChangeProcessEnqueue: Error transitioning state 03:45:10 INFO - PROCESS | 24424 | UnknownError 03:45:10 INFO - TEST-INFO | 24424: exit 0 03:45:10 INFO - Browser initialized. 03:45:10 INFO - Running cycle 1/1 for kraken test... 03:45:10 INFO - TEST-INFO | started process 24502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeCTfYj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:22 INFO - PROCESS | 24502 | RSS: Main: 175116288 03:45:22 INFO - PROCESS | 24502 | 03:45:25 INFO - PROCESS | 24502 | Cycle 1(1): loaded http://localhost:51499/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51499/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:26 INFO - PROCESS | 24502 | RSS: Main: 235225088 03:45:26 INFO - PROCESS | 24502 | 03:45:29 INFO - PROCESS | 24502 | Cycle 1(1): loaded http://localhost:51499/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51499/tests/kraken/driver.html?testName=audio-dft) 03:45:29 INFO - PROCESS | 24502 | RSS: Main: 226873344 03:45:29 INFO - PROCESS | 24502 | 03:45:33 INFO - PROCESS | 24502 | Cycle 1(1): loaded http://localhost:51499/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51499/tests/kraken/driver.html?testName=audio-fft) 03:45:33 INFO - PROCESS | 24502 | RSS: Main: 300486656 03:45:33 INFO - PROCESS | 24502 | 03:45:36 INFO - PROCESS | 24502 | Cycle 1(1): loaded http://localhost:51499/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51499/tests/kraken/driver.html?testName=audio-oscillator) 03:45:36 INFO - PROCESS | 24502 | RSS: Main: 209104896 03:45:36 INFO - PROCESS | 24502 | 03:45:38 INFO - PROCESS | 24502 | Cycle 1(1): loaded http://localhost:51499/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51499/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:45:39 INFO - PROCESS | 24502 | RSS: Main: 213803008 03:45:39 INFO - PROCESS | 24502 | 03:45:42 INFO - PROCESS | 24502 | Cycle 1(1): loaded http://localhost:51499/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51499/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:43 INFO - PROCESS | 24502 | RSS: Main: 249999360 03:45:43 INFO - PROCESS | 24502 | 03:45:46 INFO - PROCESS | 24502 | Cycle 1(1): loaded http://localhost:51499/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51499/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:47 INFO - PROCESS | 24502 | RSS: Main: 243269632 03:45:47 INFO - PROCESS | 24502 | 03:45:50 INFO - PROCESS | 24502 | Cycle 1(1): loaded http://localhost:51499/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51499/tests/kraken/driver.html?testName=json-parse-financial) 03:45:51 INFO - PROCESS | 24502 | RSS: Main: 247586816 03:45:51 INFO - PROCESS | 24502 | 03:45:52 INFO - PROCESS | 24502 | Cycle 1(1): loaded http://localhost:51499/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51499/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:45:53 INFO - PROCESS | 24502 | RSS: Main: 211120128 03:45:53 INFO - PROCESS | 24502 | 03:45:55 INFO - PROCESS | 24502 | Cycle 1(1): loaded http://localhost:51499/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51499/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:45:55 INFO - PROCESS | 24502 | RSS: Main: 219033600 03:45:55 INFO - PROCESS | 24502 | 03:45:58 INFO - PROCESS | 24502 | Cycle 1(1): loaded http://localhost:51499/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51499/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:45:58 INFO - PROCESS | 24502 | RSS: Main: 223584256 03:45:58 INFO - PROCESS | 24502 | 03:46:01 INFO - PROCESS | 24502 | Cycle 1(1): loaded http://localhost:51499/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51499/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:46:02 INFO - PROCESS | 24502 | RSS: Main: 217743360 03:46:02 INFO - PROCESS | 24502 | 03:46:05 INFO - PROCESS | 24502 | Cycle 1(1): loaded http://localhost:51499/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51499/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:05 INFO - PROCESS | 24502 | RSS: Main: 220950528 03:46:05 INFO - PROCESS | 24502 | 03:46:07 INFO - PROCESS | 24502 | Cycle 1(1): loaded http://localhost:51499/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51499/tests/kraken/driver.html?testName=ai-astar) 03:46:07 INFO - PROCESS | 24502 | RSS: Main: 272031744 03:46:07 INFO - PROCESS | 24502 | 03:46:07 INFO - PROCESS | 24502 | __start_tp_report 03:46:07 INFO - PROCESS | 24502 | _x_x_mozilla_page_load 03:46:07 INFO - PROCESS | 24502 | _x_x_mozilla_page_load_details 03:46:07 INFO - PROCESS | 24502 | |i|pagename|runs| 03:46:07 INFO - PROCESS | 24502 | |0;ai-astar;103;114;111;113;113;115;120;115;115;115 03:46:07 INFO - PROCESS | 24502 | |1;audio-beat-detection;144;126;151;192;134;150;144;123;189;124 03:46:07 INFO - PROCESS | 24502 | |2;audio-dft;163;162;161;162;164;161;160;162;162;159 03:46:07 INFO - PROCESS | 24502 | |3;audio-fft;77;77;111;115;77;76;76;118;118;76 03:46:07 INFO - PROCESS | 24502 | |4;audio-oscillator;86;86;152;86;87;87;139;85;86;141 03:46:07 INFO - PROCESS | 24502 | |5;imaging-gaussian-blur;117;117;117;116;117;117;118;118;118;124 03:46:07 INFO - PROCESS | 24502 | |6;imaging-darkroom;147;148;148;148;148;147;147;147;148;147 03:46:07 INFO - PROCESS | 24502 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;95;95 03:46:07 INFO - PROCESS | 24502 | |8;json-parse-financial;65;65;66;67;67;66;72;66;66;65 03:46:07 INFO - PROCESS | 24502 | |9;json-stringify-tinderbox;66;67;66;67;68;74;65;66;66;66 03:46:07 INFO - PROCESS | 24502 | |10;stanford-crypto-aes;84;83;87;81;92;82;91;83;83;95 03:46:07 INFO - PROCESS | 24502 | |11;stanford-crypto-ccm;137;133;142;140;130;141;135;129;154;130 03:46:07 INFO - PROCESS | 24502 | |12;stanford-crypto-pbkdf2;176;173;177;173;176;178;173;172;172;170 03:46:07 INFO - PROCESS | 24502 | |13;stanford-crypto-sha256-iterative;68;72;71;70;71;68;69;69;67;68 03:46:07 INFO - PROCESS | 24502 | __end_tp_report 03:46:07 INFO - PROCESS | 24502 | __start_cc_report 03:46:07 INFO - PROCESS | 24502 | _x_x_mozilla_cycle_collect,1989 03:46:07 INFO - PROCESS | 24502 | __end_cc_report 03:46:07 INFO - PROCESS | 24502 | __startTimestamp1471949167990__endTimestamp 03:46:07 INFO - PROCESS | 24502 | 03:46:07 INFO - PROCESS | 24502 | ------- Summary: start ------- 03:46:07 INFO - PROCESS | 24502 | Number of tests: 14 03:46:07 INFO - PROCESS | 24502 | 03:46:07 INFO - PROCESS | 24502 | [#0] ai-astar Cycles:10 Average:113.40 Median:115.00 stddev:4.33 (3.8%) stddev-sans-first:2.46 03:46:07 INFO - PROCESS | 24502 | Values: 103.0 114.0 111.0 113.0 113.0 115.0 120.0 115.0 115.0 115.0 03:46:07 INFO - PROCESS | 24502 | 03:46:08 INFO - PROCESS | 24502 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:147.00 stddev:24.82 (16.9%) stddev-sans-first:26.28 03:46:08 INFO - PROCESS | 24502 | Values: 144.0 126.0 151.0 192.0 134.0 150.0 144.0 123.0 189.0 124.0 03:46:08 INFO - PROCESS | 24502 | 03:46:08 INFO - PROCESS | 24502 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.43 (0.9%) stddev-sans-first:1.42 03:46:08 INFO - PROCESS | 24502 | Values: 163.0 162.0 161.0 162.0 164.0 161.0 160.0 162.0 162.0 159.0 03:46:08 INFO - PROCESS | 24502 | 03:46:08 INFO - PROCESS | 24502 | [#3] audio-fft Cycles:10 Average:92.10 Median:76.00 stddev:20.23 (26.6%) stddev-sans-first:20.71 03:46:08 INFO - PROCESS | 24502 | Values: 77.0 77.0 111.0 115.0 77.0 76.0 76.0 118.0 118.0 76.0 03:46:08 INFO - PROCESS | 24502 | 03:46:08 INFO - PROCESS | 24502 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:86.00 stddev:28.15 (32.7%) stddev-sans-first:29.13 03:46:08 INFO - PROCESS | 24502 | Values: 86.0 86.0 152.0 86.0 87.0 87.0 139.0 85.0 86.0 141.0 03:46:08 INFO - PROCESS | 24502 | 03:46:08 INFO - PROCESS | 24502 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:117.50 stddev:2.23 (1.9%) stddev-sans-first:2.35 03:46:08 INFO - PROCESS | 24502 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 118.0 118.0 118.0 124.0 03:46:08 INFO - PROCESS | 24502 | 03:46:08 INFO - PROCESS | 24502 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 03:46:08 INFO - PROCESS | 24502 | Values: 147.0 148.0 148.0 148.0 148.0 147.0 147.0 147.0 148.0 147.0 03:46:08 INFO - PROCESS | 24502 | 03:46:08 INFO - PROCESS | 24502 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:46:08 INFO - PROCESS | 24502 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 03:46:08 INFO - PROCESS | 24502 | 03:46:08 INFO - PROCESS | 24502 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:66.00 stddev:2.07 (3.1%) stddev-sans-first:2.12 03:46:08 INFO - PROCESS | 24502 | Values: 65.0 65.0 66.0 67.0 67.0 66.0 72.0 66.0 66.0 65.0 03:46:08 INFO - PROCESS | 24502 | 03:46:08 INFO - PROCESS | 24502 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:66.50 stddev:2.56 (3.8%) stddev-sans-first:2.68 03:46:08 INFO - PROCESS | 24502 | Values: 66.0 67.0 66.0 67.0 68.0 74.0 65.0 66.0 66.0 66.0 03:46:08 INFO - PROCESS | 24502 | 03:46:08 INFO - PROCESS | 24502 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:85.50 stddev:4.89 (5.7%) stddev-sans-first:5.12 03:46:08 INFO - PROCESS | 24502 | Values: 84.0 83.0 87.0 81.0 92.0 82.0 91.0 83.0 83.0 95.0 03:46:08 INFO - PROCESS | 24502 | 03:46:08 INFO - PROCESS | 24502 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:138.50 stddev:7.61 (5.5%) stddev-sans-first:8.07 03:46:08 INFO - PROCESS | 24502 | Values: 137.0 133.0 142.0 140.0 130.0 141.0 135.0 129.0 154.0 130.0 03:46:08 INFO - PROCESS | 24502 | 03:46:08 INFO - PROCESS | 24502 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:174.50 stddev:2.58 (1.5%) stddev-sans-first:2.64 03:46:08 INFO - PROCESS | 24502 | Values: 176.0 173.0 177.0 173.0 176.0 178.0 173.0 172.0 172.0 170.0 03:46:08 INFO - PROCESS | 24502 | 03:46:08 INFO - PROCESS | 24502 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.64 (2.4%) stddev-sans-first:1.67 03:46:08 INFO - PROCESS | 24502 | Values: 68.0 72.0 71.0 70.0 71.0 68.0 69.0 69.0 67.0 68.0 03:46:08 INFO - PROCESS | 24502 | -------- Summary: end -------- 03:46:08 INFO - PROCESS | 24502 | 03:46:09 INFO - TEST-INFO | 24502: exit 0 03:46:09 INFO - TEST-OK | kraken | took 64677ms 03:46:09 INFO - SUITE-END | took 1185s 03:46:09 INFO - Completed test suite (00:19:46) 03:46:09 INFO - javascript benchmark 03:46:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2541.288439237014, 2596.8312059716104, 2599.9350016249596, 2608.1653870761365, 2618.1229288188456, 4588.747618880969, 4689.624830013599, 4689.69516981396, 4709.246520556711, 4736.1711700452415, 4704.623630109591, 4714.764261786905, 4751.9762401187945, 4787.904241915159, 4814.518548145184, 4311.439512863323, 4345.065810850667, 4397.538258482861, 4426.092651006536, 4438.979034821977, 4392.912141757163, 4427.026054268056, 4435.62297204738, 4435.8225670973125, 4454.710443821141, 4207.64235040022, 4293.914121717579, 4390.0, 4393.165298593257, 4437.290033594625, 4305.440292761952, 4382.233109205877, 4388.956110438887, 4401.471823381215, 4411.647068234533, 4347.586979236968, 4349.826006959718, 4360.585744354281, 4365.279728844736, 4367.519572846984, 4568.474625418053, 4641.930371044437, 4754.286856971447, 4756.6432517561325, 4773.952260477386, 5035.77339019745, 5104.387473503203, 5110.310108135392, 5133.101707201225, 5133.691978481265, 5113.923291150636, 5137.38351397831, 5144.099782538078, 5145.30538377318, 5149.150390185615, 4603.654725895572, 4706.482286948433, 4818.253170758538, 4819.228923372244, 4831.758412079382, 5172.870678233075, 5265.736713164327, 5284.5772338212855, 5292.232626269247, 5293.57651387888, 5030.547250747377, 5066.847994560169, 5068.366454193226, 5068.518490743373, 5072.416672082684, 4913.238448040559, 5107.182850743863, 5115.462876397999, 5115.488451154929, 5122.820701275437, 4960.50394960501, 4990.251462280687, 5017.949820501822, 5061.291419201315, 5063.417706963673, 5047.747612619354, 5061.493850614983, 5065.822696205615, 5066.771995260222, 5070.163423035158, 4169.687273454503, 4290.506591741927, 4299.656027517791, 4301.634361079281, 4302.806373713128, 3683.318586061587, 3726.720495962814, 3763.6612704856693, 3781.8487260509273, 3835.271298453285, 4358.106588149421, 4392.363107349481, 4396.736195828196, 4397.714148580332, 4403.119376124788, 4958.9504104959215, 5156.587473002151, 5161.716105614228, 5167.405748338914, 5172.9741351293005, 4269.0, 4295.613394794484, 4302.612764851116, 4333.241682705514, 4341.826326946887, 4536.274196128604, 4551.749653769009, 4560.361549383089, 4560.657950653715, 4563.38394316763, 4670.649701272486, 4784.784684689197, 4789.425268967746, 4793.161196790617, 4796.880077998078, 5073.315102461121, 5088.720120393414, 5108.182690769459, 5115.4373018967135, 5166.45752196014, 4821.807127714992, 4822.638302127425, 4823.686460380064, 4828.758562071812, 4845.079434907357, 4880.487548807466, 5042.168042272984, 5072.949270507248, 5081.669691470042, 5119.052975199451, 5035.144025515598, 5092.159793634009, 5094.7962081516325, 5145.0, 5166.328377310925, 5016.974915125401, 5029.798808047637, 5030.270610761492, 5031.195008798721, 5032.798688052437, 4850.6362022847725, 4988.750562471934, 5012.724300163526, 5016.322796422436, 5019.0463811875625, 4818.759062046814, 4846.0, 4883.951160488492, 4931.802727890844, 4968.080905032436, 5018.648694591344, 5037.949620503748, 5044.218146187347, 5045.596352291881, 5077.568406685473, 4760.0, 4918.0, 4964.280179374043, 4966.0, 4974.9751251243515], "value": 4669.350512883618, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.8058319879641, 565.355494736001, 575.6431012772082, 579.5682216748521, 585.3765739487449, 38491.61508384919, 40108.39837402438, 40286.798566007164, 43348.566514334845, 43373.0, 40681.59318406815, 40698.18603627933, 40808.0, 41168.0, 41280.79359603198, 7613.2386761323705, 7766.611669416507, 7783.221677832228, 7790.909272701826, 7815.882761758578, 7749.457537972316, 7841.843163136762, 7843.64703588337, 7846.293833554979, 7853.214678532158, 7843.764687059397, 7880.0, 7884.0, 7884.4875083119705, 7886.763397098096, 7810.531368117902, 7851.960740196262, 7860.724874629418, 7860.842783144305, 7863.488873223251, 7735.535867847947, 7792.376609871197, 7803.531788092732, 7810.492317999368, 7812.375009999187, 37838.243235135145, 38204.23591528154, 38261.42607860884, 38278.0, 38284.23431531381, 2680.6113113598417, 2694.8517831519257, 2734.398432344901, 2790.4279622677304, 3078.122735020531, 28761.856190718914, 28908.0, 28936.0, 29326.85336573325, 29791.255218619706, 3416.40212962733, 3464.20323325634, 3513.6662017108333, 3571.482135090397, 3635.1093981974323, 251947.0, 253649.0, 256369.0, 256482.0, 257582.0, 49552.256716149284, 50325.49674503281, 50328.24507632388, 50328.496715033114, 50446.0, 32640.0, 53319.73340133352, 53457.7327113362, 53470.73264633652, 53472.73263633657, 12738.617841464771, 13436.19382837033, 13444.395002224923, 13454.394552245172, 13487.258200798855, 10000.0, 10097.636819029338, 10107.494625268855, 10114.848277275847, 10117.342372745748, 17940.372086976895, 18030.549236268937, 18048.548786280186, 18054.277828886698, 18078.0, 6606.570572912745, 6634.701438435282, 6660.467162626978, 6733.966330168416, 6991.545549539263, 795.9243871832167, 824.5464994253136, 960.7942032748855, 971.718201721507, 984.5175863826673, 27645.723542764717, 28017.57973630397, 28413.147605571867, 28772.712272877423, 28813.56779648307, 904.7285814255829, 913.0869130869131, 915.0803442540205, 928.8095940332215, 956.0773853231526, 14139.50511732105, 14864.702705946036, 14908.62728431798, 14912.105273683614, 15248.390064397521, 370261.0, 373100.0, 373878.0, 373880.0, 374595.0, 48437.0, 48921.510784891696, 48957.510424896005, 49008.754956225705, 49122.75438622784, 1069.9358038517714, 1157.2477889371976, 1165.685264978451, 1173.906087513014, 1180.4418168018133, 27277.318067048483, 28649.42701146007, 28967.130986070453, 29290.41842040109, 29396.41207175802, 41039.38440923329, 41668.0, 41853.372199417645, 41874.58125418707, 41883.581164189185, 294279.0, 296024.0, 296118.0, 296209.0, 297064.0, 22089.889550552143, 25409.61885571755, 25568.23295301144, 25945.6108158374, 26719.866400667874, 40302.19395612013, 40788.59211407848, 40946.385804213554, 41093.38359924544, 42164.156716866106, 35328.233588320996, 35613.64386356103, 35804.28391432209, 36044.81977590095, 36330.55587489932, 34871.0, 35149.0, 35579.35043965456, 35675.82162089173, 35847.10382240465, 34545.65454345424, 34829.65170348264, 35820.0, 35939.64060359363, 36509.26981460303, 30566.84716576403, 32716.0, 33067.66932330646, 33420.49869251915, 33508.329833402706, 24929.376765581004, 25597.3600659985, 25704.228873133838, 25894.87052564725, 26325.605115922892], "value": 17237.093341448817, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.45867071356537, 342.88170581149495, 350.8368608597002, 356.3994668982764, 366.0665303476137, 12827.679308017305, 16195.514134575968, 16708.74936875946, 16759.91620041901, 17681.7347739784, 15005.92497037516, 15099.471518496855, 15489.535313940572, 15856.0, 15995.680086398264, 4357.0, 4937.284093806405, 5075.873103172414, 5114.977004599076, 5132.40977287613, 5008.29883816266, 5091.567216786559, 5093.414257360414, 5095.108356037697, 5096.719680417576, 4835.911919818048, 4988.0, 5015.924761128586, 5073.188289873621, 5074.949250507485, 4926.211806111023, 5045.823396181153, 5046.84859454217, 5051.3433253676785, 5052.242163675442, 4411.933820992687, 4470.128324976631, 4505.932411013838, 4513.435820522434, 4575.771211439414, 19810.504737381536, 19939.30212442572, 20083.89958050215, 20411.183552657876, 20552.177912883468, 2038.347728726808, 2177.2488491470417, 2383.249276477904, 2406.891689873942, 2468.7037555493275, 12415.93792031034, 13053.282069486175, 13400.5309814157, 13753.931230343884, 13822.0, 1705.84647381735, 1730.7576939228518, 1737.661156074566, 1755.604988877505, 1801.5766294920684, 64949.67525162344, 65560.0, 66787.0, 68621.65689171522, 68679.65660171717, 8922.107789221156, 8998.50508222041, 9073.863892041625, 9570.090841370058, 9917.950410248048, 12949.741005179843, 12967.351632418342, 12986.35068246584, 12986.870131298756, 12987.675308117372, 6776.42400395962, 7117.958000367978, 7217.603031833194, 7269.0, 7279.490435669452, 6715.7985260442265, 6783.457323414115, 6788.898166527506, 6928.549644273106, 6962.338577835098, 6107.953835465169, 6134.2332208473945, 6189.6286222826775, 6200.410960958701, 6283.685815709287, 1711.2128420926265, 1728.6749322161672, 1734.9479515614553, 1781.0738416023596, 1784.9375271865422, 807.4307613132727, 835.3233880556647, 874.4359887872287, 909.7316291693966, 933.7292185266197, 16983.036954848452, 16996.660066798842, 17556.824431755773, 17623.0, 17990.1004949752, 854.9059603443616, 863.3783675753448, 875.4309698695898, 907.7004588485784, 955.9235261179089, 9977.0, 10013.499325033865, 10089.192864570818, 10093.444860532594, 10143.898561014295, 368631.0, 369218.0, 369727.0, 390808.0, 393292.0, 67105.6644716783, 67826.321736782, 68184.0, 68199.3180068193, 69614.3038569618, 905.4024343932973, 917.8531434970373, 923.9769005774775, 931.6971984105057, 933.3093510801957, 15018.324175412352, 15152.318145683692, 15623.843761562239, 16026.439074632332, 16139.75790363122, 33751.83124084364, 34677.82661086678, 35430.0, 35445.82277088598, 38562.421563677126, 45174.77412612916, 48407.0, 49685.75157124191, 49813.501864980884, 51114.23328649999, 6520.706568204348, 6595.538312318092, 6667.299933506912, 7223.205447400676, 7588.430867684835, 10754.784904301714, 11462.0, 11612.825807612724, 11666.533338666359, 12086.818697719717, 9734.296498112944, 10101.949490252502, 10291.125254353465, 10458.006489383497, 10509.632162874263, 10003.149732272546, 10012.44931528773, 10060.446675432922, 10483.47582620881, 10573.8942610576, 9969.102780749767, 10073.84889226677, 10280.485975701335, 10574.89425105739, 10653.147748180281, 6612.70242839083, 6753.189617245962, 6761.594304341756, 6790.049393085071, 6982.825429364307, 9485.668001620186, 9720.833499979764, 9839.85240221383, 10031.039705991672, 10463.162946964072], "value": 8127.665186413258, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1227.7667243223782, 1235.5366737473448, 1340.939657715403, 1372.6842826149984, 1650.4306014425026, 6669.866602667944, 7292.927070729291, 7573.0, 7577.545347279167, 7598.73404430845, 7333.633318334076, 7462.21646727094, 7477.962610186955, 7662.693492260317, 7674.040744906887, 2091.4875855415407, 2133.57328534293, 2137.7007218989274, 2137.9893100534478, 2139.764625891151, 2073.6163809695254, 2122.2359950417836, 2161.7081693971268, 2163.653815389538, 2163.8593491423085, 2103.053625868358, 2123.6495978163584, 2124.4476436126643, 2126.1176611706123, 2160.4274867160216, 2108.8207502362316, 2112.0390222448827, 2112.6936594193758, 2113.323736404351, 2116.365090472852, 2062.4019034479984, 2093.769685334612, 2094.675325324577, 2095.3609149209483, 2096.811286984179, 7326.04761381017, 7365.742199023062, 7391.889121663179, 7439.032925719676, 7443.478956473049, 4053.61490658387, 4234.597713217239, 4235.428217190702, 4243.469566304212, 4247.68142389322, 2761.62718033067, 2936.2365784896083, 2952.409518096389, 2959.3045634275927, 2993.4911065118763, 932.8787257656461, 935.1023017902821, 939.056248470283, 949.4113649537262, 951.0537015669453, 10327.79344413115, 10512.632057877938, 10514.421706806123, 10523.684789346331, 10525.736856578571, 3980.960190398117, 4031.1333063390925, 4105.158442519277, 4125.257453658371, 4186.727862688916, 8187.058488273806, 8339.624716887754, 8349.666013359398, 8352.958235208785, 8357.373197010249, 4328.394024836525, 4329.76186309756, 4331.97834010828, 4339.891502712394, 4354.760488173118, 3526.3828829954655, 3759.830807613664, 3892.2020985697864, 3995.0, 3996.7801770902297, 3338.315645292709, 3372.8482218299746, 3472.2013936794174, 3478.9652103478643, 3525.3125640499857, 1017.862588550551, 1018.2821111116644, 1036.6838114375037, 1039.3555995282973, 1041.703114612347, 620.4694985787178, 665.2848188197706, 734.930181632744, 736.7347754808264, 751.8345963887936, 4819.927701084486, 4935.457099719028, 5114.6931184128325, 5201.713905735145, 5340.839774806762, 786.0, 814.8818421328992, 844.6536919862826, 868.2142660891903, 899.4198741811625, 3253.6258330291844, 3254.2515221498716, 3259.9837000814846, 3319.186799234155, 3478.826058697055, 9198.908010919939, 9553.952230238805, 9578.090081442251, 9586.712398628053, 9587.616495340248, 9523.714288571355, 9528.475933823567, 9529.047095290416, 9532.0, 9554.856677149848, 7303.160136584254, 7347.595882226529, 7404.481686282016, 7430.851382972311, 7439.404847612178, 4893.486183950634, 4939.160342741814, 4978.377702787152, 5018.698878067327, 5133.101707201299, 8641.308695304235, 8819.470831750115, 8927.196552310323, 8956.507392093497, 9019.81960360776, 8861.158189971942, 8991.91008089937, 9039.819203616022, 9099.636014559343, 9108.134727200906, 6028.668423236764, 6173.104899789595, 6212.285587157354, 6218.253809542884, 6226.283977342482, 7176.9641151795995, 7215.567065976058, 7223.1693355264815, 7224.458165637703, 7228.89156662661, 6370.0, 6447.838804029937, 6474.320196379501, 6491.870162596627, 6583.63789991555, 6390.680465976776, 6495.382938620824, 6521.608703477807, 6647.767328143492, 6685.264620891795, 5800.8259752207505, 5880.617759845596, 5884.617499862496, 5885.440883116097, 5887.52899768009, 4457.353683715778, 4481.865544033684, 4565.863024109282, 4612.192866248461, 4615.676902616785, 4422.601965823092, 4478.104379124123, 4573.81704731807, 4598.8620341389815, 4796.208625576741], "value": 3968.4523844549362, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.9728325809048, 288.97977141600086, 295.9215807810929, 299.34742261869116, 299.9681097026231, 4678.181318269306, 4682.695624784391, 4696.882577935549, 4710.57604815567, 4726.314684370765, 4655.4878963314, 4683.50823163568, 4686.179918514264, 4695.131400690874, 4704.4589872164715, 3505.3865573524595, 3581.158427769472, 3581.4985901973614, 3683.37382644951, 3713.1274150574595, 3685.649863262986, 3697.9445308320396, 3706.7219958503083, 3715.1640880801738, 3719.79541125238, 3670.522832031832, 3672.320620685182, 3678.50340204073, 3678.9448158277646, 3694.833732482045, 3488.947665785015, 3564.4475106358686, 3643.107438677541, 3707.2029513654425, 3720.6465385788306, 3271.7055465008025, 3279.196596833767, 3281.7210537104374, 3282.688144626257, 3282.7045565899184, 4610.654200934943, 4612.863252987967, 4613.930791038104, 4615.192341340286, 4638.234691275936, 3987.0, 4163.271427500175, 4225.492940847087, 4238.533761286256, 4242.978785106055, 4856.732879691615, 4891.8287859925085, 4905.23968784839, 4916.1888288432365, 4931.235658472942, 3605.278944211142, 3615.7107431405425, 3616.9276614467826, 3622.1487950331652, 3633.8909832705062, 4945.307656928033, 5132.0, 5170.836561773608, 5171.456997015334, 5171.793128274864, 3658.5061016762397, 3678.1172518595345, 3682.3739964205615, 3682.502862113634, 3684.7604905681046, 3707.277080969185, 3709.554853417553, 3714.9071273218387, 3720.1257704439436, 3721.4975978243133, 4193.161367726467, 4201.382467749877, 4214.262504061777, 4222.535521092677, 4226.5773422657485, 4771.475137734847, 4890.315355850184, 4923.187674033744, 4926.1379258629595, 4926.950730492649, 1277.2528071078336, 1289.7484990426965, 1291.6383412644475, 1293.353323338331, 1293.7089154940063, 837.8073043200098, 841.7769291137853, 850.6724910909345, 856.6016802187013, 884.8716936044366, 4264.296391095435, 4274.615284624399, 4277.230098582285, 4279.636230920344, 4290.957090429056, 4968.180250258739, 4972.477889821516, 4973.278874563168, 4976.855323275667, 4977.726225057657, 4212.304969679968, 4256.021115143534, 4268.722533035343, 4270.679699022586, 4278.914421711548, 2534.0741036811787, 2652.58884872845, 2690.502257082446, 2696.934710789227, 2698.9595156072673, 4791.257355109963, 4795.904081918412, 4802.375691160127, 4805.3512775775525, 4812.590929771009, 4966.701997880139, 5189.0, 5207.713575753294, 5212.791488340424, 5213.947860521346, 4774.856754297377, 4786.736729479772, 4800.423949126058, 4800.783964721596, 4804.807807687654, 5018.787975695484, 5023.522765337433, 5042.546170844642, 5045.571126454292, 5048.671836330626, 4732.02993386348, 4977.776000080077, 4978.352814134139, 4979.3277907482025, 4981.501849814989, 4763.7856296467435, 4817.373741413594, 4819.542143496362, 4819.975610243636, 4820.39745031871, 3586.677199052098, 3594.4608308753895, 3600.4599310103695, 3610.4403817408343, 3612.1330880587943, 5015.649063540108, 5044.722540260174, 5083.364579427572, 5103.515166059218, 5126.820561280338, 4860.3195552623365, 4917.508249175054, 4952.653314267966, 4964.354633897715, 4964.578010869117, 4939.135651260943, 4950.391122885005, 4950.752462376795, 4951.9752401237765, 4961.454240033521, 4870.147724148189, 4883.633727470525, 4890.6087512998165, 4891.877703057452, 4909.0, 4746.2168742157155, 4767.0, 4821.710697358169, 4947.3321101652255, 4982.0, 4828.734419606955, 4842.4673285937815, 4844.733539655353, 4845.6608037438455, 4888.144574699342], "value": 3724.0391216770568, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.531786276322, 570.1220121013637, 577.3043482603463, 585.7598384662286, 628.1237673445543, 12302.692432689177, 12494.687632809184, 13057.216567005986, 13118.081734278605, 13124.409401576928, 11701.23941943773, 11742.589009384674, 11752.294862308247, 11775.528978840857, 11795.761445048254, 605.4036773777825, 747.0512449189513, 766.3103207113587, 768.0629631849135, 768.1473564343574, 731.6926890705889, 764.8661484240264, 765.3609236287706, 769.6651956398956, 769.7767647382252, 808.3654331349892, 810.3233799777194, 811.2050190813006, 812.1310198088048, 812.212154210415, 626.5081910700125, 801.2428255298745, 801.9077806052292, 802.626778547975, 802.8273921106932, 565.3837317324095, 580.051615608479, 585.6134950932365, 587.157429089254, 587.6679675983056, 11971.281723096643, 12031.578894738643, 12061.155719099666, 12094.637160885188, 12098.0, 11649.301041937426, 12212.755744885053, 12418.689532761662, 12421.254724716455, 12612.684682883002, 11317.377544235063, 11386.544538218544, 11653.067754579613, 11661.650150495414, 11910.404479775976, 4056.553779084298, 4107.944383833247, 4137.089840235173, 4140.426637877617, 4150.730202536825, 65473.3452665472, 67114.0, 67355.32644673588, 67662.32337676658, 67733.66133169303, 9962.750931226632, 10002.549885255181, 10189.745256368502, 10409.219308551888, 10584.312019718695, 19297.807021929882, 19361.903190483958, 19374.515637109183, 19417.805821941598, 19426.22295108208, 6469.223693156851, 6530.902036469457, 6767.39093481589, 6815.659217039129, 6864.21061577925, 3616.367135751233, 3627.818609069536, 3632.9636703632627, 3716.6655001050035, 3720.2187540616774, 2562.551553478134, 2631.2632462910415, 2654.2170059832397, 2658.9895839581222, 2666.080202330193, 482.82859584847574, 485.97944316934155, 489.4273699771276, 495.55895253224656, 501.48347202381603, 436.0254830453933, 456.51609294148307, 462.89353448706987, 463.2264118921342, 479.1112486337793, 6996.790096297119, 7244.710211591583, 7654.119776225694, 7908.090569584571, 7944.721934732257, 435.20357745325975, 479.1662507237451, 496.3473032961644, 510.9208072748656, 520.2352541763602, 3281.967180328214, 3417.111550996709, 3478.4956181353564, 3479.8434070466888, 3654.6710796028483, 53367.0, 58652.0, 101030.49484752676, 104316.47841760743, 104610.0, 86765.98510223391, 89971.55014225018, 91055.54472227597, 91280.54359728159, 91627.54186229027, 55386.72306638441, 75694.62152689311, 76151.61924190343, 76419.0, 80386.19613803788, 6714.227863795726, 6838.760643377458, 6876.724931002904, 6927.272636373108, 7002.0, 48118.9999999986, 48396.5160348392, 48568.271475928595, 48569.27146092882, 50066.749666252894, 51761.741191293804, 58501.70749146227, 65690.67154664196, 70375.29624703892, 71017.28982710106, 11170.157444047658, 11353.318800871974, 11622.825657614974, 11649.708757281136, 12006.819897701716, 12638.92569131634, 12642.367881606067, 13538.59384218475, 13542.255175965023, 13548.661283467993, 11036.889631103908, 11119.888801112209, 11519.712007199887, 11658.533658653898, 12017.63947081589, 10944.0, 11312.6040588579, 11328.0, 11383.373914434454, 11550.768984620092, 10912.181586380895, 11559.537618495166, 11630.0, 11847.646037479628, 11998.940005299917, 9882.802343952937, 9995.150897084062, 10374.844377334497, 10624.575016999543, 10973.231873769078, 9913.30606857513, 9919.305648604528, 10005.349652272578, 10006.29955903109, 10011.949940250252], "value": 6366.609378862115, "unit": "score"}], "name": "dromaeo_css", "value": 6283.672214108693, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 111.0, 113.0, 113.0, 115.0, 120.0, 115.0, 115.0, 115.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 126.0, 151.0, 192.0, 134.0, 150.0, 144.0, 123.0, 189.0, 124.0], "value": 147.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 162.0, 164.0, 161.0, 160.0, 162.0, 162.0, 159.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 111.0, 115.0, 77.0, 76.0, 76.0, 118.0, 118.0, 76.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 152.0, 86.0, 87.0, 87.0, 139.0, 85.0, 86.0, 141.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 118.0, 118.0, 124.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 67.0, 67.0, 66.0, 72.0, 66.0, 66.0, 65.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 68.0, 74.0, 65.0, 66.0, 66.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 87.0, 81.0, 92.0, 82.0, 91.0, 83.0, 83.0, 95.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 133.0, 142.0, 140.0, 130.0, 141.0, 135.0, 129.0, 154.0, 130.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 173.0, 177.0, 173.0, 176.0, 178.0, 173.0, 172.0, 172.0, 170.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 71.0, 70.0, 71.0, 68.0, 69.0, 69.0, 67.0, 68.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1578.6999999999996, "alertThreshold": 2.0}]} 03:46:09 INFO - Return code: 0 03:46:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:46:09 INFO - # TBPL SUCCESS # 03:46:09 INFO - Running post-action listener: _resource_record_post_action 03:46:09 INFO - [mozharness: 2016-08-23 10:46:09.812778Z] Finished run-tests step (success) 03:46:09 INFO - Running post-run listener: _resource_record_post_run 03:46:09 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 422895616; Read time: 16; Write time: 362892 03:46:09 INFO - TinderboxPrint: CPU usage
13.2% 03:46:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:46:09 INFO - TinderboxPrint: I/O write bytes / time
422,895,616 / 362,892 03:46:09 INFO - TinderboxPrint: CPU idle
8,326.9 (86.7%) 03:46:09 INFO - TinderboxPrint: CPU user
1,203.5 (12.5%) 03:46:09 INFO - TinderboxPrint: Swap in / out
0 / 0 03:46:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 130101248; Read time: 0; Write time: 107084 03:46:09 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292794368; Read time: 0; Write time: 255808 03:46:10 INFO - Running post-run listener: _upload_blobber_files 03:46:10 INFO - Blob upload gear active. 03:46:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:10 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 03:46:10 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'] 03:46:10 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 03:46:10 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:46:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:46:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:11 INFO - (blobuploader) - INFO - Done attempting. 03:46:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:46:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:46:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:16 INFO - (blobuploader) - INFO - Done attempting. 03:46:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:46:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:46:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:17 INFO - (blobuploader) - INFO - Done attempting. 03:46:17 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:17 INFO - Return code: 0 03:46:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1069212422db2c82690bc1d489764ae481c666fb0a07a2d4a51531aca6c3d7b8e038b06a143aa681daf26e97925c9d95361cecfeb8dd7f0a46170a555f9106a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99339fbd365055af4a28e7bf1be385d34f9c0a6ea128576aca7831c1182a09c3676b70bc11a7c767025aa93e946538deb85669eb486b723656befca31dc22dbd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/314145b10cc1af748c2d672ffe8b999178179c58c440e3df4f63ecaed36776c37d599df82509d7a6cd654791f1ce59faee06a31dd0f1ce0c18b6625bc7c90a66"} 03:46:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:17 INFO - Contents: 03:46:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1069212422db2c82690bc1d489764ae481c666fb0a07a2d4a51531aca6c3d7b8e038b06a143aa681daf26e97925c9d95361cecfeb8dd7f0a46170a555f9106a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99339fbd365055af4a28e7bf1be385d34f9c0a6ea128576aca7831c1182a09c3676b70bc11a7c767025aa93e946538deb85669eb486b723656befca31dc22dbd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/314145b10cc1af748c2d672ffe8b999178179c58c440e3df4f63ecaed36776c37d599df82509d7a6cd654791f1ce59faee06a31dd0f1ce0c18b6625bc7c90a66"} 03:46:17 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:17 INFO - Copying logs to upload dir... 03:46:17 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.213073 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-23 03:46:17.061075) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 03:46:17.065095) ========= 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-1471945677.832856-1968408251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1069212422db2c82690bc1d489764ae481c666fb0a07a2d4a51531aca6c3d7b8e038b06a143aa681daf26e97925c9d95361cecfeb8dd7f0a46170a555f9106a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99339fbd365055af4a28e7bf1be385d34f9c0a6ea128576aca7831c1182a09c3676b70bc11a7c767025aa93e946538deb85669eb486b723656befca31dc22dbd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/314145b10cc1af748c2d672ffe8b999178179c58c440e3df4f63ecaed36776c37d599df82509d7a6cd654791f1ce59faee06a31dd0f1ce0c18b6625bc7c90a66"} build_url:https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/Wm6cGn5gQHW09G4SuJlz6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1069212422db2c82690bc1d489764ae481c666fb0a07a2d4a51531aca6c3d7b8e038b06a143aa681daf26e97925c9d95361cecfeb8dd7f0a46170a555f9106a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99339fbd365055af4a28e7bf1be385d34f9c0a6ea128576aca7831c1182a09c3676b70bc11a7c767025aa93e946538deb85669eb486b723656befca31dc22dbd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/314145b10cc1af748c2d672ffe8b999178179c58c440e3df4f63ecaed36776c37d599df82509d7a6cd654791f1ce59faee06a31dd0f1ce0c18b6625bc7c90a66"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 03:46:17.090721) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 03:46:17.091068) ========= 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-1471945677.832856-1968408251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 03:46:17.173594) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 03:46:17.173929) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 03:46:17.174244) ========= ========= Total master_lag: 0.18 =========