builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1463176799.66 results: success (0) buildid: 20160513141649 builduid: 232ac1c20c41463ba19a5798e727b38c revision: c4a209a8e2a8483f71182ecfa6044b830fd85362 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 14:59:59.662685) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 14:59:59.663197) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 14:59:59.663494) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 14:59:59.679752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:59:59.680054) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 14:59:59-- 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% 51.1M=0s 2016-05-13 14:59:59 (51.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120942 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:59:59.814247) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:59:59.814590) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017087 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:59:59.864261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 14:59:59.864647) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c4a209a8e2a8483f71182ecfa6044b830fd85362 --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 c4a209a8e2a8483f71182ecfa6044b830fd85362 --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=edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 14:59:59,934 truncating revision to first 12 chars 2016-05-13 14:59:59,934 Setting DEBUG logging. 2016-05-13 14:59:59,934 attempt 1/10 2016-05-13 14:59:59,934 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c4a209a8e2a8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 15:00:01,590 unpacking tar archive at: fx-team-c4a209a8e2a8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.927356 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 15:00:01.806125) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 15:00:01.806469) ========= script_repo_revision: c4a209a8e2a8483f71182ecfa6044b830fd85362 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 15:00:01.806865) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 15:00:01.807136) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 15:00:01.816185) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-13 15:00:01.816488) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:00:01 INFO - MultiFileLogger online at 20160513 15:00:01 in /builds/slave/test 15:00:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:00:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:00:01 INFO - {'append_to_log': False, 15:00:01 INFO - 'base_work_dir': '/builds/slave/test', 15:00:01 INFO - 'blob_upload_branch': 'Fx-Team', 15:00:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:00:01 INFO - 'branch': 'Fx-Team', 15:00:01 INFO - 'buildbot_json_path': 'buildprops.json', 15:00:01 INFO - 'config_files': ('talos/linux_config.py',), 15:00:01 INFO - 'default_actions': ('clobber', 15:00:01 INFO - 'read-buildbot-config', 15:00:01 INFO - 'download-and-extract', 15:00:01 INFO - 'populate-webroot', 15:00:01 INFO - 'create-virtualenv', 15:00:01 INFO - 'install', 15:00:01 INFO - 'run-tests'), 15:00:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:00:01 INFO - 'download_minidump_stackwalk': True, 15:00:01 INFO - 'download_symbols': 'ondemand', 15:00:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:00:01 INFO - 'tooltool.py': '/tools/tooltool.py', 15:00:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:00:01 INFO - '/tools/misc-python/virtualenv.py')}, 15:00:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:00:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:00:01 INFO - 'installer_path': 'installer.exe', 15:00:01 INFO - 'log_level': 'info', 15:00:01 INFO - 'log_name': 'talos', 15:00:01 INFO - 'log_to_console': True, 15:00:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:00:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:00:01 INFO - 'opt_config_files': (), 15:00:01 INFO - 'pip_index': False, 15:00:01 INFO - 'sps_profile': False, 15:00:01 INFO - 'sps_profile_interval': 0, 15:00:01 INFO - 'suite': 'dromaeojs', 15:00:01 INFO - 'system_bits': '32', 15:00:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:00:01 INFO - 'title': 'talos-linux64-ix-033', 15:00:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:00:01 INFO - 'use_talos_json': True, 15:00:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:00:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:00:01 INFO - 'work_dir': 'build'} 15:00:01 INFO - ##### 15:00:01 INFO - ##### Running clobber step. 15:00:01 INFO - ##### 15:00:01 INFO - Running pre-action listener: _resource_record_pre_action 15:00:01 INFO - Running main action method: clobber 15:00:01 INFO - rmtree: /builds/slave/test/build 15:00:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:00:02 INFO - Running post-action listener: _resource_record_post_action 15:00:02 INFO - ##### 15:00:02 INFO - ##### Finished clobber step (success) 15:00:02 INFO - ##### 15:00:02 INFO - ##### 15:00:02 INFO - ##### Running read-buildbot-config step. 15:00:02 INFO - ##### 15:00:02 INFO - Running pre-action listener: _resource_record_pre_action 15:00:02 INFO - Running main action method: read_buildbot_config 15:00:02 INFO - Using buildbot properties: 15:00:02 INFO - { 15:00:02 INFO - "project": "", 15:00:02 INFO - "product": "firefox", 15:00:02 INFO - "script_repo_revision": "production", 15:00:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:00:02 INFO - "repository": "", 15:00:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 15:00:02 INFO - "buildid": "20160513141649", 15:00:02 INFO - "stage_platform": "linux64-pgo", 15:00:02 INFO - "basedir": "/builds/slave/test", 15:00:02 INFO - "buildnumber": 673, 15:00:02 INFO - "platform": "ubuntu64_hw", 15:00:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:00:02 INFO - "slavebuilddir": "test", 15:00:02 INFO - "branch": "fx-team", 15:00:02 INFO - "revision": "c4a209a8e2a8483f71182ecfa6044b830fd85362", 15:00:02 INFO - "slavename": "talos-linux64-ix-033", 15:00:02 INFO - "builduid": "232ac1c20c41463ba19a5798e727b38c", 15:00:02 INFO - "repo_path": "integration/fx-team" 15:00:02 INFO - } 15:00:02 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:00:02 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.test_packages.json. 15:00:02 INFO - Running post-action listener: _resource_record_post_action 15:00:02 INFO - ##### 15:00:02 INFO - ##### Finished read-buildbot-config step (success) 15:00:02 INFO - ##### 15:00:02 INFO - ##### 15:00:02 INFO - ##### Running download-and-extract step. 15:00:02 INFO - ##### 15:00:02 INFO - Running pre-action listener: _resource_record_pre_action 15:00:02 INFO - Running main action method: download_and_extract 15:00:02 INFO - mkdir: /builds/slave/test/build/tests 15:00: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:02 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:00:02 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:00:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:00:02 INFO - Downloaded 1361 bytes. 15:00:02 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:00:02 INFO - Using the following test package requirements: 15:00:02 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:00:02 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:00:02 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:00:02 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:02 INFO - u'jsshell-linux-x86_64.zip'], 15:00:02 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:00:02 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:00:02 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:00:02 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:00:02 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:00:02 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:00:02 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:00: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:02 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:00:02 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:00:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:00:02 INFO - Downloaded 23909523 bytes. 15:00:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:00:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:00:04 INFO - Return code: 0 15:00:04 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:04 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:00:04 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:00:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:00:04 INFO - Downloaded 23909523 bytes. 15:00:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:00:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:00:05 INFO - Return code: 0 15:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:05 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:00:05 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:00:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:00:06 INFO - Downloaded 10840239 bytes. 15:00:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:00:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:00:06 INFO - Return code: 0 15:00: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:06 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:00:06 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:00:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:00:06 INFO - Downloaded 58399498 bytes. 15:00:06 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:00:06 INFO - mkdir: /builds/slave/test/properties 15:00:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:00:06 INFO - Writing to file /builds/slave/test/properties/build_url 15:00:06 INFO - Contents: 15:00:06 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:00:07 INFO - Running post-action listener: _resource_record_post_action 15:00:07 INFO - Running post-action listener: set_extra_try_arguments 15:00:07 INFO - ##### 15:00:07 INFO - ##### Finished download-and-extract step (success) 15:00:07 INFO - ##### 15:00:07 INFO - ##### 15:00:07 INFO - ##### Running populate-webroot step. 15:00:07 INFO - ##### 15:00:07 INFO - Running pre-action listener: _resource_record_pre_action 15:00:07 INFO - Running main action method: populate_webroot 15:00:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:00:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:00:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:00:07 INFO - '--tppagecycles', 15:00:07 INFO - '7'], 15:00:07 INFO - 'tests': ['tsvgm']}}, 15:00:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:00:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:00:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:00:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:00:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:00:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:00:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:07 INFO - 'talos_options': ['--disable-e10s'], 15:00:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:00:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:00:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:07 INFO - 'talos_options': ['--disable-e10s'], 15:00:07 INFO - 'tests': ['damp', 'tps']}, 15:00:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:07 INFO - 'tests': ['damp', 'tps']}, 15:00:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:00:07 INFO - 'tests': ['dromaeo_dom']}, 15:00:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:00:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:00:07 INFO - 'tests': ['a11yr', 15:00:07 INFO - 'ts_paint', 15:00:07 INFO - 'tpaint', 15:00:07 INFO - 'sessionrestore', 15:00:07 INFO - 'sessionrestore_no_auto_restore', 15:00:07 INFO - 'tabpaint']}, 15:00:07 INFO - 'other-e10s': {'tests': ['a11yr', 15:00:07 INFO - 'ts_paint', 15:00:07 INFO - 'tpaint', 15:00:07 INFO - 'sessionrestore', 15:00:07 INFO - 'sessionrestore_no_auto_restore', 15:00:07 INFO - 'tabpaint']}, 15:00:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:00:07 INFO - 'ts_paint', 15:00:07 INFO - 'tpaint', 15:00:07 INFO - 'sessionrestore', 15:00:07 INFO - 'sessionrestore_no_auto_restore', 15:00:07 INFO - 'tabpaint']}, 15:00:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:00:07 INFO - 'ts_paint', 15:00:07 INFO - 'tpaint', 15:00:07 INFO - 'sessionrestore', 15:00:07 INFO - 'sessionrestore_no_auto_restore', 15:00:07 INFO - 'tabpaint']}, 15:00:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:00:07 INFO - 'tests': ['a11yr', 15:00:07 INFO - 'ts_paint', 15:00:07 INFO - 'tpaint', 15:00:07 INFO - 'sessionrestore', 15:00:07 INFO - 'sessionrestore_no_auto_restore', 15:00:07 INFO - 'tabpaint']}, 15:00:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:00:07 INFO - 'tests': ['a11yr', 15:00:07 INFO - 'ts_paint', 15:00:07 INFO - 'tpaint', 15:00:07 INFO - 'sessionrestore', 15:00:07 INFO - 'sessionrestore_no_auto_restore', 15:00:07 INFO - 'tabpaint']}, 15:00:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:00:07 INFO - 'tests': ['tsvgx', 15:00:07 INFO - 'tsvgr_opacity', 15:00:07 INFO - 'tart', 15:00:07 INFO - 'tscrollx', 15:00:07 INFO - 'cart']}, 15:00:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:00:07 INFO - 'tsvgr_opacity', 15:00:07 INFO - 'tart', 15:00:07 INFO - 'tscrollx', 15:00:07 INFO - 'cart']}, 15:00:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:07 INFO - 'talos_options': ['--disable-e10s'], 15:00:07 INFO - 'tests': ['tp5o']}, 15:00:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:07 INFO - 'tests': ['tp5o']}, 15:00:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:07 INFO - 'talos_options': ['--disable-e10s', 15:00:07 INFO - '--xperf_path', 15:00:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:00:07 INFO - 'tests': ['tp5n']}, 15:00:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:07 INFO - 'talos_options': ['--xperf_path', 15:00:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:00:07 INFO - 'tests': ['tp5n']}}, 15:00:07 INFO - 'talos.zip': {'path': '', 15:00:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:00:07 INFO - Running post-action listener: _resource_record_post_action 15:00:07 INFO - ##### 15:00:07 INFO - ##### Finished populate-webroot step (success) 15:00:07 INFO - ##### 15:00:07 INFO - ##### 15:00:07 INFO - ##### Running create-virtualenv step. 15:00:07 INFO - ##### 15:00:07 INFO - Running pre-action listener: _resource_record_pre_action 15:00:07 INFO - Running main action method: create_virtualenv 15:00:07 INFO - Creating virtualenv /builds/slave/test/build/venv 15:00:07 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 15:00:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:00:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:00:07 INFO - Using real prefix '/usr' 15:00:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:00:07 INFO - Installing distribute.............................................................................................................................................................................................done. 15:00:09 INFO - Installing pip.................done. 15:00:09 INFO - Return code: 0 15:00:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff721948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a09c0>, '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 0x27a18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', '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 15:00:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:00:09 INFO - Using env: {'DISPLAY': ':0', 15:00:09 INFO - 'HOME': '/home/cltbld', 15:00:09 INFO - 'LANG': 'en_US.UTF-8', 15:00:09 INFO - 'LANGUAGE': 'en_US:en', 15:00:09 INFO - 'LOGNAME': 'cltbld', 15:00:09 INFO - 'MAIL': '/var/mail/cltbld', 15:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:09 INFO - 'MOZ_NO_REMOTE': '1', 15:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:09 INFO - 'NO_EM_RESTART': '1', 15:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:09 INFO - 'PWD': '/builds/slave/test', 15:00:09 INFO - 'SHELL': '/bin/bash', 15:00:09 INFO - 'SHLVL': '1', 15:00:09 INFO - 'TERM': 'linux', 15:00:09 INFO - 'TMOUT': '86400', 15:00:09 INFO - 'USER': 'cltbld', 15:00:09 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', 15:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:09 INFO - '_': '/tools/buildbot/bin/python'} 15:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:10 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 15:00:10 INFO - Cleaning up... 15:00:10 INFO - Return code: 0 15:00:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:00:10 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:10 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:10 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 0x7ff721948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a09c0>, '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 0x27a18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', '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 15:00:10 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 15:00:10 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 15:00:10 INFO - Using env: {'DISPLAY': ':0', 15:00:10 INFO - 'HOME': '/home/cltbld', 15:00:10 INFO - 'LANG': 'en_US.UTF-8', 15:00:10 INFO - 'LANGUAGE': 'en_US:en', 15:00:10 INFO - 'LOGNAME': 'cltbld', 15:00:10 INFO - 'MAIL': '/var/mail/cltbld', 15:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:10 INFO - 'MOZ_NO_REMOTE': '1', 15:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:10 INFO - 'NO_EM_RESTART': '1', 15:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:10 INFO - 'PWD': '/builds/slave/test', 15:00:10 INFO - 'SHELL': '/bin/bash', 15:00:10 INFO - 'SHLVL': '1', 15:00:10 INFO - 'TERM': 'linux', 15:00:10 INFO - 'TMOUT': '86400', 15:00:10 INFO - 'USER': 'cltbld', 15:00:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', 15:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:10 INFO - '_': '/tools/buildbot/bin/python'} 15:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:10 INFO - Downloading/unpacking psutil>=3.1.1 15:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:00:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:00:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:00:12 INFO - Installing collected packages: psutil 15:00:12 INFO - Running setup.py install for psutil 15:00:12 INFO - building 'psutil._psutil_linux' extension 15:00:12 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 15:00:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:00:12 INFO - building 'psutil._psutil_posix' extension 15:00:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:00:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:00:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:00:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:00:12 INFO - Successfully installed psutil 15:00:12 INFO - Cleaning up... 15:00:12 INFO - Return code: 0 15:00:12 INFO - Installing mozsystemmonitor==0.1 into virtualenv /builds/slave/test/build/venv 15:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff721948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a09c0>, '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 0x27a18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', '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 15:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.1'] in /builds/slave/test/build 15:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.1 15:00:12 INFO - Using env: {'DISPLAY': ':0', 15:00:12 INFO - 'HOME': '/home/cltbld', 15:00:12 INFO - 'LANG': 'en_US.UTF-8', 15:00:12 INFO - 'LANGUAGE': 'en_US:en', 15:00:12 INFO - 'LOGNAME': 'cltbld', 15:00:12 INFO - 'MAIL': '/var/mail/cltbld', 15:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:12 INFO - 'MOZ_NO_REMOTE': '1', 15:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:12 INFO - 'NO_EM_RESTART': '1', 15:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:12 INFO - 'PWD': '/builds/slave/test', 15:00:12 INFO - 'SHELL': '/bin/bash', 15:00:12 INFO - 'SHLVL': '1', 15:00:12 INFO - 'TERM': 'linux', 15:00:12 INFO - 'TMOUT': '86400', 15:00:12 INFO - 'USER': 'cltbld', 15:00:12 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', 15:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:12 INFO - '_': '/tools/buildbot/bin/python'} 15:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:13 INFO - Downloading/unpacking mozsystemmonitor==0.1 15:00:13 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 15:00:13 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 15:00:13 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 15:00:13 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 15:00:13 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 15:00:13 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 15:00:14 INFO - Downloading mozsystemmonitor-0.1.tar.gz 15:00:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.1) 15:00:15 INFO - Installing collected packages: mozsystemmonitor 15:00:15 INFO - Running setup.py install for mozsystemmonitor 15:00:15 INFO - Successfully installed mozsystemmonitor 15:00:15 INFO - Cleaning up... 15:00:16 INFO - Return code: 0 15:00:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:00:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:16 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 0x7ff721948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a09c0>, '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 0x27a18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', '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 15:00:16 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 15:00:16 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 15:00:16 INFO - Using env: {'DISPLAY': ':0', 15:00:16 INFO - 'HOME': '/home/cltbld', 15:00:16 INFO - 'LANG': 'en_US.UTF-8', 15:00:16 INFO - 'LANGUAGE': 'en_US:en', 15:00:16 INFO - 'LOGNAME': 'cltbld', 15:00:16 INFO - 'MAIL': '/var/mail/cltbld', 15:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:16 INFO - 'MOZ_NO_REMOTE': '1', 15:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:16 INFO - 'NO_EM_RESTART': '1', 15:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:16 INFO - 'PWD': '/builds/slave/test', 15:00:16 INFO - 'SHELL': '/bin/bash', 15:00:16 INFO - 'SHLVL': '1', 15:00:16 INFO - 'TERM': 'linux', 15:00:16 INFO - 'TMOUT': '86400', 15:00:16 INFO - 'USER': 'cltbld', 15:00:16 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', 15:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:16 INFO - '_': '/tools/buildbot/bin/python'} 15:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:16 INFO - Downloading/unpacking blobuploader==1.2.4 15:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:18 INFO - Downloading blobuploader-1.2.4.tar.gz 15:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:00:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:00:18 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 15:00:18 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 15:00:18 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 15:00:18 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 15:00:18 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 15:00:18 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 15:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:00:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:19 INFO - Downloading docopt-0.6.1.tar.gz 15:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:00:19 INFO - Installing collected packages: blobuploader, requests, docopt 15:00:19 INFO - Running setup.py install for blobuploader 15:00:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:00:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:00:19 INFO - Running setup.py install for requests 15:00:20 INFO - Running setup.py install for docopt 15:00:20 INFO - Successfully installed blobuploader requests docopt 15:00:20 INFO - Cleaning up... 15:00:20 INFO - Return code: 0 15:00:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff721948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a09c0>, '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 0x27a18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', '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 15:00:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:00:20 INFO - Using env: {'DISPLAY': ':0', 15:00:20 INFO - 'HOME': '/home/cltbld', 15:00:20 INFO - 'LANG': 'en_US.UTF-8', 15:00:20 INFO - 'LANGUAGE': 'en_US:en', 15:00:20 INFO - 'LOGNAME': 'cltbld', 15:00:20 INFO - 'MAIL': '/var/mail/cltbld', 15:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:20 INFO - 'MOZ_NO_REMOTE': '1', 15:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:20 INFO - 'NO_EM_RESTART': '1', 15:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:20 INFO - 'PWD': '/builds/slave/test', 15:00:20 INFO - 'SHELL': '/bin/bash', 15:00:20 INFO - 'SHLVL': '1', 15:00:20 INFO - 'TERM': 'linux', 15:00:20 INFO - 'TMOUT': '86400', 15:00:20 INFO - 'USER': 'cltbld', 15:00:20 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', 15:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:20 INFO - '_': '/tools/buildbot/bin/python'} 15:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:00:20 INFO - Running setup.py (path:/tmp/pip-sPYog5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:00:20 INFO - Running setup.py (path:/tmp/pip-lPPkeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:00:20 INFO - Running setup.py (path:/tmp/pip-QL0BC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:00:20 INFO - Running setup.py (path:/tmp/pip-7oyGUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:00:20 INFO - Running setup.py (path:/tmp/pip-OcZKq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:00:20 INFO - Running setup.py (path:/tmp/pip-HkycTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:00:20 INFO - Running setup.py (path:/tmp/pip-qOhjYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:00:20 INFO - Running setup.py (path:/tmp/pip-UvnO0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:00:20 INFO - Running setup.py (path:/tmp/pip-OWYmI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:00:21 INFO - Running setup.py (path:/tmp/pip-V0YFMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:00:21 INFO - Running setup.py (path:/tmp/pip-EXVtoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:00:21 INFO - Running setup.py (path:/tmp/pip-FwQPFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:00:21 INFO - Running setup.py (path:/tmp/pip-NbrKHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:00:21 INFO - Running setup.py (path:/tmp/pip-TTzOvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:00:21 INFO - Running setup.py (path:/tmp/pip-JF7aU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:00:21 INFO - Running setup.py (path:/tmp/pip-4B3V_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:00:21 INFO - Running setup.py (path:/tmp/pip-JXnS57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:00:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:00:21 INFO - Running setup.py install for manifestparser 15:00:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:00:21 INFO - Running setup.py install for mozcrash 15:00:21 INFO - Running setup.py install for mozdebug 15:00:21 INFO - Running setup.py install for mozdevice 15:00:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:00:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:00:22 INFO - Running setup.py install for mozfile 15:00:22 INFO - Running setup.py install for mozhttpd 15:00:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:00:22 INFO - Running setup.py install for mozinfo 15:00:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:00:22 INFO - Running setup.py install for mozInstall 15:00:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:00:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:00:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:00:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:00:22 INFO - Running setup.py install for mozleak 15:00:22 INFO - Running setup.py install for mozlog 15:00:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:00:22 INFO - Running setup.py install for moznetwork 15:00:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:00:22 INFO - Running setup.py install for mozprocess 15:00:22 INFO - Running setup.py install for mozprofile 15:00:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:00:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:00:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:00:22 INFO - Running setup.py install for mozrunner 15:00:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:00:23 INFO - Running setup.py install for mozscreenshot 15:00:23 INFO - Running setup.py install for moztest 15:00:23 INFO - Running setup.py install for mozversion 15:00:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:00:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:00:23 INFO - Cleaning up... 15:00:23 INFO - Return code: 0 15:00:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:00: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:23 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 0x7ff721948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a09c0>, '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 0x27a18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', '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 15:00:23 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 15:00:23 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 15:00:23 INFO - Using env: {'DISPLAY': ':0', 15:00:23 INFO - 'HOME': '/home/cltbld', 15:00:23 INFO - 'LANG': 'en_US.UTF-8', 15:00:23 INFO - 'LANGUAGE': 'en_US:en', 15:00:23 INFO - 'LOGNAME': 'cltbld', 15:00:23 INFO - 'MAIL': '/var/mail/cltbld', 15:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:23 INFO - 'MOZ_NO_REMOTE': '1', 15:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:23 INFO - 'NO_EM_RESTART': '1', 15:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:23 INFO - 'PWD': '/builds/slave/test', 15:00:23 INFO - 'SHELL': '/bin/bash', 15:00:23 INFO - 'SHLVL': '1', 15:00:23 INFO - 'TERM': 'linux', 15:00:23 INFO - 'TMOUT': '86400', 15:00:23 INFO - 'USER': 'cltbld', 15:00:23 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', 15:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:23 INFO - '_': '/tools/buildbot/bin/python'} 15:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:00:23 INFO - Running setup.py (path:/tmp/pip-plEbRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:00:23 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)) 15:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:00:23 INFO - Running setup.py (path:/tmp/pip-dbo9up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:00:23 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)) 15:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:00:23 INFO - Running setup.py (path:/tmp/pip-KyKpkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:00:23 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)) 15:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:00:23 INFO - Running setup.py (path:/tmp/pip-iLNWZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:00:23 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)) 15:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:00:23 INFO - Running setup.py (path:/tmp/pip-pXkthN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:00:24 INFO - Running setup.py (path:/tmp/pip-H80alc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:00:24 INFO - Running setup.py (path:/tmp/pip-teUJF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:00:24 INFO - Running setup.py (path:/tmp/pip-NXZRIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:00:24 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)) 15:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:00:24 INFO - Running setup.py (path:/tmp/pip-aAwh7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:00:24 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)) 15:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:00:24 INFO - Running setup.py (path:/tmp/pip-WUU0wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 15:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:00:24 INFO - Running setup.py (path:/tmp/pip-leq6Je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:00:24 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)) 15:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:00:24 INFO - Running setup.py (path:/tmp/pip-_c9fgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 15:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:00:24 INFO - Running setup.py (path:/tmp/pip-mAogEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:00:24 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)) 15:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:00:24 INFO - Running setup.py (path:/tmp/pip-2nFb7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 15:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:00:24 INFO - Running setup.py (path:/tmp/pip-vkL6d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:00:24 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)) 15:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:00:24 INFO - Running setup.py (path:/tmp/pip-0nNbn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:00:24 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)) 15:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:00:24 INFO - Running setup.py (path:/tmp/pip-xTiFGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:00:24 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)) 15:00:24 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)) 15:00:24 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)) 15:00:24 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)) 15:00:24 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)) 15:00:24 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)) 15:00:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:00:24 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 15:00:24 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 15:00:24 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 15:00:24 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 15:00:24 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 15:00:24 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 15:00:26 INFO - Downloading blessings-1.6.tar.gz 15:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:00:26 INFO - Installing collected packages: blessings 15:00:26 INFO - Running setup.py install for blessings 15:00:26 INFO - Successfully installed blessings 15:00:26 INFO - Cleaning up... 15:00:27 INFO - Return code: 0 15:00:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:00:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:00:27 INFO - Reading from file tmpfile_stdout 15:00:27 INFO - Current package versions: 15:00:27 INFO - argparse == 1.2.1 15:00:27 INFO - blessings == 1.6 15:00:27 INFO - blobuploader == 1.2.4 15:00:27 INFO - docopt == 0.6.1 15:00:27 INFO - manifestparser == 1.1 15:00:27 INFO - mozInstall == 1.12 15:00:27 INFO - mozcrash == 0.17 15:00:27 INFO - mozdebug == 0.1 15:00:27 INFO - mozdevice == 0.48 15:00:27 INFO - mozfile == 1.2 15:00:27 INFO - mozhttpd == 0.7 15:00:27 INFO - mozinfo == 0.9 15:00:27 INFO - mozleak == 0.1 15:00:27 INFO - mozlog == 3.2 15:00:27 INFO - moznetwork == 0.27 15:00:27 INFO - mozprocess == 0.22 15:00:27 INFO - mozprofile == 0.28 15:00:27 INFO - mozrunner == 6.11 15:00:27 INFO - mozscreenshot == 0.1 15:00:27 INFO - mozsystemmonitor == 0.1 15:00:27 INFO - moztest == 0.7 15:00:27 INFO - mozversion == 1.4 15:00:27 INFO - psutil == 3.1.1 15:00:27 INFO - requests == 1.2.3 15:00:27 INFO - wsgiref == 0.1.2 15:00:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:27 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 0x7ff721948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a09c0>, '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 0x27a18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', '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 15:00:27 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 15:00:27 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 15:00:27 INFO - Using env: {'DISPLAY': ':0', 15:00:27 INFO - 'HOME': '/home/cltbld', 15:00:27 INFO - 'LANG': 'en_US.UTF-8', 15:00:27 INFO - 'LANGUAGE': 'en_US:en', 15:00:27 INFO - 'LOGNAME': 'cltbld', 15:00:27 INFO - 'MAIL': '/var/mail/cltbld', 15:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:27 INFO - 'MOZ_NO_REMOTE': '1', 15:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:27 INFO - 'NO_EM_RESTART': '1', 15:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:27 INFO - 'PWD': '/builds/slave/test', 15:00:27 INFO - 'SHELL': '/bin/bash', 15:00:27 INFO - 'SHLVL': '1', 15:00:27 INFO - 'TERM': 'linux', 15:00:27 INFO - 'TMOUT': '86400', 15:00:27 INFO - 'USER': 'cltbld', 15:00:27 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', 15:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:27 INFO - '_': '/tools/buildbot/bin/python'} 15:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:27 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)) 15:00:27 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)) 15:00:27 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)) 15:00:27 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)) 15:00:27 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)) 15:00:27 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)) 15:00:27 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)) 15:00:27 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)) 15:00:27 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)) 15:00:27 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)) 15:00:27 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)) 15:00:27 INFO - Cleaning up... 15:00:27 INFO - Return code: 0 15:00:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:27 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 0x7ff721948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a09c0>, '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 0x27a18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', '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 15:00:27 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 15:00:27 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 15:00:27 INFO - Using env: {'DISPLAY': ':0', 15:00:27 INFO - 'HOME': '/home/cltbld', 15:00:27 INFO - 'LANG': 'en_US.UTF-8', 15:00:27 INFO - 'LANGUAGE': 'en_US:en', 15:00:27 INFO - 'LOGNAME': 'cltbld', 15:00:27 INFO - 'MAIL': '/var/mail/cltbld', 15:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:27 INFO - 'MOZ_NO_REMOTE': '1', 15:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:27 INFO - 'NO_EM_RESTART': '1', 15:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:27 INFO - 'PWD': '/builds/slave/test', 15:00:27 INFO - 'SHELL': '/bin/bash', 15:00:27 INFO - 'SHLVL': '1', 15:00:27 INFO - 'TERM': 'linux', 15:00:27 INFO - 'TMOUT': '86400', 15:00:27 INFO - 'USER': 'cltbld', 15:00:27 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', 15:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:27 INFO - '_': '/tools/buildbot/bin/python'} 15:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:27 INFO - Downloading/unpacking jsonschema 15:00:27 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 15:00:27 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 15:00:27 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 15:00:27 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 15:00:27 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 15:00:27 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 15:00:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:00:29 INFO - Downloading/unpacking functools32 (from jsonschema) 15:00:29 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 15:00:29 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 15:00:29 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 15:00:29 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 15:00:29 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 15:00:29 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 15:00:29 INFO - Downloading functools32-3.2.3-2.tar.gz 15:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:00:29 INFO - warning: no files found matching '*.txt' 15:00:29 INFO - no previously-included directories found matching 'build' 15:00:29 INFO - no previously-included directories found matching 'dist' 15:00:29 INFO - no previously-included directories found matching '.git*' 15:00:29 INFO - Installing collected packages: jsonschema, functools32 15:00:29 INFO - Running setup.py install for functools32 15:00:29 INFO - warning: no files found matching '*.txt' 15:00:29 INFO - no previously-included directories found matching 'build' 15:00:29 INFO - no previously-included directories found matching 'dist' 15:00:29 INFO - no previously-included directories found matching '.git*' 15:00:29 INFO - Successfully installed jsonschema functools32 15:00:29 INFO - Cleaning up... 15:00:30 INFO - Return code: 0 15:00:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:00:30 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:30 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:30 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff721948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a09c0>, '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 0x27a18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', '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 15:00:30 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', 'flake8'] in /builds/slave/test/build 15:00:30 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 flake8 15:00:30 INFO - Using env: {'DISPLAY': ':0', 15:00:30 INFO - 'HOME': '/home/cltbld', 15:00:30 INFO - 'LANG': 'en_US.UTF-8', 15:00:30 INFO - 'LANGUAGE': 'en_US:en', 15:00:30 INFO - 'LOGNAME': 'cltbld', 15:00:30 INFO - 'MAIL': '/var/mail/cltbld', 15:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:30 INFO - 'MOZ_NO_REMOTE': '1', 15:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:30 INFO - 'NO_EM_RESTART': '1', 15:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:30 INFO - 'PWD': '/builds/slave/test', 15:00:30 INFO - 'SHELL': '/bin/bash', 15:00:30 INFO - 'SHLVL': '1', 15:00:30 INFO - 'TERM': 'linux', 15:00:30 INFO - 'TMOUT': '86400', 15:00:30 INFO - 'USER': 'cltbld', 15:00:30 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', 15:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:30 INFO - '_': '/tools/buildbot/bin/python'} 15:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:30 INFO - Downloading/unpacking flake8 15:00:30 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 15:00:30 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 15:00:30 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 15:00:30 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 15:00:30 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 15:00:30 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 15:00:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:00:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:00:32 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 15:00:32 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 15:00:32 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 15:00:32 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 15:00:32 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 15:00:32 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 15:00:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:00:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:00:32 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 15:00:32 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 15:00:32 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 15:00:32 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 15:00:32 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 15:00:32 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 15:00:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:00:32 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 15:00:32 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 15:00:32 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 15:00:32 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 15:00:32 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 15:00:32 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 15:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:00:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:00:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:00:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:00:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:00:32 INFO - no previously-included directories found matching 'docs/_build' 15:00:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:00:32 INFO - Running setup.py install for pep8 15:00:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:00:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:00:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:00:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:00:32 INFO - no previously-included directories found matching 'docs/_build' 15:00:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:00:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:00:33 INFO - Cleaning up... 15:00:33 INFO - Return code: 0 15:00:33 INFO - Running post-action listener: _resource_record_post_action 15:00:33 INFO - Running post-action listener: _start_resource_monitoring 15:00:33 INFO - Starting resource monitoring. 15:00:33 INFO - ##### 15:00:33 INFO - ##### Finished create-virtualenv step (success) 15:00:33 INFO - ##### 15:00:33 INFO - ##### 15:00:33 INFO - ##### Running install step. 15:00:33 INFO - ##### 15:00:33 INFO - Running pre-action listener: _resource_record_pre_action 15:00:33 INFO - Running main action method: install 15:00:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:00:33 INFO - Reading from file tmpfile_stdout 15:00:33 INFO - Detecting whether we're running mozinstall >=1.0... 15:00:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:00:33 INFO - Reading from file tmpfile_stdout 15:00:33 INFO - Output received: 15:00:33 INFO - Usage: mozinstall [options] installer 15:00:33 INFO - Options: 15:00:33 INFO - -h, --help show this help message and exit 15:00:33 INFO - -d DEST, --destination=DEST 15:00:33 INFO - Directory to install application into. [default: 15:00:33 INFO - "/builds/slave/test"] 15:00:33 INFO - --app=APP Application being installed. [default: firefox] 15:00:33 INFO - mkdir: /builds/slave/test/build/application 15:00:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:00:49 INFO - Reading from file tmpfile_stdout 15:00:49 INFO - Output received: 15:00:49 INFO - /builds/slave/test/build/application/firefox/firefox 15:00:49 INFO - Running post-action listener: _resource_record_post_action 15:00:49 INFO - ##### 15:00:49 INFO - ##### Finished install step (success) 15:00:49 INFO - ##### 15:00:49 INFO - ##### 15:00:49 INFO - ##### Running run-tests step. 15:00:49 INFO - ##### 15:00:49 INFO - Running pre-action listener: _resource_record_pre_action 15:00:49 INFO - Running main action method: run_tests 15:00:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:00:49 INFO - Python 2.7.3 15:00:49 INFO - Return code: 0 15:00:49 INFO - grabbing minidump binary from tooltool 15:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:49 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 0x27a09c0>, '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 0x27a18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:00:49 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 15:00:49 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 15:00:49 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 15:00:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:00:50 INFO - Return code: 0 15:00:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:00:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:00:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:00:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:00:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:00:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:00:50 INFO - Return code: 0 15:00:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 15:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 15:00:50 INFO - Using env: {'DISPLAY': ':0', 15:00:50 INFO - 'HOME': '/home/cltbld', 15:00:50 INFO - 'LANG': 'en_US.UTF-8', 15:00:50 INFO - 'LANGUAGE': 'en_US:en', 15:00:50 INFO - 'LOGNAME': 'cltbld', 15:00:50 INFO - 'MAIL': '/var/mail/cltbld', 15:00:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:00:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:50 INFO - 'MOZ_NO_REMOTE': '1', 15:00:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:50 INFO - 'NO_EM_RESTART': '1', 15:00:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:50 INFO - 'PWD': '/builds/slave/test', 15:00:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:00:50 INFO - 'SHELL': '/bin/bash', 15:00:50 INFO - 'SHLVL': '1', 15:00:50 INFO - 'TERM': 'linux', 15:00:50 INFO - 'TMOUT': '86400', 15:00:50 INFO - 'USER': 'cltbld', 15:00:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475', 15:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:50 INFO - '_': '/tools/buildbot/bin/python'} 15:00:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 15:00:51 INFO - mozversion application_buildid: 20160513113013 15:00:51 INFO - mozversion application_changeset: c4a209a8e2a8483f71182ecfa6044b830fd85362 15:00:51 INFO - mozversion application_display_name: Nightly 15:00:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:00:51 INFO - mozversion application_name: Firefox 15:00:51 INFO - mozversion application_remotingname: firefox 15:00:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:00:51 INFO - mozversion application_vendor: Mozilla 15:00:51 INFO - mozversion application_version: 49.0a1 15:00:51 INFO - mozversion platform_buildid: 20160513113013 15:00:51 INFO - mozversion platform_changeset: c4a209a8e2a8483f71182ecfa6044b830fd85362 15:00:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:00:51 INFO - mozversion platform_version: 49.0a1 15:00:51 INFO - using testdate: 1463176851 15:00:51 INFO - actual date: 1463176851 15:00:51 INFO - starting webserver on 'localhost:50828' 15:00:51 INFO - SUITE-START | Running 2 tests 15:00:51 INFO - TEST-START | dromaeo_css 15:00:51 INFO - operating with platform_type : linux_ 15:00:51 INFO - Initialising browser for dromaeo_css test... 15:00:51 INFO - TEST-INFO | started process 4419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8LwCsp/profile http://localhost:50828/getInfo.html) 15:00:56 INFO - PROCESS | 4419 | __metrics Screen width/height:1600/1200 15:00:56 INFO - PROCESS | 4419 | colorDepth:24 15:00:56 INFO - PROCESS | 4419 | Browser inner width/height: 1024/697 15:00:56 INFO - PROCESS | 4419 | __metrics 15:00:57 ERROR - PROCESS | 4419 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:00:58 INFO - TEST-INFO | 4419: exit 0 15:00:58 INFO - Browser initialized. 15:00:58 INFO - Running cycle 1/1 for dromaeo_css test... 15:00:58 INFO - TEST-INFO | started process 4501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8LwCsp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:01:10 INFO - PROCESS | 4501 | RSS: Main: 152956928 15:01:10 INFO - PROCESS | 4501 | 15:02:01 INFO - PROCESS | 4501 | 1463176921253 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] 15:04:09 INFO - PROCESS | 4501 | Cycle 1(1): loaded http://localhost:50828/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50828/tests/dromaeo/cssquery-ext.html) 15:04:10 INFO - PROCESS | 4501 | RSS: Main: 251760640 15:04:10 INFO - PROCESS | 4501 | 15:07:12 INFO - PROCESS | 4501 | Cycle 1(1): loaded http://localhost:50828/tests/dromaeo/cssquery-ext.html (next: http://localhost:50828/tests/dromaeo/cssquery-jquery.html) 15:07:13 INFO - PROCESS | 4501 | RSS: Main: 241926144 15:07:13 INFO - PROCESS | 4501 | 15:10:15 INFO - PROCESS | 4501 | Cycle 1(1): loaded http://localhost:50828/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50828/tests/dromaeo/cssquery-mootools.html) 15:10:15 INFO - PROCESS | 4501 | RSS: Main: 243273728 15:10:15 INFO - PROCESS | 4501 | 15:13:17 INFO - PROCESS | 4501 | Cycle 1(1): loaded http://localhost:50828/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50828/tests/dromaeo/cssquery-prototype.html) 15:13:18 INFO - PROCESS | 4501 | RSS: Main: 244371456 15:13:18 INFO - PROCESS | 4501 | 15:16:21 INFO - PROCESS | 4501 | Cycle 1(1): loaded http://localhost:50828/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50828/tests/dromaeo/cssquery-yui.html) 15:16:21 INFO - PROCESS | 4501 | RSS: Main: 230002688 15:16:21 INFO - PROCESS | 4501 | 15:19:24 INFO - PROCESS | 4501 | Cycle 1(1): loaded http://localhost:50828/tests/dromaeo/cssquery-yui.html (next: http://localhost:50828/tests/dromaeo/cssquery-dojo.html) 15:19:24 INFO - PROCESS | 4501 | RSS: Main: 346013696 15:19:24 INFO - PROCESS | 4501 | 15:19:24 INFO - PROCESS | 4501 | __start_tp_report 15:19:24 INFO - PROCESS | 4501 | _x_x_mozilla_page_load 15:19:24 INFO - PROCESS | 4501 | _x_x_mozilla_page_load_details 15:19:24 INFO - PROCESS | 4501 | |i|pagename|runs| 15:19:24 INFO - PROCESS | 4501 | |0;dojo.html;3161.7470602351814;3182.4112539180255;3199.4241036613407;3209.8555564999574;3246.853891574879;5375.6774593524415;5404.621676482648;5417.7291135443165;5466.863328416786;5518.310211223597;5356.062689029414;5396.5952553558445;5438.891222175564;5451.809186678467;5470.972645136779;4890.217565189561;4978.327925730035;5000.299958005882;5005.199168133099;5067.442581316071;5009.57418619416;5025.1708468102715;5051.595872330205;5074.84775456735;5082.0598189334905;4868.0750657375165;4935.703857768527;4977.104121258172;4977.552020318152;4978.377702787152;4979.626528010377;4990.575801056914;4996.925046124311;5011.298418221452;5037.11850426174;4801.255805350176;4949.307097006422;4967.751612419401;4972.428170760372;5000.149974504343;5247.370315562119;5272.604554658416;5302.09864323066;5303.761330740126;5375.354957405098;5781.161731548944;5787.50806181475;5790.71046447676;5840.912386314209;5845.795397161079;5708.400617935098;5790.276215473066;5798.710064496759;5802.158686990405;5849.736761845727;5419.918701219485;5566.109422492423;5566.666000040011;5572.219889215473;5585.664860108406;6028.386380091869;6064.423879731418;6078.179445774852;6081.6351018939;6082.482988945989;5643.322801263875;5670.262865827499;5712.200291959129;5844.620099693507;5854.736536855852;5828.0966450200285;5844.736986835603;5847.181394604759;5848.356680765112;5891.322497912709;5777.62445441045;5821.18503409523;5826.6795326256615;5833.88332233353;5838.2702162229725;5709.65742055478;5793.2179155814265;5804.042333015005;5834.562407819346;5875.059990401601;4464.397306363664;4464.464264288306;4465.017696106851;4467.709598876063;4499.640028797754;3981.442598036277;3999.280129576704;4009;4039.151778126626;4047.6964227683043;5441;5449.7275136243825;5494.80768173112;5499.477549632778;5501.092319767274;5837.562182836305;5857.15071314657;5868.589198756046;5874.941250587525;5876.853078673067;5532.640378375393;5541.778328866881;5542.196381524656;5544.7227638618715;5547.5007249347755;4843.951560484421;5016.44819069902;5049.040682270357;5090.898182036412;5095.694258344512;6061.666608336495;6069.3627169147485;6071.241094863142;6071.757129714851;6075.848103797441;5874.236349274653;5881.206037184926;5885.705714714333;5885.852853678521;5885.882282354414;5795.536357091507;6073.119397687399;6097.433938678448;6136.29432615255;6187.195664563758;5816.941830581809;5828.271466066742;5855.912161317498;5857.560682948711;5895.29256489224;5657.32112146545;5951.226340575698;5955.434233747787;5958.553108516965;5959.28488581373;5648.096304591246;5679.460451257124;5700.629459085146;5730.341010783646;5734.426557344233;5655.660660360391;5716.085426331767;5719.027765279996;5726.770929162787;5728.2266893970445;5474.616776825584;5525.281713377235;5626.2967129108865;5629.127485239795;5638.407967163553;5679.971600141973;5781.306243250837;5795.420457954171;5815.621984570989;5816;5600.0479918414785;5608.07466767995;5632.464915832989;5637.661740295595;5643.746031428514 15:19:24 INFO - PROCESS | 4501 | |1;ext.html;629.4586655476289;633.8035209085184;641.8812519683862;645.7546132469662;656.9375909288616;31135;33870.153246168826;43044.13911721767;44068.33897491532;44163.77918110405;45313;45669;45743.542564574345;45777.77111114448;45783.54216457834;8807.471551706902;8959.641614335418;8971.282297416192;8972.371933964625;8975.730728078168;8827.735167944971;8906.86639700405;8916.8408106946;8920;8922.10778922109;8931.55342232889;8976.910230897673;8981.730548083535;8981.865272020925;8984.8652270216;8915.063918288552;8959.37284390093;8960.417572857743;8964.551772411385;8968.955155224183;8870.73387798367;8947.50788706621;8952.8657070144;8957.462552246887;8960.641574337018;43132.78433607843;43400.565994340286;43440.56559434428;43470.56529434697;43482.565174348485;3648.890533284006;3876.089119057019;4107.466029416157;4136.627703506699;4469.7541635210055;32564.348713025844;33013.83493082519;33244.50133248003;33670;33703;4167.354060120686;4204.558521355275;4223.66210703143;4239.745615263094;4276.102018576103;347010;347175;347681;347738.9999999975;351098;53750;58192.12711809326;62390;62586.0612090819;62624;60222.09666855001;66301;66301;66359;66405.66797165983;17480;17560.29758809633;17713.29146834138;17746.935183889007;17749.645007099785;12195.329256890778;12963.287019214034;13256.668583285495;13658.180509169482;13773.724525509635;18094;18208.180631871597;18280;18444.35444759454;18503.629927401376;6201.844953876099;6263.217097862767;6269.310375858652;6302.369763023661;6393.2328120625825;1038.3354653022072;1098.1983152298708;1167.486306025346;1184.6505280942142;1209.8245754365569;33229;33500.83249583785;33834.154146146546;34101.147471313416;34656.306873862886;1167.2237961755338;1169.3393232823428;1192.6243233381458;1217.8843009914044;1331.4807225182187;17176;17845.821541784677;17921.193546290448;17927.37254196097;18014.099295035197;538072;541556;541934;543609;543639;60405.46958978094;60942;60992.39007609867;61082.38917610856;61121.69439152776;1305.9934700326437;1413.6607214268502;1425.3870835540818;1432.9713405731827;1447.8407375188722;30563;34510.654893450745;34739;34843.82578087093;34881.65118348784;50725;51052.489475104776;51340.486595135066;51363.48636513737;51369.229461558854;330190;332451;333289;335748;335885;36802;41832.3725144117;41852.581474184866;42017.78991105147;43603.34594981141;49133;49199.508004919495;50467.242991355895;50496.747516262185;50828;38558.80720596379;41706.37440438335;42026.78986605047;42115.57884421239;42256.57743422526;41925;42348;42470.150596988504;42551.574484254765;42625.14749704926;41589.37615935703;42276.36585451282;42485;43043.35434968415;43133.784331078146;36023.63976360203;36903;37591;37775.81112094422;37827.24345513019;28704;28727.281817954718;28884;29184.27039324034;29268.56097158502 15:19:24 INFO - PROCESS | 4501 | |2;jquery.html;404.25213355292715;406.40664629640725;412.59771722570497;414.2543421840687;420.08002474580667;13232.603021909357;18054.638907221848;18574.81425185751;19513.121909514088;19514.21943122275;14647.780283295733;16892.493225203234;18075.63848723028;18504.814951850476;18897;5533.972330138354;5651.463111004448;5665;5676.687782171979;5718.714064296769;5604.943950560503;5617.269754931853;5642.689652069134;5646.2942132233475;5667.971660141693;4044.757314561121;4207.326827707568;4208.13733184698;5763.769449222047;6111.816645500642;5400.891982160335;6201.162843016203;6203.31763506014;6204.87590248197;6220.720067596969;5460.153676180198;5506.834794956158;5575.107982722786;5582.497575218209;5590.357108932484;13108.14797038199;13267.535636252782;21886.452838679;22534;22555;2423;2455.1161581830706;2478.987605061963;2817.394260234039;3019.1697283247063;10245.077942985092;10669.786604267949;12954.287514186715;13893.79159312611;14390.28048597566;1780.2078075256516;1898.4968983219458;2003.5492014296813;2033.1867253098878;2058.608864315775;78703.21296787016;79636;80090.59954700248;80750.59624701897;81437.18562814355;10841.83737243942;10886.183536234814;11093;11141.94429027866;12025.098117641212;15190.088594684354;15262.31319590621;15381.461648842236;15414.768778468331;15424.61438464025;7884.763457096296;8057.59712014397;8145.95927020373;8151.266386025286;8217.753467395987;7709.575973321521;7747.147813740484;7787.29914307715;7863.52818830872;7879.84240315202;4644.7213167210075;4730.526947305242;4751.762411879392;4772.570468657768;4833.3958255218095;1782.2069179215384;1831.84429323509;1909.255390397746;1914.874489316857;1981.1753444872031;1003.267614641316;1015.3349556040805;1077.3105212663902;1133.3879704959395;1175.5767923547517;17994.190261438267;18384.17271222798;18509.7223541647;18569.44291671252;18618.16218270181;1053.6786280184465;1065.706930594093;1083.073971754139;1118.9664310070712;1148.9310641361544;9768.658096966572;10553.419561924014;10583.153347732163;10638.361698297973;10647.094996925192;423026;423182;442626;462804;465120;56628;67810.66094669593;84949.57525212334;90446.64330035055;92267;1052.4842827014709;1073.2058276875212;1076.7631121153333;1095.4905968724581;1099.7140743406771;16228.837711623204;16313.755293670842;16394.672106558042;16532;16541.917290413472;33640.327193456484;37264;37642.83512177662;40791.388129177496;41231;51835.74082129565;54818;54832.451675482735;55008.89982200414;55111;8102.83794324122;8295.626696798538;8500.489970601784;8639.524826134622;8767.912320876709;7409.518381305198;11811.468483918072;11824.82262766042;12246.510139594317;12365.938170309091;10787.568497260021;10917.344959302467;10936.56253749841;10964.506597203304;11151.944240278746;10467;10513.526891289757;10694.893051069701;11026.173037022416;11149.386783726974;5984.461398474158;8317.584120794058;10996.560137594726;11022.50398732075;11076.833847492455;7893.17121702236;8165.79585510367;8269.627866746132;8365.121662225378;8404.075551689431;8191.385646076449;10714.14286857034;10851.945740271249;10859.782804344028;10886.074683651661 15:19:24 INFO - PROCESS | 4501 | |3;mootools.html;1404.431205361829;1540.6918616276741;1582.3591445464585;1783.7681101456817;1930.160380234598;8812.867806982893;9118.817623647532;9138.451692898423;9446.622135114605;9449.574769135388;9100.635974561026;9285.210757085655;9286.349955503118;9289;9297.628094876214;2098.6327392706294;2380.73811880693;2420.298113547069;2441.3286346254745;2453.5706251406023;2473.6536884836137;2484.6397272395493;2486.254123762873;2486.9751302486925;2489.3278814720015;2433.3429973907037;2477.6531285620026;2493.0526399967985;2494.2018554062706;2494.775470207681;2002.8197462228397;2274.8407611467205;2339.356676913845;2340.5435939991708;2342.10999820069;2341.1220792202926;2357.622780355135;2360.586897292967;2362.244081893795;2365.7870791628666;9342.346035777498;9346.579403926771;9408.95295523518;9409.811803763954;9415.482148481831;5414.269073675043;5482.533984611313;5500.4499550045075;5511.724413779295;5520.66875987438;3317.1872891141584;3326.367990081901;3370.8482568798254;3484.4947482615135;3500.5799304083416;1095.5508241620978;1111.6331610568493;1120.4509790202824;1131.4569006876663;1160.4719852467108;13106.80339794904;13253.337333133304;13258.734825303536;13310.267935263557;13364.264965426897;4814.614830813526;4882.853514394574;4917.975410122998;4954.925676114861;4986.276989836453;10397.63608273722;10410.531526081344;10415.895841041644;10423.478826058667;10432.165426765841;5672.886542269214;5679.801206957736;5680.602357834994;5684.062129748628;5686.5735069869925;4657.8602641920115;5108.897822043538;5244.842654720364;5249.685018898878;5311.415744268127;4076.3885417187657;4094.6519545838937;4120.484939382577;4136.110736191733;4143.854965076208;1177.1936223686803;1192.1237890150733;1204.4098391788136;1207.4144040140525;1212.87871212878;1009.1119814563137;1033.6227277043824;1034.896510348974;1041.156663102889;1062.4846949229618;6153.538484613582;6193.102000210034;6198.876022479525;6208.379162083756;6347.904781428282;470.21943573667545;475.2728325661743;478.09401184754694;480.9110314591812;490.5045903637352;4255.148970205972;4394.450693663292;4430.579094985971;4435.911281774346;4462.482755863022;11257.211995160424;11444.484998175101;11824;11845.703857403634;11851;11628.53485860556;11874.168808183344;11981.221220620806;11981.580644677395;11992.460339284753;8574.571271436404;8749.256313213447;8761.25529330014;8766.693165739296;8769.956150219208;6218.31598524171;6509.283978762238;6641.33586641332;6660.533762636569;6767.458603311625;10717.839232411676;10959.780804384027;11048.226624136234;11048.392338421463;11125.944370278097;10851.782964340511;11005.944970275097;11118.722031948942;11127.666170014912;11148.331100133693;7485.588292643957;7809.453338266267;7999.920000799918;8273.669053237803;8392.622331994953;9169.35814492979;9169.358144930058;9234;9245.167934885623;9263.305252105984;7760.18518055596;7891.526508409514;7895.526268423913;7912.723054693058;8014.118446970945;7804.102528209329;7879.409044321814;7907.209279072047;7992.560409177551;8021.157778433414;7292.197858235696;7348.191698913222;7375.11498620169;7436.553806771611;7440.404767618686;5002.324686167321;5005.524475174852;5094.6688465249645;5150.716710580804;5205.6356055075785;5368;5368.973155134199;5538.667679939216;5543.556515478833;5587.413321601336 15:19:24 INFO - PROCESS | 4501 | |4;prototype.html;335.0563863328621;338.3655645664379;340.8977306807957;341.2526566818667;344.1774159758178;5198;5303.522682958538;5340.519353258206;5361.919571206435;5394.190871369301;5299.735013249332;5339.958708051931;5342.171963345678;5360.65983504124;5380.192971054344;4178.7283826551175;4191.727537710054;4193.308104162809;4219.493660760713;4226.260404429228;3947.9802600986955;3987.3620220764683;4070.267351876661;4195.874123776276;4205.264078786216;4147.979260103695;4153.688473364495;4165.250254954107;4169.291220492523;4178.101708132751;4131.669466442678;4162.708610397273;4169.249535083683;4182.351735481006;4203.327467605169;3618.7105031597407;3639.363111455511;3696.31618150643;3707.8146092695256;3717.7769333840056;5137.845864624067;5152.9484705152845;5183.429822719498;5192.376914770214;5237.397699264558;4829.903401931977;4834.468208497063;4845.588125009378;4848.393950756155;4881.560659540658;5340.786368545254;5564.33228012641;5577.525910297589;5593.860153496154;5660.179274005246;3970.602939706035;3985.3822657488136;4025.6715283956223;4028.7582745035393;4053.97973010136;5711.914321285184;5804.709764511757;5836.737346819361;5860.267466566722;5865.970670146665;4021.658159056513;4083.959160408417;4114.300568903293;4125.23683118624;4148.398482220061;4145.694106356548;4159.689697745201;4162.2299874522705;4162.2716024696165;4172.7704976226;4738.170820106537;4739.218029025241;4741.241401375763;4743.620510359163;4756.453007904066;5582.27430434041;5624.578156638268;5645.765183462665;5699.430056994351;5709.885802284014;1349.3590544491287;1395.6092294157652;1427.8933826284713;1436.1454934314067;1440.8126943497277;897.3001059173855;898.955052247385;917.8393781088283;918.260800055948;934.3319526538558;4740.862193073706;4777.880552986134;4794.376731024944;4834.540718631724;4857.854264372075;5034.84895453137;5056.836927506694;5078.746062696924;5107.642465027487;5148.326793792033;4774.7585627737035;4791.928121078186;4845.9757701211265;4861.586765124934;5018.372703412074;3055.1903745507457;3066.4633689104317;3074.2775447769754;3076.830804294354;3085.4291955988215;5963.880722385615;5973.283206015306;5980.863635909163;6047.697615119315;6062.575619706578;5653.660780353192;5904.498117660047;5916.5858389913155;5919;5920.674362909996;5920.940790592039;5930.703464826827;5943.10853371989;5973.283206015219;6006.519478441714;5578.716895114066;5756.942430575808;5815.883682326415;5846.210761547307;5878.676672783038;5740.225069615715;5767.5385969121535;5784.566157538117;5784.855378615568;5795.362510123968;5965.403459654;5994.430529099728;6001;6026.668533230714;6073.453389194817;4036.172584620087;4133.669306455537;4228.471441069866;4251.660726871026;4272.722273052242;5600.803971860965;5779.133130030361;5786.161006654096;5825.679587622722;5826.805504871407;5510.614257001971;5601.719914004365;5665.631733937281;5737.971310143423;5741.224934633771;5601.663900166003;5630.718464076862;5638.126090455822;5645.237892884572;5663.292088488939;5342.1986701993455;5578.972105139448;5602.579806514609;5617.43825617435;5626.368353177532;5652.915206271827;5695.772169113189;5715.8856822864145;5729.54163666914;5746.5402767779315;5443;5570;5582.441755824385;5647.378788333198;5648.5481161507805 15:19:24 INFO - PROCESS | 4501 | |5;yui.html;783.3498196496909;784.3764207455074;845.8435189489945;884.1644645809712;884.5754038061729;15101.395944162234;15647.374105035813;15647.84352156478;15687;16286.7556986645;16160;16273.837261627381;16324.34702611897;16332.83667163328;16352.427665031726;690.3131384272656;811.1361400108894;836.0761358698657;840.9495430274172;844.9535275559841;837.1377481194379;839.5927974932154;842.759813453166;843.0515669871395;843.3716880923721;889.7330800759779;890.514669505118;891.1355984694868;891.4027601506973;891.9821603567925;723.8996724978031;742.0649981023895;743.2084829656426;857.1171693156059;874.9781255468632;628.1802248066272;634.109076747171;635.9968200159016;636.5893998371025;637.1684951138762;15248.313825877862;15301.234938253043;15320.540383788504;15331.080135191813;15336;13485;13789.724205515833;13905.304734763322;14100.224487653175;14109.223992680398;13267.86732132676;13373.531926382628;13406.932965335209;13461.192328460324;13487.258200798951;4482.5965663090155;4551.294549344857;4559.338895860082;4617.468991066037;4721.291806229059;63165.36834631687;64251.67874160646;64997.67501162511;65304.67347663231;65569.67215163942;11188.720281992852;11298.250147850258;11305.434728263719;11340.659780206606;11433.1996760226;20375.388738337875;20402.591948160953;20404.591908161754;20409.89795051045;20433.284835030703;7961.283484486308;7965.203479652105;8107.067687215927;8144.837103257902;8238.711645092513;4628.074385122922;4663.836765713184;4730.455997560256;4737.881552961204;4739.3838800955655;3414.129397003748;3488.5639295088113;3520.3663340598937;3522.295540891832;3522.7710198836994;644.5616980453243;647.4464332995316;672.7342699633617;681.431005110738;682.9487788415888;633.762339122829;721.1598487761698;727.3708242370417;773.9264769846856;796.4942261663886;9130.954345228363;9738.028827270022;9740.805183896424;9781.608735650636;9834.655787047419;621.6114928169894;658.2430205263889;770.0989841885008;774.2953911940108;779.6530543907907;4320.4804517681105;4323.848665296762;4388.670849686287;4479.328100784843;4495.505494395614;72068;72193;75222.97324321007;75751.62124189344;76766.61616691992;62424;62948.37051629517;63017.68491157515;63122.36877631257;63827.36172638307;55275.723621381636;55878.44121558814;57769.42230577725;57779.13331300034;58857.70571147202;10285.331453455501;10368.637097701545;10404.68785936423;10435.94782026085;10596.15230781551;37300;37941.81029094837;38464.80767596144;38494.615053850226;39147.608523915536;49472.50527494679;51125.23312150395;51668;51822.74088629533;52128;12863;12863.871361286267;13033.674158145743;13121.475140994253;13247.40386682621;14268.857311426753;14407.42370305176;15118;15134.697306054037;15154.014989025678;13196.868031319947;13631;14011.60595401333;14253.714925701635;14393.712125757216;13702.10936289138;13749.243791591558;14377.065490743069;14578.635534111309;14582;13420.993425492932;13425.664358390728;13654;13931.233782142079;13933.58199254024;11284.661460156209;11481.311121332747;11601.129915256559;11712.648620541397;12073;10816.373427649241;11691.356975366436;11783.646490605295;11793.941030294794;12150 15:19:24 INFO - PROCESS | 4501 | __end_tp_report 15:19:24 INFO - PROCESS | 4501 | __start_cc_report 15:19:24 INFO - PROCESS | 4501 | _x_x_mozilla_cycle_collect,877 15:19:24 INFO - PROCESS | 4501 | __end_cc_report 15:19:24 INFO - PROCESS | 4501 | __startTimestamp1463177964563__endTimestamp 15:19:24 INFO - PROCESS | 4501 | 15:19:24 INFO - PROCESS | 4501 | ------- Summary: start ------- 15:19:24 INFO - PROCESS | 4501 | Number of tests: 6 15:19:24 INFO - PROCESS | 4501 | 15:19:24 INFO - PROCESS | 4501 | [#0] dojo.html Cycles:165 Average:5431.77 Median:5637.66 stddev:613.88 (10.9%) stddev-sans-first:589.37 15:19:24 INFO - PROCESS | 4501 | Values: 3161.7 3182.4 3199.4 3209.9 3246.9 5375.7 5404.6 5417.7 5466.9 5518.3 5356.1 5396.6 5438.9 5451.8 5471.0 4890.2 4978.3 5000.3 5005.2 5067.4 5009.6 5025.2 5051.6 5074.8 5082.1 4868.1 4935.7 4977.1 4977.6 4978.4 4979.6 4990.6 4996.9 5011.3 5037.1 4801.3 4949.3 4967.8 4972.4 5000.1 5247.4 5272.6 5302.1 5303.8 5375.4 5781.2 5787.5 5790.7 5840.9 5845.8 5708.4 5790.3 5798.7 5802.2 5849.7 5419.9 5566.1 5566.7 5572.2 5585.7 6028.4 6064.4 6078.2 6081.6 6082.5 5643.3 5670.3 5712.2 5844.6 5854.7 5828.1 5844.7 5847.2 5848.4 5891.3 5777.6 5821.2 5826.7 5833.9 5838.3 5709.7 5793.2 5804.0 5834.6 5875.1 4464.4 4464.5 4465.0 4467.7 4499.6 3981.4 3999.3 4009.0 4039.2 4047.7 5441.0 5449.7 5494.8 5499.5 5501.1 5837.6 5857.2 5868.6 5874.9 5876.9 5532.6 5541.8 5542.2 5544.7 5547.5 4844.0 5016.4 5049.0 5090.9 5095.7 6061.7 6069.4 6071.2 6071.8 6075.8 5874.2 5881.2 5885.7 5885.9 5885.9 5795.5 6073.1 6097.4 6136.3 6187.2 5816.9 5828.3 5855.9 5857.6 5895.3 5657.3 5951.2 5955.4 5958.6 5959.3 5648.1 5679.5 5700.6 5730.3 5734.4 5655.7 5716.1 5719.0 5726.8 5728.2 5474.6 5525.3 5626.3 5629.1 5638.4 5680.0 5781.3 5795.4 5815.6 5816.0 5600.0 5608.1 5632.5 5637.7 5643.7 15:19:24 INFO - PROCESS | 4501 | 15:19:24 INFO - PROCESS | 4501 | [#1] ext.html Cycles:180 Average:58445.46 Median:42312.18 stddev:110794.38 (261.8%) stddev-sans-first:111020.15 15:19:24 INFO - PROCESS | 4501 | Values: 629.5 633.8 641.9 645.8 656.9 31135.0 33870.2 43044.1 44068.3 44163.8 45313.0 45669.0 45743.5 45777.8 45783.5 8807.5 8959.6 8971.3 8972.4 8975.7 8827.7 8906.9 8916.8 8920.0 8922.1 8931.6 8976.9 8981.7 8981.9 8984.9 8915.1 8959.4 8960.4 8964.6 8969.0 8870.7 8947.5 8952.9 8957.5 8960.6 43132.8 43400.6 43440.6 43470.6 43482.6 3648.9 3876.1 4107.5 4136.6 4469.8 32564.3 33013.8 33244.5 33670.0 33703.0 4167.4 4204.6 4223.7 4239.7 4276.1 347010.0 347175.0 347681.0 347739.0 351098.0 53750.0 58192.1 62390.0 62586.1 62624.0 60222.1 66301.0 66301.0 66359.0 66405.7 17480.0 17560.3 17713.3 17746.9 17749.6 12195.3 12963.3 13256.7 13658.2 13773.7 18094.0 18208.2 18280.0 18444.4 18503.6 6201.8 6263.2 6269.3 6302.4 6393.2 1038.3 1098.2 1167.5 1184.7 1209.8 33229.0 33500.8 33834.2 34101.1 34656.3 1167.2 1169.3 1192.6 1217.9 1331.5 17176.0 17845.8 17921.2 17927.4 18014.1 538072.0 541556.0 541934.0 543609.0 543639.0 60405.5 60942.0 60992.4 61082.4 61121.7 1306.0 1413.7 1425.4 1433.0 1447.8 30563.0 34510.7 34739.0 34843.8 34881.7 50725.0 51052.5 51340.5 51363.5 51369.2 330190.0 332451.0 333289.0 335748.0 335885.0 36802.0 41832.4 41852.6 42017.8 43603.3 49133.0 49199.5 50467.2 50496.7 50828.0 38558.8 41706.4 42026.8 42115.6 42256.6 41925.0 42348.0 42470.2 42551.6 42625.1 41589.4 42276.4 42485.0 43043.4 43133.8 36023.6 36903.0 37591.0 37775.8 37827.2 28704.0 28727.3 28884.0 29184.3 29268.6 15:19:24 INFO - PROCESS | 4501 | 15:19:24 INFO - PROCESS | 4501 | [#2] jquery.html Cycles:180 Average:26673.21 Median:2439.06 stddev:73179.22 (3000.3%) stddev-sans-first:73357.93 15:19:24 INFO - PROCESS | 4501 | Values: 404.3 406.4 412.6 414.3 420.1 13232.6 18054.6 18574.8 19513.1 19514.2 14647.8 16892.5 18075.6 18504.8 18897.0 5534.0 5651.5 5665.0 5676.7 5718.7 5604.9 5617.3 5642.7 5646.3 5668.0 4044.8 4207.3 4208.1 5763.8 6111.8 5400.9 6201.2 6203.3 6204.9 6220.7 5460.2 5506.8 5575.1 5582.5 5590.4 13108.1 13267.5 21886.5 22534.0 22555.0 2423.0 2455.1 2479.0 2817.4 3019.2 10245.1 10669.8 12954.3 13893.8 14390.3 1780.2 1898.5 2003.5 2033.2 2058.6 78703.2 79636.0 80090.6 80750.6 81437.2 10841.8 10886.2 11093.0 11141.9 12025.1 15190.1 15262.3 15381.5 15414.8 15424.6 7884.8 8057.6 8146.0 8151.3 8217.8 7709.6 7747.1 7787.3 7863.5 7879.8 4644.7 4730.5 4751.8 4772.6 4833.4 1782.2 1831.8 1909.3 1914.9 1981.2 1003.3 1015.3 1077.3 1133.4 1175.6 17994.2 18384.2 18509.7 18569.4 18618.2 1053.7 1065.7 1083.1 1119.0 1148.9 9768.7 10553.4 10583.2 10638.4 10647.1 423026.0 423182.0 442626.0 462804.0 465120.0 56628.0 67810.7 84949.6 90446.6 92267.0 1052.5 1073.2 1076.8 1095.5 1099.7 16228.8 16313.8 16394.7 16532.0 16541.9 33640.3 37264.0 37642.8 40791.4 41231.0 51835.7 54818.0 54832.5 55008.9 55111.0 8102.8 8295.6 8500.5 8639.5 8767.9 7409.5 11811.5 11824.8 12246.5 12365.9 10787.6 10917.3 10936.6 10964.5 11151.9 10467.0 10513.5 10694.9 11026.2 11149.4 5984.5 8317.6 10996.6 11022.5 11076.8 7893.2 8165.8 8269.6 8365.1 8404.1 8191.4 10714.1 10851.9 10859.8 10886.1 15:19:24 INFO - PROCESS | 4501 | 15:19:24 INFO - PROCESS | 4501 | [#3] mootools.html Cycles:180 Average:6113.29 Median:2564.04 stddev:3565.44 (139.1%) stddev-sans-first:3557.88 15:19:24 INFO - PROCESS | 4501 | Values: 1404.4 1540.7 1582.4 1783.8 1930.2 8812.9 9118.8 9138.5 9446.6 9449.6 9100.6 9285.2 9286.3 9289.0 9297.6 2098.6 2380.7 2420.3 2441.3 2453.6 2473.7 2484.6 2486.3 2487.0 2489.3 2433.3 2477.7 2493.1 2494.2 2494.8 2002.8 2274.8 2339.4 2340.5 2342.1 2341.1 2357.6 2360.6 2362.2 2365.8 9342.3 9346.6 9409.0 9409.8 9415.5 5414.3 5482.5 5500.4 5511.7 5520.7 3317.2 3326.4 3370.8 3484.5 3500.6 1095.6 1111.6 1120.5 1131.5 1160.5 13106.8 13253.3 13258.7 13310.3 13364.3 4814.6 4882.9 4918.0 4954.9 4986.3 10397.6 10410.5 10415.9 10423.5 10432.2 5672.9 5679.8 5680.6 5684.1 5686.6 4657.9 5108.9 5244.8 5249.7 5311.4 4076.4 4094.7 4120.5 4136.1 4143.9 1177.2 1192.1 1204.4 1207.4 1212.9 1009.1 1033.6 1034.9 1041.2 1062.5 6153.5 6193.1 6198.9 6208.4 6347.9 470.2 475.3 478.1 480.9 490.5 4255.1 4394.5 4430.6 4435.9 4462.5 11257.2 11444.5 11824.0 11845.7 11851.0 11628.5 11874.2 11981.2 11981.6 11992.5 8574.6 8749.3 8761.3 8766.7 8770.0 6218.3 6509.3 6641.3 6660.5 6767.5 10717.8 10959.8 11048.2 11048.4 11125.9 10851.8 11005.9 11118.7 11127.7 11148.3 7485.6 7809.5 7999.9 8273.7 8392.6 9169.4 9169.4 9234.0 9245.2 9263.3 7760.2 7891.5 7895.5 7912.7 8014.1 7804.1 7879.4 7907.2 7992.6 8021.2 7292.2 7348.2 7375.1 7436.6 7440.4 5002.3 5005.5 5094.7 5150.7 5205.6 5368.0 5369.0 5538.7 5543.6 5587.4 15:19:24 INFO - PROCESS | 4501 | 15:19:24 INFO - PROCESS | 4501 | [#4] prototype.html Cycles:180 Average:4693.25 Median:5268.57 stddev:1386.13 (26.3%) stddev-sans-first:1350.87 15:19:24 INFO - PROCESS | 4501 | Values: 335.1 338.4 340.9 341.3 344.2 5198.0 5303.5 5340.5 5361.9 5394.2 5299.7 5340.0 5342.2 5360.7 5380.2 4178.7 4191.7 4193.3 4219.5 4226.3 3948.0 3987.4 4070.3 4195.9 4205.3 4148.0 4153.7 4165.3 4169.3 4178.1 4131.7 4162.7 4169.2 4182.4 4203.3 3618.7 3639.4 3696.3 3707.8 3717.8 5137.8 5152.9 5183.4 5192.4 5237.4 4829.9 4834.5 4845.6 4848.4 4881.6 5340.8 5564.3 5577.5 5593.9 5660.2 3970.6 3985.4 4025.7 4028.8 4054.0 5711.9 5804.7 5836.7 5860.3 5866.0 4021.7 4084.0 4114.3 4125.2 4148.4 4145.7 4159.7 4162.2 4162.3 4172.8 4738.2 4739.2 4741.2 4743.6 4756.5 5582.3 5624.6 5645.8 5699.4 5709.9 1349.4 1395.6 1427.9 1436.1 1440.8 897.3 899.0 917.8 918.3 934.3 4740.9 4777.9 4794.4 4834.5 4857.9 5034.8 5056.8 5078.7 5107.6 5148.3 4774.8 4791.9 4846.0 4861.6 5018.4 3055.2 3066.5 3074.3 3076.8 3085.4 5963.9 5973.3 5980.9 6047.7 6062.6 5653.7 5904.5 5916.6 5919.0 5920.7 5920.9 5930.7 5943.1 5973.3 6006.5 5578.7 5756.9 5815.9 5846.2 5878.7 5740.2 5767.5 5784.6 5784.9 5795.4 5965.4 5994.4 6001.0 6026.7 6073.5 4036.2 4133.7 4228.5 4251.7 4272.7 5600.8 5779.1 5786.2 5825.7 5826.8 5510.6 5601.7 5665.6 5738.0 5741.2 5601.7 5630.7 5638.1 5645.2 5663.3 5342.2 5579.0 5602.6 5617.4 5626.4 5652.9 5695.8 5715.9 5729.5 5746.5 5443.0 5570.0 5582.4 5647.4 5648.5 15:19:24 INFO - PROCESS | 4501 | 15:19:24 INFO - PROCESS | 4501 | [#5] yui.html Cycles:180 Average:16670.75 Median:4523.40 stddev:19986.31 (441.8%) stddev-sans-first:20006.77 15:19:24 INFO - PROCESS | 4501 | Values: 783.3 784.4 845.8 884.2 884.6 15101.4 15647.4 15647.8 15687.0 16286.8 16160.0 16273.8 16324.3 16332.8 16352.4 690.3 811.1 836.1 840.9 845.0 837.1 839.6 842.8 843.1 843.4 889.7 890.5 891.1 891.4 892.0 723.9 742.1 743.2 857.1 875.0 628.2 634.1 636.0 636.6 637.2 15248.3 15301.2 15320.5 15331.1 15336.0 13485.0 13789.7 13905.3 14100.2 14109.2 13267.9 13373.5 13406.9 13461.2 13487.3 4482.6 4551.3 4559.3 4617.5 4721.3 63165.4 64251.7 64997.7 65304.7 65569.7 11188.7 11298.3 11305.4 11340.7 11433.2 20375.4 20402.6 20404.6 20409.9 20433.3 7961.3 7965.2 8107.1 8144.8 8238.7 4628.1 4663.8 4730.5 4737.9 4739.4 3414.1 3488.6 3520.4 3522.3 3522.8 644.6 647.4 672.7 681.4 682.9 633.8 721.2 727.4 773.9 796.5 9131.0 9738.0 9740.8 9781.6 9834.7 621.6 658.2 770.1 774.3 779.7 4320.5 4323.8 4388.7 4479.3 4495.5 72068.0 72193.0 75223.0 75751.6 76766.6 62424.0 62948.4 63017.7 63122.4 63827.4 55275.7 55878.4 57769.4 57779.1 58857.7 10285.3 10368.6 10404.7 10435.9 10596.2 37300.0 37941.8 38464.8 38494.6 39147.6 49472.5 51125.2 51668.0 51822.7 52128.0 12863.0 12863.9 13033.7 13121.5 13247.4 14268.9 14407.4 15118.0 15134.7 15154.0 13196.9 13631.0 14011.6 14253.7 14393.7 13702.1 13749.2 14377.1 14578.6 14582.0 13421.0 13425.7 13654.0 13931.2 13933.6 11284.7 11481.3 11601.1 11712.6 12073.0 10816.4 11691.4 11783.6 11793.9 12150.0 15:19:24 INFO - PROCESS | 4501 | -------- Summary: end -------- 15:19:24 INFO - PROCESS | 4501 | 15:19:25 INFO - TEST-INFO | 4501: exit 0 15:19:25 INFO - TEST-OK | dromaeo_css | took 1114153ms 15:19:25 INFO - TEST-START | kraken 15:19:25 INFO - operating with platform_type : linux_ 15:19:25 INFO - Initialising browser for kraken test... 15:19:25 INFO - TEST-INFO | started process 4685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXtF6Z7/profile http://localhost:50828/getInfo.html) 15:19:30 INFO - PROCESS | 4685 | __metrics Screen width/height:1600/1200 15:19:30 INFO - PROCESS | 4685 | colorDepth:24 15:19:30 INFO - PROCESS | 4685 | Browser inner width/height: 1024/697 15:19:30 INFO - PROCESS | 4685 | __metrics 15:19:31 INFO - PROCESS | 4685 | 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" 15:19:31 ERROR - PROCESS | 4685 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:19:32 INFO - TEST-INFO | 4685: exit 0 15:19:32 INFO - Browser initialized. 15:19:32 INFO - Running cycle 1/1 for kraken test... 15:19:32 INFO - TEST-INFO | started process 4771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXtF6Z7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:19:44 INFO - PROCESS | 4771 | RSS: Main: 152780800 15:19:44 INFO - PROCESS | 4771 | 15:19:46 INFO - PROCESS | 4771 | Cycle 1(1): loaded http://localhost:50828/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50828/tests/kraken/driver.html?testName=audio-beat-detection) 15:19:47 INFO - PROCESS | 4771 | RSS: Main: 208883712 15:19:47 INFO - PROCESS | 4771 | 15:19:50 INFO - PROCESS | 4771 | Cycle 1(1): loaded http://localhost:50828/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50828/tests/kraken/driver.html?testName=audio-dft) 15:19:50 INFO - PROCESS | 4771 | RSS: Main: 197726208 15:19:50 INFO - PROCESS | 4771 | 15:19:54 INFO - PROCESS | 4771 | Cycle 1(1): loaded http://localhost:50828/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50828/tests/kraken/driver.html?testName=audio-fft) 15:19:54 INFO - PROCESS | 4771 | RSS: Main: 266080256 15:19:54 INFO - PROCESS | 4771 | 15:19:56 INFO - PROCESS | 4771 | Cycle 1(1): loaded http://localhost:50828/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50828/tests/kraken/driver.html?testName=audio-oscillator) 15:19:57 INFO - PROCESS | 4771 | RSS: Main: 174272512 15:19:57 INFO - PROCESS | 4771 | 15:19:59 INFO - PROCESS | 4771 | Cycle 1(1): loaded http://localhost:50828/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50828/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:20:00 INFO - PROCESS | 4771 | RSS: Main: 179384320 15:20:00 INFO - PROCESS | 4771 | 15:20:03 INFO - PROCESS | 4771 | Cycle 1(1): loaded http://localhost:50828/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50828/tests/kraken/driver.html?testName=imaging-darkroom) 15:20:04 INFO - PROCESS | 4771 | RSS: Main: 214892544 15:20:04 INFO - PROCESS | 4771 | 15:20:07 INFO - PROCESS | 4771 | Cycle 1(1): loaded http://localhost:50828/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50828/tests/kraken/driver.html?testName=imaging-desaturate) 15:20:08 INFO - PROCESS | 4771 | RSS: Main: 215138304 15:20:08 INFO - PROCESS | 4771 | 15:20:11 INFO - PROCESS | 4771 | Cycle 1(1): loaded http://localhost:50828/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50828/tests/kraken/driver.html?testName=json-parse-financial) 15:20:11 INFO - PROCESS | 4771 | RSS: Main: 215269376 15:20:11 INFO - PROCESS | 4771 | 15:20:13 INFO - PROCESS | 4771 | Cycle 1(1): loaded http://localhost:50828/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50828/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:20:14 INFO - PROCESS | 4771 | RSS: Main: 203042816 15:20:14 INFO - PROCESS | 4771 | 15:20:15 INFO - PROCESS | 4771 | Cycle 1(1): loaded http://localhost:50828/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50828/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:20:16 INFO - PROCESS | 4771 | RSS: Main: 207523840 15:20:16 INFO - PROCESS | 4771 | 15:20:18 INFO - PROCESS | 4771 | Cycle 1(1): loaded http://localhost:50828/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50828/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:20:19 INFO - PROCESS | 4771 | RSS: Main: 217407488 15:20:19 INFO - PROCESS | 4771 | 15:20:21 INFO - PROCESS | 4771 | Cycle 1(1): loaded http://localhost:50828/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50828/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:20:22 INFO - PROCESS | 4771 | RSS: Main: 224555008 15:20:22 INFO - PROCESS | 4771 | 15:20:25 INFO - PROCESS | 4771 | Cycle 1(1): loaded http://localhost:50828/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50828/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:20:25 INFO - PROCESS | 4771 | RSS: Main: 219860992 15:20:25 INFO - PROCESS | 4771 | 15:20:27 INFO - PROCESS | 4771 | Cycle 1(1): loaded http://localhost:50828/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50828/tests/kraken/driver.html?testName=ai-astar) 15:20:27 INFO - PROCESS | 4771 | RSS: Main: 265457664 15:20:27 INFO - PROCESS | 4771 | 15:20:27 INFO - PROCESS | 4771 | __start_tp_report 15:20:27 INFO - PROCESS | 4771 | _x_x_mozilla_page_load 15:20:27 INFO - PROCESS | 4771 | _x_x_mozilla_page_load_details 15:20:27 INFO - PROCESS | 4771 | |i|pagename|runs| 15:20:27 INFO - PROCESS | 4771 | |0;ai-astar;109;104;108;108;108;109;109;109;107;108 15:20:27 INFO - PROCESS | 4771 | |1;audio-beat-detection;159;125;154;202;128;159;158;127;177;139 15:20:27 INFO - PROCESS | 4771 | |2;audio-dft;161;163;161;160;159;162;162;162;161;162 15:20:27 INFO - PROCESS | 4771 | |3;audio-fft;74;77;75;144;75;74;75;74;124;73 15:20:27 INFO - PROCESS | 4771 | |4;audio-oscillator;92;90;144;91;92;91;136;90;91;117 15:20:27 INFO - PROCESS | 4771 | |5;imaging-gaussian-blur;116;117;116;116;117;116;117;117;118;116 15:20:27 INFO - PROCESS | 4771 | |6;imaging-darkroom;146;144;146;146;145;145;144;146;146;145 15:20:27 INFO - PROCESS | 4771 | |7;imaging-desaturate;94;95;95;95;95;95;95;94;96;95 15:20:27 INFO - PROCESS | 4771 | |8;json-parse-financial;55;54;56;53;55;54;54;108;53;51 15:20:27 INFO - PROCESS | 4771 | |9;json-stringify-tinderbox;59;60;59;59;59;59;59;58;59;59 15:20:27 INFO - PROCESS | 4771 | |10;stanford-crypto-aes;78;79;78;77;84;80;78;85;77;79 15:20:27 INFO - PROCESS | 4771 | |11;stanford-crypto-ccm;135;121;121;116;123;120;119;127;191;124 15:20:27 INFO - PROCESS | 4771 | |12;stanford-crypto-pbkdf2;160;159;156;163;161;157;160;165;160;163 15:20:27 INFO - PROCESS | 4771 | |13;stanford-crypto-sha256-iterative;61;63;62;63;62;64;62;60;63;60 15:20:27 INFO - PROCESS | 4771 | __end_tp_report 15:20:27 INFO - PROCESS | 4771 | __start_cc_report 15:20:27 INFO - PROCESS | 4771 | _x_x_mozilla_cycle_collect,1857 15:20:27 INFO - PROCESS | 4771 | __end_cc_report 15:20:27 INFO - PROCESS | 4771 | __startTimestamp1463178027747__endTimestamp 15:20:27 INFO - PROCESS | 4771 | 15:20:27 INFO - PROCESS | 4771 | ------- Summary: start ------- 15:20:27 INFO - PROCESS | 4771 | Number of tests: 14 15:20:27 INFO - PROCESS | 4771 | 15:20:27 INFO - PROCESS | 4771 | [#0] ai-astar Cycles:10 Average:107.90 Median:108.50 stddev:1.52 (1.4%) stddev-sans-first:1.56 15:20:27 INFO - PROCESS | 4771 | Values: 109.0 104.0 108.0 108.0 108.0 109.0 109.0 109.0 107.0 108.0 15:20:27 INFO - PROCESS | 4771 | 15:20:27 INFO - PROCESS | 4771 | [#1] audio-beat-detection Cycles:10 Average:152.80 Median:158.50 stddev:24.39 (15.4%) stddev-sans-first:25.77 15:20:27 INFO - PROCESS | 4771 | Values: 159.0 125.0 154.0 202.0 128.0 159.0 158.0 127.0 177.0 139.0 15:20:27 INFO - PROCESS | 4771 | 15:20:27 INFO - PROCESS | 4771 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 15:20:27 INFO - PROCESS | 4771 | Values: 161.0 163.0 161.0 160.0 159.0 162.0 162.0 162.0 161.0 162.0 15:20:27 INFO - PROCESS | 4771 | 15:20:27 INFO - PROCESS | 4771 | [#3] audio-fft Cycles:10 Average:86.50 Median:74.50 stddev:25.50 (34.2%) stddev-sans-first:26.64 15:20:27 INFO - PROCESS | 4771 | Values: 74.0 77.0 75.0 144.0 75.0 74.0 75.0 74.0 124.0 73.0 15:20:27 INFO - PROCESS | 4771 | 15:20:27 INFO - PROCESS | 4771 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:91.00 stddev:21.02 (23.1%) stddev-sans-first:21.89 15:20:27 INFO - PROCESS | 4771 | Values: 92.0 90.0 144.0 91.0 92.0 91.0 136.0 90.0 91.0 117.0 15:20:27 INFO - PROCESS | 4771 | 15:20:27 INFO - PROCESS | 4771 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 15:20:27 INFO - PROCESS | 4771 | Values: 116.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 118.0 116.0 15:20:27 INFO - PROCESS | 4771 | 15:20:27 INFO - PROCESS | 4771 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 15:20:27 INFO - PROCESS | 4771 | Values: 146.0 144.0 146.0 146.0 145.0 145.0 144.0 146.0 146.0 145.0 15:20:27 INFO - PROCESS | 4771 | 15:20:27 INFO - PROCESS | 4771 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 15:20:27 INFO - PROCESS | 4771 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 15:20:27 INFO - PROCESS | 4771 | 15:20:27 INFO - PROCESS | 4771 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:54.00 stddev:17.17 (31.8%) stddev-sans-first:18.14 15:20:27 INFO - PROCESS | 4771 | Values: 55.0 54.0 56.0 53.0 55.0 54.0 54.0 108.0 53.0 51.0 15:20:27 INFO - PROCESS | 4771 | 15:20:27 INFO - PROCESS | 4771 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 15:20:27 INFO - PROCESS | 4771 | Values: 59.0 60.0 59.0 59.0 59.0 59.0 59.0 58.0 59.0 59.0 15:20:27 INFO - PROCESS | 4771 | 15:20:27 INFO - PROCESS | 4771 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:2.80 (3.5%) stddev-sans-first:2.92 15:20:27 INFO - PROCESS | 4771 | Values: 78.0 79.0 78.0 77.0 84.0 80.0 78.0 85.0 77.0 79.0 15:20:27 INFO - PROCESS | 4771 | 15:20:27 INFO - PROCESS | 4771 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:123.50 stddev:22.16 (17.9%) stddev-sans-first:23.42 15:20:27 INFO - PROCESS | 4771 | Values: 135.0 121.0 121.0 116.0 123.0 120.0 119.0 127.0 191.0 124.0 15:20:27 INFO - PROCESS | 4771 | 15:20:27 INFO - PROCESS | 4771 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.50 stddev:2.76 (1.7%) stddev-sans-first:2.92 15:20:27 INFO - PROCESS | 4771 | Values: 160.0 159.0 156.0 163.0 161.0 157.0 160.0 165.0 160.0 163.0 15:20:27 INFO - PROCESS | 4771 | 15:20:27 INFO - PROCESS | 4771 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.50 stddev:1.33 (2.1%) stddev-sans-first:1.36 15:20:27 INFO - PROCESS | 4771 | Values: 61.0 63.0 62.0 63.0 62.0 64.0 62.0 60.0 63.0 60.0 15:20:27 INFO - PROCESS | 4771 | -------- Summary: end -------- 15:20:27 INFO - PROCESS | 4771 | 15:20:28 INFO - TEST-INFO | 4771: exit 0 15:20:28 INFO - TEST-OK | kraken | took 63446ms 15:20:28 INFO - SUITE-END | took 1177s 15:20:28 INFO - Completed test suite (00:19:37) 15:20:28 INFO - javascript benchmark 15:20:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3161.7470602351814, 3182.4112539180255, 3199.4241036613407, 3209.8555564999574, 3246.853891574879, 5375.6774593524415, 5404.621676482648, 5417.7291135443165, 5466.863328416786, 5518.310211223597, 5356.062689029414, 5396.5952553558445, 5438.891222175564, 5451.809186678467, 5470.972645136779, 4890.217565189561, 4978.327925730035, 5000.299958005882, 5005.199168133099, 5067.442581316071, 5009.57418619416, 5025.1708468102715, 5051.595872330205, 5074.84775456735, 5082.0598189334905, 4868.0750657375165, 4935.703857768527, 4977.104121258172, 4977.552020318152, 4978.377702787152, 4979.626528010377, 4990.575801056914, 4996.925046124311, 5011.298418221452, 5037.11850426174, 4801.255805350176, 4949.307097006422, 4967.751612419401, 4972.428170760372, 5000.149974504343, 5247.370315562119, 5272.604554658416, 5302.09864323066, 5303.761330740126, 5375.354957405098, 5781.161731548944, 5787.50806181475, 5790.71046447676, 5840.912386314209, 5845.795397161079, 5708.400617935098, 5790.276215473066, 5798.710064496759, 5802.158686990405, 5849.736761845727, 5419.918701219485, 5566.109422492423, 5566.666000040011, 5572.219889215473, 5585.664860108406, 6028.386380091869, 6064.423879731418, 6078.179445774852, 6081.6351018939, 6082.482988945989, 5643.322801263875, 5670.262865827499, 5712.200291959129, 5844.620099693507, 5854.736536855852, 5828.0966450200285, 5844.736986835603, 5847.181394604759, 5848.356680765112, 5891.322497912709, 5777.62445441045, 5821.18503409523, 5826.6795326256615, 5833.88332233353, 5838.2702162229725, 5709.65742055478, 5793.2179155814265, 5804.042333015005, 5834.562407819346, 5875.059990401601, 4464.397306363664, 4464.464264288306, 4465.017696106851, 4467.709598876063, 4499.640028797754, 3981.442598036277, 3999.280129576704, 4009.0, 4039.151778126626, 4047.6964227683043, 5441.0, 5449.7275136243825, 5494.80768173112, 5499.477549632778, 5501.092319767274, 5837.562182836305, 5857.15071314657, 5868.589198756046, 5874.941250587525, 5876.853078673067, 5532.640378375393, 5541.778328866881, 5542.196381524656, 5544.7227638618715, 5547.5007249347755, 4843.951560484421, 5016.44819069902, 5049.040682270357, 5090.898182036412, 5095.694258344512, 6061.666608336495, 6069.3627169147485, 6071.241094863142, 6071.757129714851, 6075.848103797441, 5874.236349274653, 5881.206037184926, 5885.705714714333, 5885.852853678521, 5885.882282354414, 5795.536357091507, 6073.119397687399, 6097.433938678448, 6136.29432615255, 6187.195664563758, 5816.941830581809, 5828.271466066742, 5855.912161317498, 5857.560682948711, 5895.29256489224, 5657.32112146545, 5951.226340575698, 5955.434233747787, 5958.553108516965, 5959.28488581373, 5648.096304591246, 5679.460451257124, 5700.629459085146, 5730.341010783646, 5734.426557344233, 5655.660660360391, 5716.085426331767, 5719.027765279996, 5726.770929162787, 5728.2266893970445, 5474.616776825584, 5525.281713377235, 5626.2967129108865, 5629.127485239795, 5638.407967163553, 5679.971600141973, 5781.306243250837, 5795.420457954171, 5815.621984570989, 5816.0, 5600.0479918414785, 5608.07466767995, 5632.464915832989, 5637.661740295595, 5643.746031428514], "value": 5390.864930606015, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.4586655476289, 633.8035209085184, 641.8812519683862, 645.7546132469662, 656.9375909288616, 31135.0, 33870.153246168826, 43044.13911721767, 44068.33897491532, 44163.77918110405, 45313.0, 45669.0, 45743.542564574345, 45777.77111114448, 45783.54216457834, 8807.471551706902, 8959.641614335418, 8971.282297416192, 8972.371933964625, 8975.730728078168, 8827.735167944971, 8906.86639700405, 8916.8408106946, 8920.0, 8922.10778922109, 8931.55342232889, 8976.910230897673, 8981.730548083535, 8981.865272020925, 8984.8652270216, 8915.063918288552, 8959.37284390093, 8960.417572857743, 8964.551772411385, 8968.955155224183, 8870.73387798367, 8947.50788706621, 8952.8657070144, 8957.462552246887, 8960.641574337018, 43132.78433607843, 43400.565994340286, 43440.56559434428, 43470.56529434697, 43482.565174348485, 3648.890533284006, 3876.089119057019, 4107.466029416157, 4136.627703506699, 4469.7541635210055, 32564.348713025844, 33013.83493082519, 33244.50133248003, 33670.0, 33703.0, 4167.354060120686, 4204.558521355275, 4223.66210703143, 4239.745615263094, 4276.102018576103, 347010.0, 347175.0, 347681.0, 347738.9999999975, 351098.0, 53750.0, 58192.12711809326, 62390.0, 62586.0612090819, 62624.0, 60222.09666855001, 66301.0, 66301.0, 66359.0, 66405.66797165983, 17480.0, 17560.29758809633, 17713.29146834138, 17746.935183889007, 17749.645007099785, 12195.329256890778, 12963.287019214034, 13256.668583285495, 13658.180509169482, 13773.724525509635, 18094.0, 18208.180631871597, 18280.0, 18444.35444759454, 18503.629927401376, 6201.844953876099, 6263.217097862767, 6269.310375858652, 6302.369763023661, 6393.2328120625825, 1038.3354653022072, 1098.1983152298708, 1167.486306025346, 1184.6505280942142, 1209.8245754365569, 33229.0, 33500.83249583785, 33834.154146146546, 34101.147471313416, 34656.306873862886, 1167.2237961755338, 1169.3393232823428, 1192.6243233381458, 1217.8843009914044, 1331.4807225182187, 17176.0, 17845.821541784677, 17921.193546290448, 17927.37254196097, 18014.099295035197, 538072.0, 541556.0, 541934.0, 543609.0, 543639.0, 60405.46958978094, 60942.0, 60992.39007609867, 61082.38917610856, 61121.69439152776, 1305.9934700326437, 1413.6607214268502, 1425.3870835540818, 1432.9713405731827, 1447.8407375188722, 30563.0, 34510.654893450745, 34739.0, 34843.82578087093, 34881.65118348784, 50725.0, 51052.489475104776, 51340.486595135066, 51363.48636513737, 51369.229461558854, 330190.0, 332451.0, 333289.0, 335748.0, 335885.0, 36802.0, 41832.3725144117, 41852.581474184866, 42017.78991105147, 43603.34594981141, 49133.0, 49199.508004919495, 50467.242991355895, 50496.747516262185, 50828.0, 38558.80720596379, 41706.37440438335, 42026.78986605047, 42115.57884421239, 42256.57743422526, 41925.0, 42348.0, 42470.150596988504, 42551.574484254765, 42625.14749704926, 41589.37615935703, 42276.36585451282, 42485.0, 43043.35434968415, 43133.784331078146, 36023.63976360203, 36903.0, 37591.0, 37775.81112094422, 37827.24345513019, 28704.0, 28727.281817954718, 28884.0, 29184.27039324034, 29268.56097158502], "value": 20653.385592936, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.25213355292715, 406.40664629640725, 412.59771722570497, 414.2543421840687, 420.08002474580667, 13232.603021909357, 18054.638907221848, 18574.81425185751, 19513.121909514088, 19514.21943122275, 14647.780283295733, 16892.493225203234, 18075.63848723028, 18504.814951850476, 18897.0, 5533.972330138354, 5651.463111004448, 5665.0, 5676.687782171979, 5718.714064296769, 5604.943950560503, 5617.269754931853, 5642.689652069134, 5646.2942132233475, 5667.971660141693, 4044.757314561121, 4207.326827707568, 4208.13733184698, 5763.769449222047, 6111.816645500642, 5400.891982160335, 6201.162843016203, 6203.31763506014, 6204.87590248197, 6220.720067596969, 5460.153676180198, 5506.834794956158, 5575.107982722786, 5582.497575218209, 5590.357108932484, 13108.14797038199, 13267.535636252782, 21886.452838679, 22534.0, 22555.0, 2423.0, 2455.1161581830706, 2478.987605061963, 2817.394260234039, 3019.1697283247063, 10245.077942985092, 10669.786604267949, 12954.287514186715, 13893.79159312611, 14390.28048597566, 1780.2078075256516, 1898.4968983219458, 2003.5492014296813, 2033.1867253098878, 2058.608864315775, 78703.21296787016, 79636.0, 80090.59954700248, 80750.59624701897, 81437.18562814355, 10841.83737243942, 10886.183536234814, 11093.0, 11141.94429027866, 12025.098117641212, 15190.088594684354, 15262.31319590621, 15381.461648842236, 15414.768778468331, 15424.61438464025, 7884.763457096296, 8057.59712014397, 8145.95927020373, 8151.266386025286, 8217.753467395987, 7709.575973321521, 7747.147813740484, 7787.29914307715, 7863.52818830872, 7879.84240315202, 4644.7213167210075, 4730.526947305242, 4751.762411879392, 4772.570468657768, 4833.3958255218095, 1782.2069179215384, 1831.84429323509, 1909.255390397746, 1914.874489316857, 1981.1753444872031, 1003.267614641316, 1015.3349556040805, 1077.3105212663902, 1133.3879704959395, 1175.5767923547517, 17994.190261438267, 18384.17271222798, 18509.7223541647, 18569.44291671252, 18618.16218270181, 1053.6786280184465, 1065.706930594093, 1083.073971754139, 1118.9664310070712, 1148.9310641361544, 9768.658096966572, 10553.419561924014, 10583.153347732163, 10638.361698297973, 10647.094996925192, 423026.0, 423182.0, 442626.0, 462804.0, 465120.0, 56628.0, 67810.66094669593, 84949.57525212334, 90446.64330035055, 92267.0, 1052.4842827014709, 1073.2058276875212, 1076.7631121153333, 1095.4905968724581, 1099.7140743406771, 16228.837711623204, 16313.755293670842, 16394.672106558042, 16532.0, 16541.917290413472, 33640.327193456484, 37264.0, 37642.83512177662, 40791.388129177496, 41231.0, 51835.74082129565, 54818.0, 54832.451675482735, 55008.89982200414, 55111.0, 8102.83794324122, 8295.626696798538, 8500.489970601784, 8639.524826134622, 8767.912320876709, 7409.518381305198, 11811.468483918072, 11824.82262766042, 12246.510139594317, 12365.938170309091, 10787.568497260021, 10917.344959302467, 10936.56253749841, 10964.506597203304, 11151.944240278746, 10467.0, 10513.526891289757, 10694.893051069701, 11026.173037022416, 11149.386783726974, 5984.461398474158, 8317.584120794058, 10996.560137594726, 11022.50398732075, 11076.833847492455, 7893.17121702236, 8165.79585510367, 8269.627866746132, 8365.121662225378, 8404.075551689431, 8191.385646076449, 10714.14286857034, 10851.945740271249, 10859.782804344028, 10886.074683651661], "value": 8914.229575774352, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.431205361829, 1540.6918616276741, 1582.3591445464585, 1783.7681101456817, 1930.160380234598, 8812.867806982893, 9118.817623647532, 9138.451692898423, 9446.622135114605, 9449.574769135388, 9100.635974561026, 9285.210757085655, 9286.349955503118, 9289.0, 9297.628094876214, 2098.6327392706294, 2380.73811880693, 2420.298113547069, 2441.3286346254745, 2453.5706251406023, 2473.6536884836137, 2484.6397272395493, 2486.254123762873, 2486.9751302486925, 2489.3278814720015, 2433.3429973907037, 2477.6531285620026, 2493.0526399967985, 2494.2018554062706, 2494.775470207681, 2002.8197462228397, 2274.8407611467205, 2339.356676913845, 2340.5435939991708, 2342.10999820069, 2341.1220792202926, 2357.622780355135, 2360.586897292967, 2362.244081893795, 2365.7870791628666, 9342.346035777498, 9346.579403926771, 9408.95295523518, 9409.811803763954, 9415.482148481831, 5414.269073675043, 5482.533984611313, 5500.4499550045075, 5511.724413779295, 5520.66875987438, 3317.1872891141584, 3326.367990081901, 3370.8482568798254, 3484.4947482615135, 3500.5799304083416, 1095.5508241620978, 1111.6331610568493, 1120.4509790202824, 1131.4569006876663, 1160.4719852467108, 13106.80339794904, 13253.337333133304, 13258.734825303536, 13310.267935263557, 13364.264965426897, 4814.614830813526, 4882.853514394574, 4917.975410122998, 4954.925676114861, 4986.276989836453, 10397.63608273722, 10410.531526081344, 10415.895841041644, 10423.478826058667, 10432.165426765841, 5672.886542269214, 5679.801206957736, 5680.602357834994, 5684.062129748628, 5686.5735069869925, 4657.8602641920115, 5108.897822043538, 5244.842654720364, 5249.685018898878, 5311.415744268127, 4076.3885417187657, 4094.6519545838937, 4120.484939382577, 4136.110736191733, 4143.854965076208, 1177.1936223686803, 1192.1237890150733, 1204.4098391788136, 1207.4144040140525, 1212.87871212878, 1009.1119814563137, 1033.6227277043824, 1034.896510348974, 1041.156663102889, 1062.4846949229618, 6153.538484613582, 6193.102000210034, 6198.876022479525, 6208.379162083756, 6347.904781428282, 470.21943573667545, 475.2728325661743, 478.09401184754694, 480.9110314591812, 490.5045903637352, 4255.148970205972, 4394.450693663292, 4430.579094985971, 4435.911281774346, 4462.482755863022, 11257.211995160424, 11444.484998175101, 11824.0, 11845.703857403634, 11851.0, 11628.53485860556, 11874.168808183344, 11981.221220620806, 11981.580644677395, 11992.460339284753, 8574.571271436404, 8749.256313213447, 8761.25529330014, 8766.693165739296, 8769.956150219208, 6218.31598524171, 6509.283978762238, 6641.33586641332, 6660.533762636569, 6767.458603311625, 10717.839232411676, 10959.780804384027, 11048.226624136234, 11048.392338421463, 11125.944370278097, 10851.782964340511, 11005.944970275097, 11118.722031948942, 11127.666170014912, 11148.331100133693, 7485.588292643957, 7809.453338266267, 7999.920000799918, 8273.669053237803, 8392.622331994953, 9169.35814492979, 9169.358144930058, 9234.0, 9245.167934885623, 9263.305252105984, 7760.18518055596, 7891.526508409514, 7895.526268423913, 7912.723054693058, 8014.118446970945, 7804.102528209329, 7879.409044321814, 7907.209279072047, 7992.560409177551, 8021.157778433414, 7292.197858235696, 7348.191698913222, 7375.11498620169, 7436.553806771611, 7440.404767618686, 5002.324686167321, 5005.524475174852, 5094.6688465249645, 5150.716710580804, 5205.6356055075785, 5368.0, 5368.973155134199, 5538.667679939216, 5543.556515478833, 5587.413321601336], "value": 4765.27184042185, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.0563863328621, 338.3655645664379, 340.8977306807957, 341.2526566818667, 344.1774159758178, 5198.0, 5303.522682958538, 5340.519353258206, 5361.919571206435, 5394.190871369301, 5299.735013249332, 5339.958708051931, 5342.171963345678, 5360.65983504124, 5380.192971054344, 4178.7283826551175, 4191.727537710054, 4193.308104162809, 4219.493660760713, 4226.260404429228, 3947.9802600986955, 3987.3620220764683, 4070.267351876661, 4195.874123776276, 4205.264078786216, 4147.979260103695, 4153.688473364495, 4165.250254954107, 4169.291220492523, 4178.101708132751, 4131.669466442678, 4162.708610397273, 4169.249535083683, 4182.351735481006, 4203.327467605169, 3618.7105031597407, 3639.363111455511, 3696.31618150643, 3707.8146092695256, 3717.7769333840056, 5137.845864624067, 5152.9484705152845, 5183.429822719498, 5192.376914770214, 5237.397699264558, 4829.903401931977, 4834.468208497063, 4845.588125009378, 4848.393950756155, 4881.560659540658, 5340.786368545254, 5564.33228012641, 5577.525910297589, 5593.860153496154, 5660.179274005246, 3970.602939706035, 3985.3822657488136, 4025.6715283956223, 4028.7582745035393, 4053.97973010136, 5711.914321285184, 5804.709764511757, 5836.737346819361, 5860.267466566722, 5865.970670146665, 4021.658159056513, 4083.959160408417, 4114.300568903293, 4125.23683118624, 4148.398482220061, 4145.694106356548, 4159.689697745201, 4162.2299874522705, 4162.2716024696165, 4172.7704976226, 4738.170820106537, 4739.218029025241, 4741.241401375763, 4743.620510359163, 4756.453007904066, 5582.27430434041, 5624.578156638268, 5645.765183462665, 5699.430056994351, 5709.885802284014, 1349.3590544491287, 1395.6092294157652, 1427.8933826284713, 1436.1454934314067, 1440.8126943497277, 897.3001059173855, 898.955052247385, 917.8393781088283, 918.260800055948, 934.3319526538558, 4740.862193073706, 4777.880552986134, 4794.376731024944, 4834.540718631724, 4857.854264372075, 5034.84895453137, 5056.836927506694, 5078.746062696924, 5107.642465027487, 5148.326793792033, 4774.7585627737035, 4791.928121078186, 4845.9757701211265, 4861.586765124934, 5018.372703412074, 3055.1903745507457, 3066.4633689104317, 3074.2775447769754, 3076.830804294354, 3085.4291955988215, 5963.880722385615, 5973.283206015306, 5980.863635909163, 6047.697615119315, 6062.575619706578, 5653.660780353192, 5904.498117660047, 5916.5858389913155, 5919.0, 5920.674362909996, 5920.940790592039, 5930.703464826827, 5943.10853371989, 5973.283206015219, 6006.519478441714, 5578.716895114066, 5756.942430575808, 5815.883682326415, 5846.210761547307, 5878.676672783038, 5740.225069615715, 5767.5385969121535, 5784.566157538117, 5784.855378615568, 5795.362510123968, 5965.403459654, 5994.430529099728, 6001.0, 6026.668533230714, 6073.453389194817, 4036.172584620087, 4133.669306455537, 4228.471441069866, 4251.660726871026, 4272.722273052242, 5600.803971860965, 5779.133130030361, 5786.161006654096, 5825.679587622722, 5826.805504871407, 5510.614257001971, 5601.719914004365, 5665.631733937281, 5737.971310143423, 5741.224934633771, 5601.663900166003, 5630.718464076862, 5638.126090455822, 5645.237892884572, 5663.292088488939, 5342.1986701993455, 5578.972105139448, 5602.579806514609, 5617.43825617435, 5626.368353177532, 5652.915206271827, 5695.772169113189, 5715.8856822864145, 5729.54163666914, 5746.5402767779315, 5443.0, 5570.0, 5582.441755824385, 5647.378788333198, 5648.5481161507805], "value": 4251.082635226109, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.3498196496909, 784.3764207455074, 845.8435189489945, 884.1644645809712, 884.5754038061729, 15101.395944162234, 15647.374105035813, 15647.84352156478, 15687.0, 16286.7556986645, 16160.0, 16273.837261627381, 16324.34702611897, 16332.83667163328, 16352.427665031726, 690.3131384272656, 811.1361400108894, 836.0761358698657, 840.9495430274172, 844.9535275559841, 837.1377481194379, 839.5927974932154, 842.759813453166, 843.0515669871395, 843.3716880923721, 889.7330800759779, 890.514669505118, 891.1355984694868, 891.4027601506973, 891.9821603567925, 723.8996724978031, 742.0649981023895, 743.2084829656426, 857.1171693156059, 874.9781255468632, 628.1802248066272, 634.109076747171, 635.9968200159016, 636.5893998371025, 637.1684951138762, 15248.313825877862, 15301.234938253043, 15320.540383788504, 15331.080135191813, 15336.0, 13485.0, 13789.724205515833, 13905.304734763322, 14100.224487653175, 14109.223992680398, 13267.86732132676, 13373.531926382628, 13406.932965335209, 13461.192328460324, 13487.258200798951, 4482.5965663090155, 4551.294549344857, 4559.338895860082, 4617.468991066037, 4721.291806229059, 63165.36834631687, 64251.67874160646, 64997.67501162511, 65304.67347663231, 65569.67215163942, 11188.720281992852, 11298.250147850258, 11305.434728263719, 11340.659780206606, 11433.1996760226, 20375.388738337875, 20402.591948160953, 20404.591908161754, 20409.89795051045, 20433.284835030703, 7961.283484486308, 7965.203479652105, 8107.067687215927, 8144.837103257902, 8238.711645092513, 4628.074385122922, 4663.836765713184, 4730.455997560256, 4737.881552961204, 4739.3838800955655, 3414.129397003748, 3488.5639295088113, 3520.3663340598937, 3522.295540891832, 3522.7710198836994, 644.5616980453243, 647.4464332995316, 672.7342699633617, 681.431005110738, 682.9487788415888, 633.762339122829, 721.1598487761698, 727.3708242370417, 773.9264769846856, 796.4942261663886, 9130.954345228363, 9738.028827270022, 9740.805183896424, 9781.608735650636, 9834.655787047419, 621.6114928169894, 658.2430205263889, 770.0989841885008, 774.2953911940108, 779.6530543907907, 4320.4804517681105, 4323.848665296762, 4388.670849686287, 4479.328100784843, 4495.505494395614, 72068.0, 72193.0, 75222.97324321007, 75751.62124189344, 76766.61616691992, 62424.0, 62948.37051629517, 63017.68491157515, 63122.36877631257, 63827.36172638307, 55275.723621381636, 55878.44121558814, 57769.42230577725, 57779.13331300034, 58857.70571147202, 10285.331453455501, 10368.637097701545, 10404.68785936423, 10435.94782026085, 10596.15230781551, 37300.0, 37941.81029094837, 38464.80767596144, 38494.615053850226, 39147.608523915536, 49472.50527494679, 51125.23312150395, 51668.0, 51822.74088629533, 52128.0, 12863.0, 12863.871361286267, 13033.674158145743, 13121.475140994253, 13247.40386682621, 14268.857311426753, 14407.42370305176, 15118.0, 15134.697306054037, 15154.014989025678, 13196.868031319947, 13631.0, 14011.60595401333, 14253.714925701635, 14393.712125757216, 13702.10936289138, 13749.243791591558, 14377.065490743069, 14578.635534111309, 14582.0, 13420.993425492932, 13425.664358390728, 13654.0, 13931.233782142079, 13933.58199254024, 11284.661460156209, 11481.311121332747, 11601.129915256559, 11712.648620541397, 12073.0, 10816.373427649241, 11691.356975366436, 11783.646490605295, 11793.941030294794, 12150.0], "value": 7256.024345803246, "unit": "score"}], "name": "dromaeo_css", "value": 7255.666261532383, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 104.0, 108.0, 108.0, 108.0, 109.0, 109.0, 109.0, 107.0, 108.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 154.0, 202.0, 128.0, 159.0, 158.0, 127.0, 177.0, 139.0], "value": 152.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 160.0, 159.0, 162.0, 162.0, 162.0, 161.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 144.0, 75.0, 74.0, 75.0, 74.0, 124.0, 73.0], "value": 86.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 144.0, 91.0, 92.0, 91.0, 136.0, 90.0, 91.0, 117.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 118.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 144.0, 146.0, 146.0, 145.0, 145.0, 144.0, 146.0, 146.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 56.0, 53.0, 55.0, 54.0, 54.0, 108.0, 53.0, 51.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 77.0, 84.0, 80.0, 78.0, 85.0, 77.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 121.0, 121.0, 116.0, 123.0, 120.0, 119.0, 127.0, 191.0, 124.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 156.0, 163.0, 161.0, 157.0, 160.0, 165.0, 160.0, 163.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 63.0, 62.0, 64.0, 62.0, 60.0, 63.0, 60.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1518.6000000000004, "alertThreshold": 2.0}]} 15:20:28 INFO - Return code: 0 15:20:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:20:29 ERROR - # TBPL SUCCESS # 15:20:29 INFO - Running post-action listener: _resource_record_post_action 15:20:29 INFO - ##### 15:20:29 INFO - ##### Finished run-tests step (success) 15:20:29 INFO - ##### 15:20:29 INFO - Running post-run listener: _resource_record_post_run 15:20:29 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 458752; Write bytes: 292737024; Read time: 160; Write time: 341172 15:20:29 INFO - TinderboxPrint: CPU usage
13.1% 15:20:29 INFO - TinderboxPrint: I/O read bytes / time
458,752 / 160 15:20:29 INFO - TinderboxPrint: I/O write bytes / time
292,737,024 / 341,172 15:20:29 INFO - TinderboxPrint: CPU idle
8,289.2 (86.9%) 15:20:29 INFO - TinderboxPrint: CPU user
1,200.6 (12.6%) 15:20:29 INFO - TinderboxPrint: Swap in / out
0 / 0 15:20:29 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5263360; Read time: 0; Write time: 756 15:20:29 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 458752; Write bytes: 287473664; Read time: 160; Write time: 340416 15:20:29 INFO - Running post-run listener: _upload_blobber_files 15:20:29 INFO - Blob upload gear active. 15:20:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:20:29 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 15:20:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:20:30 INFO - (blobuploader) - INFO - Open directory for files ... 15:20:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:20:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:20:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:20:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:20:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:20:35 INFO - (blobuploader) - INFO - Done attempting. 15:20:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:20:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:20:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:20:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:20:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:20:36 INFO - (blobuploader) - INFO - Done attempting. 15:20:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:20:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:20:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:20:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:20:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:20:37 INFO - (blobuploader) - INFO - Done attempting. 15:20:37 INFO - (blobuploader) - INFO - Iteration through files over. 15:20:37 INFO - Return code: 0 15:20:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:20:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:20:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0e48d216f19d1d3fc5885ff8d121e9b323b91de683b4fc6f296c7105b82f4a2e753329157f3090e9d3487df83606b21f7fe9fe42a75efcae9ff77f669d8ccfe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d9e41c89fe23997b2d47a8c29c85955cd627044419af8a574d09c1f5c92fa9784cb9f2d433ae7a184397573df521e3ed6accf782579a9173a1a42a925194a53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12a65ae51e240199a75129062f782dee6be8b2557c9b4b7421b85d761f6ed502fdf8f0273e4a0e5b8c7413f526a6ca12b0e63d3e8befd50823a70ea47fac1318"} 15:20:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:20:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:20:37 INFO - Contents: 15:20:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0e48d216f19d1d3fc5885ff8d121e9b323b91de683b4fc6f296c7105b82f4a2e753329157f3090e9d3487df83606b21f7fe9fe42a75efcae9ff77f669d8ccfe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d9e41c89fe23997b2d47a8c29c85955cd627044419af8a574d09c1f5c92fa9784cb9f2d433ae7a184397573df521e3ed6accf782579a9173a1a42a925194a53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12a65ae51e240199a75129062f782dee6be8b2557c9b4b7421b85d761f6ed502fdf8f0273e4a0e5b8c7413f526a6ca12b0e63d3e8befd50823a70ea47fac1318"} 15:20:37 INFO - Running post-run listener: copy_logs_to_upload_dir 15:20:37 INFO - Copying logs to upload dir... 15:20:37 INFO - mkdir: /builds/slave/test/build/upload/logs 15:20:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.398526 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-13 15:20:37.322200) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 15:20:37.325967) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475 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/sha512/d0e48d216f19d1d3fc5885ff8d121e9b323b91de683b4fc6f296c7105b82f4a2e753329157f3090e9d3487df83606b21f7fe9fe42a75efcae9ff77f669d8ccfe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d9e41c89fe23997b2d47a8c29c85955cd627044419af8a574d09c1f5c92fa9784cb9f2d433ae7a184397573df521e3ed6accf782579a9173a1a42a925194a53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12a65ae51e240199a75129062f782dee6be8b2557c9b4b7421b85d761f6ed502fdf8f0273e4a0e5b8c7413f526a6ca12b0e63d3e8befd50823a70ea47fac1318"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0e48d216f19d1d3fc5885ff8d121e9b323b91de683b4fc6f296c7105b82f4a2e753329157f3090e9d3487df83606b21f7fe9fe42a75efcae9ff77f669d8ccfe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d9e41c89fe23997b2d47a8c29c85955cd627044419af8a574d09c1f5c92fa9784cb9f2d433ae7a184397573df521e3ed6accf782579a9173a1a42a925194a53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12a65ae51e240199a75129062f782dee6be8b2557c9b4b7421b85d761f6ed502fdf8f0273e4a0e5b8c7413f526a6ca12b0e63d3e8befd50823a70ea47fac1318"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 15:20:37.352986) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 15:20:37.353520) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1463176799.40749-1152398475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 15:20:37.402569) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 15:20:37.402908) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 15:20:37.403232) ========= ========= Total master_lag: 0.23 =========