builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1468251858.08 results: success (0) buildid: 20160711072027 builduid: 8c0a39d96ea04c579e36446382b35903 revision: f9cae1b84fe26ada12aaa1ef08173948a6b54e83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.077830) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.078405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.078819) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.094919) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.095227) ========= 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=32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 08:44:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-07-11 08:44:18 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084402 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.193636) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.194023) ========= 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=32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014841 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.244492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.244845) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f9cae1b84fe26ada12aaa1ef08173948a6b54e83 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f9cae1b84fe26ada12aaa1ef08173948a6b54e83 --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=32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 08:44:18,835 truncating revision to first 12 chars 2016-07-11 08:44:18,835 Setting DEBUG logging. 2016-07-11 08:44:18,835 attempt 1/10 2016-07-11 08:44:18,835 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f9cae1b84fe2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 08:44:19,191 unpacking tar archive at: mozilla-central-f9cae1b84fe2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.732188 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.992846) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.993180) ========= script_repo_revision: f9cae1b84fe26ada12aaa1ef08173948a6b54e83 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.993629) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:18.993969) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 08:44:19.005034) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-11 08:44:19.005623) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:44:19 INFO - MultiFileLogger online at 20160711 08:44:19 in /builds/slave/test 08:44:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:44:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:44:19 INFO - {'append_to_log': False, 08:44:19 INFO - 'base_work_dir': '/builds/slave/test', 08:44:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:44:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:44:19 INFO - 'branch': 'Firefox-Non-PGO', 08:44:19 INFO - 'buildbot_json_path': 'buildprops.json', 08:44:19 INFO - 'config_files': ('talos/linux_config.py',), 08:44:19 INFO - 'default_actions': ('clobber', 08:44:19 INFO - 'read-buildbot-config', 08:44:19 INFO - 'download-and-extract', 08:44:19 INFO - 'populate-webroot', 08:44:19 INFO - 'create-virtualenv', 08:44:19 INFO - 'install', 08:44:19 INFO - 'run-tests'), 08:44:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:44:19 INFO - 'download_minidump_stackwalk': True, 08:44:19 INFO - 'download_symbols': 'ondemand', 08:44:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:44:19 INFO - 'tooltool.py': '/tools/tooltool.py', 08:44:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:44:19 INFO - '/tools/misc-python/virtualenv.py')}, 08:44:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:44:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:44:19 INFO - 'installer_path': 'installer.exe', 08:44:19 INFO - 'log_level': 'info', 08:44:19 INFO - 'log_name': 'talos', 08:44:19 INFO - 'log_to_console': True, 08:44:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:44:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:44:19 INFO - 'opt_config_files': (), 08:44:19 INFO - 'pip_index': False, 08:44:19 INFO - 'sps_profile': False, 08:44:19 INFO - 'sps_profile_interval': 0, 08:44:19 INFO - 'suite': 'dromaeojs', 08:44:19 INFO - 'system_bits': '32', 08:44:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:44:19 INFO - 'title': 'talos-linux64-ix-008', 08:44:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:44:19 INFO - 'use_talos_json': True, 08:44:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:44:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:44:19 INFO - 'work_dir': 'build'} 08:44:19 INFO - ##### 08:44:19 INFO - ##### Running clobber step. 08:44:19 INFO - ##### 08:44:19 INFO - Running pre-action listener: _resource_record_pre_action 08:44:19 INFO - Running main action method: clobber 08:44:19 INFO - rmtree: /builds/slave/test/build 08:44:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:44:20 INFO - Running post-action listener: _resource_record_post_action 08:44:20 INFO - ##### 08:44:20 INFO - ##### Finished clobber step (success) 08:44:20 INFO - ##### 08:44:20 INFO - ##### 08:44:20 INFO - ##### Running read-buildbot-config step. 08:44:20 INFO - ##### 08:44:20 INFO - Running pre-action listener: _resource_record_pre_action 08:44:20 INFO - Running main action method: read_buildbot_config 08:44:20 INFO - Using buildbot properties: 08:44:20 INFO - { 08:44:20 INFO - "project": "", 08:44:20 INFO - "product": "firefox", 08:44:20 INFO - "script_repo_revision": "production", 08:44:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:44:20 INFO - "repository": "", 08:44:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:44:20 INFO - "buildid": "20160711072027", 08:44:20 INFO - "pgo_build": "False", 08:44:20 INFO - "basedir": "/builds/slave/test", 08:44:20 INFO - "buildnumber": 551, 08:44:20 INFO - "slavename": "talos-linux64-ix-008", 08:44:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:44:20 INFO - "platform": "ubuntu64_hw", 08:44:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:44:20 INFO - "branch": "mozilla-central", 08:44:20 INFO - "repo_path": "mozilla-central", 08:44:20 INFO - "revision": "f9cae1b84fe26ada12aaa1ef08173948a6b54e83", 08:44:20 INFO - "stage_platform": "linux64", 08:44:20 INFO - "builduid": "8c0a39d96ea04c579e36446382b35903", 08:44:20 INFO - "slavebuilddir": "test" 08:44:20 INFO - } 08:44:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:44:20 INFO - Running post-action listener: _resource_record_post_action 08:44:20 INFO - ##### 08:44:20 INFO - ##### Finished read-buildbot-config step (success) 08:44:20 INFO - ##### 08:44:20 INFO - ##### 08:44:20 INFO - ##### Running download-and-extract step. 08:44:20 INFO - ##### 08:44:20 INFO - Running pre-action listener: _resource_record_pre_action 08:44:20 INFO - Running main action method: download_and_extract 08:44:20 INFO - mkdir: /builds/slave/test/build/tests 08:44: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')]} 08:44:20 INFO - https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:44:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:44:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:44:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:44:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:44:21 INFO - Downloaded 1361 bytes. 08:44:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:44:21 INFO - Using the following test package requirements: 08:44:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:44:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:44:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:44:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:21 INFO - u'jsshell-linux-x86_64.zip'], 08:44:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:44:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:44:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:44:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:44:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:44:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:44:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:44:21 INFO - https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:44:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:44:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:44:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:44:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:44:22 INFO - Downloaded 22735220 bytes. 08:44:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:44:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:44:23 INFO - Return code: 0 08:44:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:44: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')]} 08:44:23 INFO - https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:44:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:44:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:44:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:44:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:44:25 INFO - Downloaded 22735220 bytes. 08:44:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:44:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:44:26 INFO - Return code: 0 08:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:44:26 INFO - https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:44:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:44:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:44:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:44:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:44:28 INFO - Downloaded 14403333 bytes. 08:44:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:44:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:44:28 INFO - Return code: 0 08:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:44:28 INFO - https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:44:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:44:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:44:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:44:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:44:29 INFO - Downloaded 56658725 bytes. 08:44:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:44:29 INFO - mkdir: /builds/slave/test/properties 08:44:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:44:29 INFO - Writing to file /builds/slave/test/properties/build_url 08:44:29 INFO - Contents: 08:44:29 INFO - build_url:https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:44:30 INFO - Running post-action listener: _resource_record_post_action 08:44:30 INFO - Running post-action listener: set_extra_try_arguments 08:44:30 INFO - ##### 08:44:30 INFO - ##### Finished download-and-extract step (success) 08:44:30 INFO - ##### 08:44:30 INFO - ##### 08:44:30 INFO - ##### Running populate-webroot step. 08:44:30 INFO - ##### 08:44:30 INFO - Running pre-action listener: _resource_record_pre_action 08:44:30 INFO - Running main action method: populate_webroot 08:44:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:44:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:44:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:44:30 INFO - '--tppagecycles', 08:44:30 INFO - '7'], 08:44:30 INFO - 'tests': ['tsvgm']}}, 08:44:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:44:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:44:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:44:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:44:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:44:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:44:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:30 INFO - 'talos_options': ['--disable-e10s'], 08:44:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:30 INFO - 'talos_options': ['--disable-e10s'], 08:44:30 INFO - 'tests': ['damp', 'tps']}, 08:44:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:30 INFO - 'tests': ['damp', 'tps']}, 08:44:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:44:30 INFO - 'tests': ['dromaeo_dom']}, 08:44:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:44:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:44:30 INFO - 'tests': ['basic_compositor_video']}, 08:44:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:44:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:44:30 INFO - 'tests': ['a11yr', 08:44:30 INFO - 'ts_paint', 08:44:30 INFO - 'tpaint', 08:44:30 INFO - 'sessionrestore', 08:44:30 INFO - 'sessionrestore_no_auto_restore', 08:44:30 INFO - 'tabpaint']}, 08:44:30 INFO - 'other-e10s': {'tests': ['a11yr', 08:44:30 INFO - 'ts_paint', 08:44:30 INFO - 'tpaint', 08:44:30 INFO - 'sessionrestore', 08:44:30 INFO - 'sessionrestore_no_auto_restore', 08:44:30 INFO - 'tabpaint']}, 08:44:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:44:30 INFO - 'ts_paint', 08:44:30 INFO - 'tpaint', 08:44:30 INFO - 'sessionrestore', 08:44:30 INFO - 'sessionrestore_no_auto_restore', 08:44:30 INFO - 'tabpaint']}, 08:44:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:44:30 INFO - 'ts_paint', 08:44:30 INFO - 'tpaint', 08:44:30 INFO - 'sessionrestore', 08:44:30 INFO - 'sessionrestore_no_auto_restore', 08:44:30 INFO - 'tabpaint']}, 08:44:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:44:30 INFO - 'tests': ['a11yr', 08:44:30 INFO - 'ts_paint', 08:44:30 INFO - 'tpaint', 08:44:30 INFO - 'sessionrestore', 08:44:30 INFO - 'sessionrestore_no_auto_restore', 08:44:30 INFO - 'tabpaint']}, 08:44:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:44:30 INFO - 'tests': ['a11yr', 08:44:30 INFO - 'ts_paint', 08:44:30 INFO - 'tpaint', 08:44:30 INFO - 'sessionrestore', 08:44:30 INFO - 'sessionrestore_no_auto_restore', 08:44:30 INFO - 'tabpaint']}, 08:44:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:44:30 INFO - 'tests': ['tsvgx', 08:44:30 INFO - 'tsvgr_opacity', 08:44:30 INFO - 'tart', 08:44:30 INFO - 'tscrollx', 08:44:30 INFO - 'cart']}, 08:44:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:44:30 INFO - 'tsvgr_opacity', 08:44:30 INFO - 'tart', 08:44:30 INFO - 'tscrollx', 08:44:30 INFO - 'cart']}, 08:44:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:30 INFO - 'talos_options': ['--disable-e10s'], 08:44:30 INFO - 'tests': ['tp5o']}, 08:44:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:30 INFO - 'tests': ['tp5o']}, 08:44:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:30 INFO - 'talos_options': ['--disable-e10s', 08:44:30 INFO - '--xperf_path', 08:44:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:30 INFO - 'tests': ['tp5n']}, 08:44:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:30 INFO - 'talos_options': ['--xperf_path', 08:44:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:30 INFO - 'tests': ['tp5n']}}, 08:44:30 INFO - 'talos.zip': {'path': '', 08:44:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:44:30 INFO - Running post-action listener: _resource_record_post_action 08:44:30 INFO - ##### 08:44:30 INFO - ##### Finished populate-webroot step (success) 08:44:30 INFO - ##### 08:44:30 INFO - ##### 08:44:30 INFO - ##### Running create-virtualenv step. 08:44:30 INFO - ##### 08:44:30 INFO - Running pre-action listener: _resource_record_pre_action 08:44:30 INFO - Running main action method: create_virtualenv 08:44:30 INFO - Creating virtualenv /builds/slave/test/build/venv 08:44:30 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 08:44:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:44:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:44:30 INFO - Using real prefix '/usr' 08:44:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:44:31 INFO - Installing distribute.............................................................................................................................................................................................done. 08:44:33 INFO - Installing pip.................done. 08:44:33 INFO - Return code: 0 08:44:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:33 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 0x29f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb53b0>, '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 0x2cb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6740>, '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': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', '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 08:44:33 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 08:44:33 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 08:44:33 INFO - Using env: {'DISPLAY': ':0', 08:44:33 INFO - 'HOME': '/home/cltbld', 08:44:33 INFO - 'LANG': 'en_US.UTF-8', 08:44:33 INFO - 'LANGUAGE': 'en_US:en', 08:44:33 INFO - 'LOGNAME': 'cltbld', 08:44:33 INFO - 'MAIL': '/var/mail/cltbld', 08:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:33 INFO - 'MOZ_NO_REMOTE': '1', 08:44:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:33 INFO - 'NO_EM_RESTART': '1', 08:44:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:33 INFO - 'PWD': '/builds/slave/test', 08:44:33 INFO - 'SHELL': '/bin/bash', 08:44:33 INFO - 'SHLVL': '1', 08:44:33 INFO - 'TERM': 'linux', 08:44:33 INFO - 'TMOUT': '86400', 08:44:33 INFO - 'USER': 'cltbld', 08:44:33 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', 08:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:33 INFO - '_': '/tools/buildbot/bin/python'} 08:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:33 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 08:44:33 INFO - Cleaning up... 08:44:33 INFO - Return code: 0 08:44:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:33 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 0x29f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb53b0>, '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 0x2cb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6740>, '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': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', '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 08:44:33 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 08:44:33 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 08:44:33 INFO - Using env: {'DISPLAY': ':0', 08:44:33 INFO - 'HOME': '/home/cltbld', 08:44:33 INFO - 'LANG': 'en_US.UTF-8', 08:44:33 INFO - 'LANGUAGE': 'en_US:en', 08:44:33 INFO - 'LOGNAME': 'cltbld', 08:44:33 INFO - 'MAIL': '/var/mail/cltbld', 08:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:33 INFO - 'MOZ_NO_REMOTE': '1', 08:44:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:33 INFO - 'NO_EM_RESTART': '1', 08:44:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:33 INFO - 'PWD': '/builds/slave/test', 08:44:33 INFO - 'SHELL': '/bin/bash', 08:44:33 INFO - 'SHLVL': '1', 08:44:33 INFO - 'TERM': 'linux', 08:44:33 INFO - 'TMOUT': '86400', 08:44:33 INFO - 'USER': 'cltbld', 08:44:33 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', 08:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:33 INFO - '_': '/tools/buildbot/bin/python'} 08:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:33 INFO - Downloading/unpacking psutil>=3.1.1 08:44:33 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 08:44:33 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 08:44:33 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 08:44:33 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 08:44:33 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 08:44:33 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 08:44:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:44:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:35 INFO - Installing collected packages: psutil 08:44:35 INFO - Running setup.py install for psutil 08:44:35 INFO - building 'psutil._psutil_linux' extension 08:44:35 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 08:44:35 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 08:44:35 INFO - building 'psutil._psutil_posix' extension 08:44:35 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 08:44:36 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 08:44:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:36 INFO - Successfully installed psutil 08:44:36 INFO - Cleaning up... 08:44:36 INFO - Return code: 0 08:44:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:44:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb53b0>, '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 0x2cb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6740>, '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': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', '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 08:44:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:44:36 INFO - Using env: {'DISPLAY': ':0', 08:44:36 INFO - 'HOME': '/home/cltbld', 08:44:36 INFO - 'LANG': 'en_US.UTF-8', 08:44:36 INFO - 'LANGUAGE': 'en_US:en', 08:44:36 INFO - 'LOGNAME': 'cltbld', 08:44:36 INFO - 'MAIL': '/var/mail/cltbld', 08:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:36 INFO - 'MOZ_NO_REMOTE': '1', 08:44:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:36 INFO - 'NO_EM_RESTART': '1', 08:44:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:36 INFO - 'PWD': '/builds/slave/test', 08:44:36 INFO - 'SHELL': '/bin/bash', 08:44:36 INFO - 'SHLVL': '1', 08:44:36 INFO - 'TERM': 'linux', 08:44:36 INFO - 'TMOUT': '86400', 08:44:36 INFO - 'USER': 'cltbld', 08:44:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', 08:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:36 INFO - '_': '/tools/buildbot/bin/python'} 08:44:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:44:36 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 08:44:36 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 08:44:36 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 08:44:36 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 08:44:36 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 08:44:36 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 08:44:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:44:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:44:38 INFO - Installing collected packages: mozsystemmonitor 08:44:38 INFO - Running setup.py install for mozsystemmonitor 08:44:38 INFO - Successfully installed mozsystemmonitor 08:44:38 INFO - Cleaning up... 08:44:38 INFO - Return code: 0 08:44:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:44:38 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')]} 08:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:38 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')]} 08:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb53b0>, '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 0x2cb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6740>, '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': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', '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 08:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:44:38 INFO - Using env: {'DISPLAY': ':0', 08:44:38 INFO - 'HOME': '/home/cltbld', 08:44:38 INFO - 'LANG': 'en_US.UTF-8', 08:44:38 INFO - 'LANGUAGE': 'en_US:en', 08:44:38 INFO - 'LOGNAME': 'cltbld', 08:44:38 INFO - 'MAIL': '/var/mail/cltbld', 08:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:38 INFO - 'MOZ_NO_REMOTE': '1', 08:44:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:38 INFO - 'NO_EM_RESTART': '1', 08:44:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:38 INFO - 'PWD': '/builds/slave/test', 08:44:38 INFO - 'SHELL': '/bin/bash', 08:44:38 INFO - 'SHLVL': '1', 08:44:38 INFO - 'TERM': 'linux', 08:44:38 INFO - 'TMOUT': '86400', 08:44:38 INFO - 'USER': 'cltbld', 08:44:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', 08:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:38 INFO - '_': '/tools/buildbot/bin/python'} 08:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:38 INFO - Downloading/unpacking jsonschema==2.5.1 08:44:38 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 08:44:38 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 08:44:38 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 08:44:38 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 08:44:38 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 08:44:38 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 08:44:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:44:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:44:40 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 08:44:40 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 08:44:40 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 08:44:40 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 08:44:40 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 08:44:40 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 08:44:40 INFO - Downloading functools32-3.2.3-2.tar.gz 08:44:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:44:40 INFO - warning: no files found matching '*.txt' 08:44:40 INFO - no previously-included directories found matching 'build' 08:44:40 INFO - no previously-included directories found matching 'dist' 08:44:40 INFO - no previously-included directories found matching '.git*' 08:44:40 INFO - Installing collected packages: jsonschema, functools32 08:44:40 INFO - Running setup.py install for functools32 08:44:41 INFO - warning: no files found matching '*.txt' 08:44:41 INFO - no previously-included directories found matching 'build' 08:44:41 INFO - no previously-included directories found matching 'dist' 08:44:41 INFO - no previously-included directories found matching '.git*' 08:44:41 INFO - Successfully installed jsonschema functools32 08:44:41 INFO - Cleaning up... 08:44:41 INFO - Return code: 0 08:44:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:44:41 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')]} 08:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:41 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')]} 08:44:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:41 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 0x29f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb53b0>, '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 0x2cb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6740>, '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': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', '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 08:44:41 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 08:44:41 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 08:44:41 INFO - Using env: {'DISPLAY': ':0', 08:44:41 INFO - 'HOME': '/home/cltbld', 08:44:41 INFO - 'LANG': 'en_US.UTF-8', 08:44:41 INFO - 'LANGUAGE': 'en_US:en', 08:44:41 INFO - 'LOGNAME': 'cltbld', 08:44:41 INFO - 'MAIL': '/var/mail/cltbld', 08:44:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:41 INFO - 'MOZ_NO_REMOTE': '1', 08:44:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:41 INFO - 'NO_EM_RESTART': '1', 08:44:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:41 INFO - 'PWD': '/builds/slave/test', 08:44:41 INFO - 'SHELL': '/bin/bash', 08:44:41 INFO - 'SHLVL': '1', 08:44:41 INFO - 'TERM': 'linux', 08:44:41 INFO - 'TMOUT': '86400', 08:44:41 INFO - 'USER': 'cltbld', 08:44:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', 08:44:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:41 INFO - '_': '/tools/buildbot/bin/python'} 08:44:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:41 INFO - Downloading/unpacking blobuploader==1.2.4 08:44:41 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 08:44:41 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 08:44:41 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 08:44:41 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 08:44:41 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 08:44:41 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 08:44:43 INFO - Downloading blobuploader-1.2.4.tar.gz 08:44:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:44:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:44:43 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 08:44:43 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 08:44:43 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 08:44:43 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 08:44:43 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 08:44:43 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 08:44:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:44:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:44:43 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 08:44:43 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 08:44:43 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 08:44:43 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 08:44:43 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 08:44:43 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 08:44:44 INFO - Downloading docopt-0.6.1.tar.gz 08:44:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:44:44 INFO - Installing collected packages: blobuploader, requests, docopt 08:44:44 INFO - Running setup.py install for blobuploader 08:44:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:44:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:44:44 INFO - Running setup.py install for requests 08:44:44 INFO - Running setup.py install for docopt 08:44:44 INFO - Successfully installed blobuploader requests docopt 08:44:44 INFO - Cleaning up... 08:44:44 INFO - Return code: 0 08:44:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:44 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 0x29f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb53b0>, '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 0x2cb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6740>, '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': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', '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 08:44:44 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 08:44:44 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 08:44:44 INFO - Using env: {'DISPLAY': ':0', 08:44:44 INFO - 'HOME': '/home/cltbld', 08:44:44 INFO - 'LANG': 'en_US.UTF-8', 08:44:44 INFO - 'LANGUAGE': 'en_US:en', 08:44:44 INFO - 'LOGNAME': 'cltbld', 08:44:44 INFO - 'MAIL': '/var/mail/cltbld', 08:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:44 INFO - 'MOZ_NO_REMOTE': '1', 08:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:44 INFO - 'NO_EM_RESTART': '1', 08:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:44 INFO - 'PWD': '/builds/slave/test', 08:44:44 INFO - 'SHELL': '/bin/bash', 08:44:44 INFO - 'SHLVL': '1', 08:44:44 INFO - 'TERM': 'linux', 08:44:44 INFO - 'TMOUT': '86400', 08:44:44 INFO - 'USER': 'cltbld', 08:44:44 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', 08:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:44 INFO - '_': '/tools/buildbot/bin/python'} 08:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:44 INFO - Running setup.py (path:/tmp/pip-q2J9OV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:44 INFO - Running setup.py (path:/tmp/pip-G4_jDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:45 INFO - Running setup.py (path:/tmp/pip-UT36wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:45 INFO - Running setup.py (path:/tmp/pip-Gkg86k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:45 INFO - Running setup.py (path:/tmp/pip-zNgzxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:45 INFO - Running setup.py (path:/tmp/pip-BScIXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:45 INFO - Running setup.py (path:/tmp/pip-BxkmFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:45 INFO - Running setup.py (path:/tmp/pip-SHfFZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:45 INFO - Running setup.py (path:/tmp/pip-fokMJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:45 INFO - Running setup.py (path:/tmp/pip-zFD45h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:45 INFO - Running setup.py (path:/tmp/pip-iPUUBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:45 INFO - Running setup.py (path:/tmp/pip-_l9ZrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:45 INFO - Running setup.py (path:/tmp/pip-Ql7Z4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:45 INFO - Running setup.py (path:/tmp/pip-AxKv7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:45 INFO - Running setup.py (path:/tmp/pip-Z9cOWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:45 INFO - Running setup.py (path:/tmp/pip-r9L8l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:46 INFO - Running setup.py (path:/tmp/pip-hi3r3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:44:46 INFO - Running setup.py install for manifestparser 08:44:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:44:46 INFO - Running setup.py install for mozcrash 08:44:46 INFO - Running setup.py install for mozdebug 08:44:46 INFO - Running setup.py install for mozdevice 08:44:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:44:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:44:46 INFO - Running setup.py install for mozfile 08:44:46 INFO - Running setup.py install for mozhttpd 08:44:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:44:46 INFO - Running setup.py install for mozinfo 08:44:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:44:46 INFO - Running setup.py install for mozInstall 08:44:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:44:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:44:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:44:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:44:46 INFO - Running setup.py install for mozleak 08:44:47 INFO - Running setup.py install for mozlog 08:44:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:44:47 INFO - Running setup.py install for moznetwork 08:44:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:44:47 INFO - Running setup.py install for mozprocess 08:44:47 INFO - Running setup.py install for mozprofile 08:44:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:44:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:44:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:44:47 INFO - Running setup.py install for mozrunner 08:44:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:44:47 INFO - Running setup.py install for mozscreenshot 08:44:47 INFO - Running setup.py install for moztest 08:44:47 INFO - Running setup.py install for mozversion 08:44:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:44:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:44:47 INFO - Cleaning up... 08:44:47 INFO - Return code: 0 08:44:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:47 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 0x29f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb53b0>, '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 0x2cb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6740>, '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': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', '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 08:44:47 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 08:44:47 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 08:44:47 INFO - Using env: {'DISPLAY': ':0', 08:44:47 INFO - 'HOME': '/home/cltbld', 08:44:47 INFO - 'LANG': 'en_US.UTF-8', 08:44:47 INFO - 'LANGUAGE': 'en_US:en', 08:44:47 INFO - 'LOGNAME': 'cltbld', 08:44:47 INFO - 'MAIL': '/var/mail/cltbld', 08:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:47 INFO - 'MOZ_NO_REMOTE': '1', 08:44:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:47 INFO - 'NO_EM_RESTART': '1', 08:44:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:47 INFO - 'PWD': '/builds/slave/test', 08:44:47 INFO - 'SHELL': '/bin/bash', 08:44:47 INFO - 'SHLVL': '1', 08:44:47 INFO - 'TERM': 'linux', 08:44:47 INFO - 'TMOUT': '86400', 08:44:47 INFO - 'USER': 'cltbld', 08:44:47 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', 08:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:47 INFO - '_': '/tools/buildbot/bin/python'} 08:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:48 INFO - Running setup.py (path:/tmp/pip-RX8wt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:48 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)) 08:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:48 INFO - Running setup.py (path:/tmp/pip-sOdwIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:48 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)) 08:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:48 INFO - Running setup.py (path:/tmp/pip-JuET3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:48 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)) 08:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:48 INFO - Running setup.py (path:/tmp/pip-AqVnMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:48 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)) 08:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:48 INFO - Running setup.py (path:/tmp/pip-XUrvit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:48 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)) 08:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:48 INFO - Running setup.py (path:/tmp/pip-CHckph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:48 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)) 08:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:48 INFO - Running setup.py (path:/tmp/pip-rLOage-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:48 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)) 08:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:48 INFO - Running setup.py (path:/tmp/pip-FuJ8ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:48 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)) 08:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:48 INFO - Running setup.py (path:/tmp/pip-jAQa3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:48 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)) 08:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:48 INFO - Running setup.py (path:/tmp/pip-AovN79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:48 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)) 08:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:48 INFO - Running setup.py (path:/tmp/pip-j54GhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:48 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)) 08:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:48 INFO - Running setup.py (path:/tmp/pip-dvZtkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:49 INFO - Running setup.py (path:/tmp/pip-TmmGIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:49 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)) 08:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:49 INFO - Running setup.py (path:/tmp/pip-miFZzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:49 INFO - Running setup.py (path:/tmp/pip-SNd8rH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:49 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)) 08:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:49 INFO - Running setup.py (path:/tmp/pip-Sbp_Sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:49 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)) 08:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:49 INFO - Running setup.py (path:/tmp/pip-XrIGxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:49 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)) 08:44:49 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)) 08:44:49 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)) 08:44:49 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)) 08:44:49 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)) 08:44:49 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)) 08:44:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:44:49 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 08:44:49 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 08:44:49 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 08:44:49 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 08:44:49 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 08:44:49 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 08:44:51 INFO - Downloading blessings-1.6.tar.gz 08:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:44:51 INFO - Installing collected packages: blessings 08:44:51 INFO - Running setup.py install for blessings 08:44:51 INFO - Successfully installed blessings 08:44:51 INFO - Cleaning up... 08:44:51 INFO - Return code: 0 08:44:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:44:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:51 INFO - Reading from file tmpfile_stdout 08:44:51 INFO - Current package versions: 08:44:51 INFO - argparse == 1.2.1 08:44:51 INFO - blessings == 1.6 08:44:51 INFO - blobuploader == 1.2.4 08:44:51 INFO - docopt == 0.6.1 08:44:51 INFO - functools32 == 3.2.3-2 08:44:51 INFO - jsonschema == 2.5.1 08:44:51 INFO - manifestparser == 1.1 08:44:51 INFO - mozInstall == 1.12 08:44:51 INFO - mozcrash == 0.17 08:44:51 INFO - mozdebug == 0.1 08:44:51 INFO - mozdevice == 0.48 08:44:51 INFO - mozfile == 1.2 08:44:51 INFO - mozhttpd == 0.7 08:44:51 INFO - mozinfo == 0.9 08:44:51 INFO - mozleak == 0.1 08:44:51 INFO - mozlog == 3.2 08:44:51 INFO - moznetwork == 0.27 08:44:51 INFO - mozprocess == 0.23 08:44:51 INFO - mozprofile == 0.28 08:44:51 INFO - mozrunner == 6.12 08:44:51 INFO - mozscreenshot == 0.1 08:44:51 INFO - mozsystemmonitor == 0.3 08:44:51 INFO - moztest == 0.7 08:44:51 INFO - mozversion == 1.4 08:44:51 INFO - psutil == 3.1.1 08:44:51 INFO - requests == 1.2.3 08:44:51 INFO - wsgiref == 0.1.2 08:44:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:51 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')]} 08:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:51 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')]} 08:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:51 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 0x29f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb53b0>, '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 0x2cb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6740>, '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': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', '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 08:44:51 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 08:44:51 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 08:44:51 INFO - Using env: {'DISPLAY': ':0', 08:44:51 INFO - 'HOME': '/home/cltbld', 08:44:51 INFO - 'LANG': 'en_US.UTF-8', 08:44:51 INFO - 'LANGUAGE': 'en_US:en', 08:44:51 INFO - 'LOGNAME': 'cltbld', 08:44:51 INFO - 'MAIL': '/var/mail/cltbld', 08:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:51 INFO - 'MOZ_NO_REMOTE': '1', 08:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:51 INFO - 'NO_EM_RESTART': '1', 08:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:51 INFO - 'PWD': '/builds/slave/test', 08:44:51 INFO - 'SHELL': '/bin/bash', 08:44:51 INFO - 'SHLVL': '1', 08:44:51 INFO - 'TERM': 'linux', 08:44:51 INFO - 'TMOUT': '86400', 08:44:51 INFO - 'USER': 'cltbld', 08:44:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', 08:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:51 INFO - '_': '/tools/buildbot/bin/python'} 08:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:51 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)) 08:44:51 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)) 08:44:51 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)) 08:44:51 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)) 08:44:51 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)) 08:44:51 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)) 08:44:51 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)) 08:44:51 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)) 08:44:51 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)) 08:44:51 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)) 08:44:51 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)) 08:44:51 INFO - Cleaning up... 08:44:51 INFO - Return code: 0 08:44:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:44:51 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')]} 08:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:51 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')]} 08:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:51 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 0x29f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb53b0>, '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 0x2cb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6740>, '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': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', '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 08:44:51 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 08:44:51 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 08:44:51 INFO - Using env: {'DISPLAY': ':0', 08:44:51 INFO - 'HOME': '/home/cltbld', 08:44:51 INFO - 'LANG': 'en_US.UTF-8', 08:44:51 INFO - 'LANGUAGE': 'en_US:en', 08:44:51 INFO - 'LOGNAME': 'cltbld', 08:44:51 INFO - 'MAIL': '/var/mail/cltbld', 08:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:51 INFO - 'MOZ_NO_REMOTE': '1', 08:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:51 INFO - 'NO_EM_RESTART': '1', 08:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:51 INFO - 'PWD': '/builds/slave/test', 08:44:51 INFO - 'SHELL': '/bin/bash', 08:44:51 INFO - 'SHLVL': '1', 08:44:51 INFO - 'TERM': 'linux', 08:44:51 INFO - 'TMOUT': '86400', 08:44:51 INFO - 'USER': 'cltbld', 08:44:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', 08:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:51 INFO - '_': '/tools/buildbot/bin/python'} 08:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:44:52 INFO - Cleaning up... 08:44:52 INFO - Return code: 0 08:44:52 INFO - Running post-action listener: _resource_record_post_action 08:44:52 INFO - Running post-action listener: _start_resource_monitoring 08:44:52 INFO - Starting resource monitoring. 08:44:52 INFO - ##### 08:44:52 INFO - ##### Finished create-virtualenv step (success) 08:44:52 INFO - ##### 08:44:52 INFO - ##### 08:44:52 INFO - ##### Running install step. 08:44:52 INFO - ##### 08:44:52 INFO - Running pre-action listener: _resource_record_pre_action 08:44:52 INFO - Running main action method: install 08:44:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:52 INFO - Reading from file tmpfile_stdout 08:44:52 INFO - Detecting whether we're running mozinstall >=1.0... 08:44:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:44:52 INFO - Reading from file tmpfile_stdout 08:44:52 INFO - Output received: 08:44:52 INFO - Usage: mozinstall [options] installer 08:44:52 INFO - Options: 08:44:52 INFO - -h, --help show this help message and exit 08:44:52 INFO - -d DEST, --destination=DEST 08:44:52 INFO - Directory to install application into. [default: 08:44:52 INFO - "/builds/slave/test"] 08:44:52 INFO - --app=APP Application being installed. [default: firefox] 08:44:52 INFO - mkdir: /builds/slave/test/build/application 08:44:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:45:09 INFO - Reading from file tmpfile_stdout 08:45:09 INFO - Output received: 08:45:09 INFO - /builds/slave/test/build/application/firefox/firefox 08:45:09 INFO - Running post-action listener: _resource_record_post_action 08:45:09 INFO - ##### 08:45:09 INFO - ##### Finished install step (success) 08:45:09 INFO - ##### 08:45:09 INFO - ##### 08:45:09 INFO - ##### Running run-tests step. 08:45:09 INFO - ##### 08:45:09 INFO - Running pre-action listener: _resource_record_pre_action 08:45:09 INFO - Running main action method: run_tests 08:45:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:45:09 INFO - Python 2.7.3 08:45:09 INFO - Return code: 0 08:45:09 INFO - grabbing minidump binary from tooltool 08:45: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')]} 08:45:09 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 0x2cb53b0>, '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 0x2cb62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:45:09 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 08:45:09 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 08:45:09 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 08:45:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:45:09 INFO - Return code: 0 08:45:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:45:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:45:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:45:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:45:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:45:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 08:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 08:45:09 INFO - Using env: {'DISPLAY': ':0', 08:45:09 INFO - 'HOME': '/home/cltbld', 08:45:09 INFO - 'LANG': 'en_US.UTF-8', 08:45:09 INFO - 'LANGUAGE': 'en_US:en', 08:45:09 INFO - 'LOGNAME': 'cltbld', 08:45:09 INFO - 'MAIL': '/var/mail/cltbld', 08:45:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:45:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:09 INFO - 'MOZ_NO_REMOTE': '1', 08:45:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:45:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:09 INFO - 'NO_EM_RESTART': '1', 08:45:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:09 INFO - 'PWD': '/builds/slave/test', 08:45:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:45:09 INFO - 'SHELL': '/bin/bash', 08:45:09 INFO - 'SHLVL': '1', 08:45:09 INFO - 'TERM': 'linux', 08:45:09 INFO - 'TMOUT': '86400', 08:45:09 INFO - 'USER': 'cltbld', 08:45:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292', 08:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:09 INFO - '_': '/tools/buildbot/bin/python'} 08:45:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 08:45:09 INFO - mozversion application_buildid: 20160711072027 08:45:09 INFO - mozversion application_changeset: f9cae1b84fe26ada12aaa1ef08173948a6b54e83 08:45:09 INFO - mozversion application_display_name: Nightly 08:45:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:45:09 INFO - mozversion application_name: Firefox 08:45:09 INFO - mozversion application_remotingname: firefox 08:45:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:45:09 INFO - mozversion application_vendor: Mozilla 08:45:09 INFO - mozversion application_version: 50.0a1 08:45:09 INFO - mozversion platform_buildid: 20160711072027 08:45:09 INFO - mozversion platform_changeset: f9cae1b84fe26ada12aaa1ef08173948a6b54e83 08:45:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:45:09 INFO - mozversion platform_version: 50.0a1 08:45:09 INFO - using testdate: 1468251909 08:45:09 INFO - actual date: 1468251909 08:45:09 INFO - starting webserver on 'localhost:34976' 08:45:09 INFO - SUITE-START | Running 2 tests 08:45:09 INFO - TEST-START | dromaeo_css 08:45:09 INFO - operating with platform_type : linux_ 08:45:09 INFO - Initialising browser for dromaeo_css test... 08:45:09 INFO - TEST-INFO | started process 13732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX0J4En/profile http://localhost:34976/getInfo.html) 08:45:13 INFO - PROCESS | 13732 | __metrics Screen width/height:1600/1200 08:45:13 INFO - PROCESS | 13732 | colorDepth:24 08:45:13 INFO - PROCESS | 13732 | Browser inner width/height: 1024/697 08:45:13 INFO - PROCESS | 13732 | __metrics 08:45:14 INFO - PROCESS | 13732 | 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" 08:45:14 INFO - PROCESS | 13732 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:45:15 INFO - TEST-INFO | 13732: exit 0 08:45:15 INFO - Browser initialized. 08:45:15 INFO - Running cycle 1/1 for dromaeo_css test... 08:45:15 INFO - TEST-INFO | started process 13814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX0J4En/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:45:27 INFO - PROCESS | 13814 | RSS: Main: 158773248 08:45:27 INFO - PROCESS | 13814 | 08:46:19 INFO - PROCESS | 13814 | 1468251979283 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] 08:48:31 INFO - PROCESS | 13814 | Cycle 1(1): loaded http://localhost:34976/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34976/tests/dromaeo/cssquery-ext.html) 08:48:32 INFO - PROCESS | 13814 | RSS: Main: 257908736 08:48:32 INFO - PROCESS | 13814 | 08:51:34 INFO - PROCESS | 13814 | Cycle 1(1): loaded http://localhost:34976/tests/dromaeo/cssquery-ext.html (next: http://localhost:34976/tests/dromaeo/cssquery-jquery.html) 08:51:35 INFO - PROCESS | 13814 | RSS: Main: 241139712 08:51:35 INFO - PROCESS | 13814 | 08:54:37 INFO - PROCESS | 13814 | Cycle 1(1): loaded http://localhost:34976/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34976/tests/dromaeo/cssquery-mootools.html) 08:54:38 INFO - PROCESS | 13814 | RSS: Main: 246013952 08:54:38 INFO - PROCESS | 13814 | 08:57:40 INFO - PROCESS | 13814 | Cycle 1(1): loaded http://localhost:34976/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34976/tests/dromaeo/cssquery-prototype.html) 08:57:41 INFO - PROCESS | 13814 | RSS: Main: 234442752 08:57:41 INFO - PROCESS | 13814 | 09:00:44 INFO - PROCESS | 13814 | Cycle 1(1): loaded http://localhost:34976/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34976/tests/dromaeo/cssquery-yui.html) 09:00:44 INFO - PROCESS | 13814 | RSS: Main: 211365888 09:00:44 INFO - PROCESS | 13814 | 09:03:47 INFO - PROCESS | 13814 | Cycle 1(1): loaded http://localhost:34976/tests/dromaeo/cssquery-yui.html (next: http://localhost:34976/tests/dromaeo/cssquery-dojo.html) 09:03:47 INFO - PROCESS | 13814 | RSS: Main: 278257664 09:03:47 INFO - PROCESS | 13814 | 09:03:47 INFO - PROCESS | 13814 | __start_tp_report 09:03:47 INFO - PROCESS | 13814 | _x_x_mozilla_page_load 09:03:47 INFO - PROCESS | 13814 | _x_x_mozilla_page_load_details 09:03:47 INFO - PROCESS | 13814 | |i|pagename|runs| 09:03:47 INFO - PROCESS | 13814 | |0;dojo.html;2567.2811612748415;2576.0854896511737;2609.3085332386913;2617.6989646190696;2619.790416766659;4519.90960180797;4584.312353147029;4602.677812553118;4626.306054091888;4644.930326045112;4590.747508887018;4609.147307748069;4611.077784443108;4623.7919293631785;4661.5804577588015;4188.329867221245;4197.076643138505;4238.237117318881;4281.336392859112;4298.140371925611;4232.407462955189;4255.255330317197;4294.377315289281;4303.074838909633;4307.784610769465;4162.708610397273;4213.599708027732;4214.91570168598;4223.91552168958;4278.764667943262;4133.1940271647045;4163.812628431728;4194.098268872207;4196.349565817303;4196.748195108304;4169.478815148106;4171.97914010431;4174.791260436997;4211.389348544474;4215.894602634928;4534.478534968455;4559;4583.335416364608;4593.173228818811;4601.332806743037;4922.926156107661;4961.231009193581;4974.925376119361;4995.100881841304;5001.774920128603;4954.752262386903;5010.348654674905;5021.347224860745;5032.370953630796;5034.370703662043;4484.1031793641405;4520.751358675238;4572.588467037916;4635.513271106553;4691.601213896857;5039;5078.08594453002;5102.719350435687;5133.922991155136;5137.640365174477;4864.221724524059;4908.337374454474;4916.459189489154;4925.4335751388335;4926.58124059459;4843.564079232886;4871.951280487221;4909.852704418873;4951.653384263139;5006.07387633289;4913.582345500601;4917.901641967141;4942.258661200777;4945.752712364368;4946.480619534969;4872.6832755870755;4877.609791216694;4881.829135980294;4883.072216278967;4926.310316555685;4171.478565179353;4216.30430978885;4251.107267473803;4252.808623611883;4306.397104405386;3693.021349342426;3720.2931443025736;3723.0506220913494;3737.8131093445763;3769.2838360711376;4260.360945858146;4261.360795880642;4262.829486820555;4297.978510107492;4303.246931786987;4815.398075240595;4942.061008408391;4957.603391728653;4960.057589058068;5011.123053465629;4136.896577585524;4229.238737027365;4292.948227684237;4296.892577685583;4342.370356298319;4519.41247637805;4546.727196368162;4548.4541854977615;4548.749818759934;4601.792919318638;4662.7668616569035;4664.93002604968;4666.3700400445505;4670.252759558454;4689.43726752785;4787.664863459524;4873.049755297683;4926.926096108633;4929.038837426668;4939.5554400104165;4596.8161273548685;4620.861374158781;4624.838130665411;4635.096156249499;4668.766561671835;4628.259478483426;4746.596539294199;4764.190087685032;4780.11567859947;4824.252240902666;4855.344528488608;4902.068606964665;4911.533404326583;4921.606271498343;4927.507249275044;4722.220833562424;4723.149833030087;4738.976305118453;4747.335373047707;4767.76161191946;4617.284320930261;4689.835855745033;4744.78648460827;4756.619470442287;4807.375041244755;4669.60308373792;4680.251159814414;4708.8463326485235;4715.905681886412;4717.764111794328;4780.593649539828;4785.282207668738;4786.138495070921;4833.564979151753;4842.539958703917;4537.4328208973875;4638.512956139557;4638.814447422065;4683.437987441529;4683.8360657376825 09:03:47 INFO - PROCESS | 13814 | |1;ext.html;556.5809753962667;572.9799457019005;582.8251524542636;584.652131981471;597.2743117112709;39678;41255.96860078496;41258.38112428316;41432.171356572886;45070.549294507124;41692.79153604228;42153.36769948453;42197;42272.36591451123;42313.57686423135;7527.360174385184;7653.387728981668;7689.077310722721;7967.00412448444;8101.797455063612;7701.306882380584;9750.414975101517;9990.050945160197;10009.349392289514;10422.530986105643;10523.684289471328;10580.576776928914;10591.046805787477;10605.310654807452;10605.787884242349;7662.1571627120975;10122.139618132467;10166.796664066676;10174.186065114773;10437.373757574569;10326.896731032744;10409.739756506073;10414.062734353869;10414.531346089445;10418.68743937683;39400.408993864825;39929;39943.8002809987;39992.80003599993;40105;2815.6761972373233;2817.4224284021725;2826.053272153831;2870.8851645934137;2967.1988563087843;30023;30234.566483798928;30275.243118921982;30287;31271.374572508423;3480.216951185963;3491.284286721216;3519.542459480251;3545.592256890465;3592.4611308303965;271961;271994;272616;272720;273699.6315018432;32032.67967320297;47755.28367074497;48051.75974120177;48066.5193348062;48154;30415.847920760254;30617;30627.69372306293;30638;30660.386792264475;11600.825987610193;11681.824772628417;11687.298762074302;11734.70663233426;11734.882651173379;8364.790880228044;8872.157145071207;8968.820623587622;9212.907870921204;9244.630214791334;7707.922920770833;7763.340116090196;7793.220677932161;7811.414143939227;7823.687052517949;3056.5720799088144;3097.6282846058616;3107.5183346581316;3143.4813255812533;3170.3342298117655;870.4081224767219;887.3921363865772;900.0684291757999;941.8445956417252;983.2674657380297;28415;28685.713142868302;28876.27809304784;29392.412151756846;29510;903.1014140929817;960.673371053845;990.346371394876;1006.3911333643186;1033.3644808442752;14335.211563363906;14772.704545909022;14837.10977341363;15163;15167.848321516864;414213;418163;418280;418902;419095;46209.76895115503;47282;47351.05297894023;47505.762471188114;47600.761996189794;1031.5254982708038;1125.5947858770835;1139.3733446604501;1166.854143232096;1185.6383802940013;27796.30509237285;28986.710132899243;29000.41999159963;29670.703292967657;29984.85007574948;42267.57732422637;42400.78799606106;42420.57579424166;42455.15089698251;42745.78627106844;285225;287263;287505;288689;288728;22687.88656056709;24735.752642473344;25571.872140639178;25811.096611618505;26974.32564185911;38698;38959.2208155841;39238.80380598193;39640.80179599083;40374.798126009184;37224.62775372212;37272.44091338686;37469.4379584301;37928.051798704146;38077.238455231294;37031.44528320666;37473.2505349897;37487;37722.62277377191;37776.81111594424;32527.837360813046;32570.51144232791;32714;32999;33012.66987330096;30872;33640.1589960253;33700;33946.49080263847;33996.49005264873;24566.263012109666;24871.37821554403;25010.37474063163;25086.749132509172;25395.36511587225 09:03:47 INFO - PROCESS | 13814 | |2;jquery.html;342.31624067312265;362.7460777455781;370.32046195231743;370.5312779334143;387.0884068019813;13153.67115822105;16562;16974;17931.731024034616;17953.551161220978;15675.921620391882;16138.435154769586;17477.213525391355;17503.91248043761;17826.910865445654;4420.911581768362;4992.176290911995;5182.533571978521;5183.481651834805;5187.429382767892;5062.291279220912;5099.71951542665;5108.77010534525;5113.642045056848;5123.820666276681;4902.264660300965;5077.543021128097;5117.590592752589;5128.025675121715;5133.435322114565;5103.668261563005;5121.795128194868;5125.3080834087295;5128.640995130342;5129.820456284049;4561.7262964222255;4590.632749380042;4877.414710234759;4895.290182923492;4907.730074845882;12334.32161231132;12386.690332741664;12422.192557483735;14172.433102675881;21050.894745526326;1815.5279627296998;1825.2607693884;1844.6679597672548;1883.1243471785685;2374.25211058516;8991.325650576233;9030.45817250967;9212.631494740202;9488.620455181785;9522.190613797835;1648.6810551558824;1667.4164042585119;1774.609585891102;1804.7112462006148;1827.4791684370023;64874.67562662157;68342;69036.65481672609;69884.30115698879;71126.288737113;8725.52009639476;9392.8591071134;10052.849207261897;10069.395836249849;10101.69694909154;12739.745205096031;13660.453581856813;13662.863371366358;14044.227567483886;14105.576832695035;6403.359664033653;6758.290379510179;6793.184817821893;6875.759348422881;6879.2432832388395;5674.773009079673;6057.4851137653795;6285.465735412541;6441.5490915635455;6542.476601871934;4313.352997050468;4403.515613282536;4411.647068234533;4496.5503449655425;4504.369388285642;1823.4165067178376;1864.7389365488843;1866.132248504452;1871.5976065146058;1878.5585387433941;700.9859802804017;712.590260600157;773.6441237031029;840.5755093677653;914.7804526913493;16715.16424178786;16765.580860478585;17426.21582028812;17557.561060973323;17746.5563360917;769.9191584883619;851.9787005324793;853.4452605806275;865.4936861935712;870.525563567857;9295.163435290857;9873.60505579783;9878.851817222747;9879.654212102541;9961.80076398468;357940;359882;360620;363342;367052;78691.60654196692;79481;79522.6023869877;79553;79843.20156798357;876.1851478125277;877.3989816975393;895.6283142495921;897.2239013253488;899.1952202778607;14996.925015374853;15442.150681712614;15571.844281557493;15593.454229101926;15728.977616454893;32319;36640.816795916915;37651.43522847105;38417.80791096027;38889;49681;51751.74124129355;52447.21329180142;52544.737276313375;52717.736411317695;7324.304191101837;7348.52234604749;7422.925770742223;7495;7747.6513556891205;10774.46127693628;11154.55381784752;11355.091592672732;11614.883851161718;11642;9597.712068637951;9667.758306042406;9939.155171810477;10024.147947424259;10198.235132365251;8962.103789620985;9564.569594368131;9682.70951871445;9920.553575088994;10002.899971000197;9835.557399916877;9964.551595178089;10097.19222462216;10171.491425428847;10346.896531034594;7505.4746167767735;7512.511686740344;7591.620418978919;7616.961915190389;7645.6559454823555;8707.259882910024;9627.56675949598;9741.805163896825;9815.509224538888;9994.950025249827 09:03:47 INFO - PROCESS | 13814 | |3;mootools.html;1280.379016177154;1351.8918486521077;1415.9221242831647;1649.381481944271;1697.4822679082883;7166.749163779269;7555.471117021811;7629.42779291554;7629.961850190748;7634.122075961259;6358.61848289103;7170.247124051978;7418.2581741825925;7434.628268586576;7444.181140074601;2213.2806837777707;2245.3376254005107;2247.045005872506;2250.4148921280503;2251.3583628665833;1854.4900152458047;2167.6856855755905;2205.94485137872;2212.856164349312;2221.7444993825675;2123.4160605833363;2229.665550167472;2232.4530490029965;2239.261043855524;2242.8766417847014;2177.80399764022;2203.55928814237;2207.1612787140944;2210.1380461619983;2213.856099353553;2177.858439201447;2178.2485042660255;2182.6835108909277;2182.858114222586;2185.136870935987;7604.657790399446;7653.043369578802;7655.043119610049;7656.9617151914445;7660.846783064308;4370.2570563004365;4562.885927851797;4604.171249175147;4611.861644150647;4613.354130421743;2705.080272707269;2746.299693578145;2817.281593193743;2824.887004519817;2830.40561482089;905.9275257979411;914.2457472585144;921;922.8892532896028;932.128459890005;10016.399016058987;10024.19806415485;10051.145652619463;10055.095041446304;10062.64780732678;3977.7812220327583;4158.6673066154635;4207.537170911197;4263.616274535245;4274.7435153890865;8605.95697021511;8667.219950204511;8679.91320086791;8682.826343473094;8688;4648.140094082605;4648.465426475931;4654.837080702159;4663.067386522709;4664.906701866012;4172.937405938914;4227.788610569459;4233.661307095425;4239.788010599519;4240.088380998101;3667.5048868402423;3713.424419215026;3720.739548231652;3767.321882061255;3796.5823759386444;1070.373831308693;1166.1836714299855;1176.7293522489874;1180.6281021478208;1181.5273890443718;603.4810063345607;658.4271683635268;658.4337469775988;695.1449716848305;800.1318569352202;5048.242763585418;5221.66059206158;5226.451222621646;5237.240600113038;5280.894382112337;802.4222559756965;822.8683410654386;828.8963879515061;854.4104567848165;871.8430682477215;3374.983125084359;3483.198864261234;3486.7210623150086;3494.4758286257265;3507.2459421224557;9177.816443671223;9493.810123797486;9554.522273886418;9582.568784404719;9588.90411095894;9156.084391560791;9265.72202833916;9267;9477.952610237042;9506.667266645634;6093.811706717236;6767.492438067165;7037.824054398681;7054;7195.89206161908;5184.559312458483;5203.297554830049;5240.947590524046;5345.465453454779;5477.3427188737605;8460.111688272642;8597.140285971353;8603.655853765778;8610.225079742853;8618.52598107085;8625.525596092275;8644;8692.956535217283;8698.652053918026;8712.21590056898;6109.389061093855;6410.230772307353;6419.165508483868;6491.123698300669;6543.280239173592;7049.612271325126;7075.327843854826;7099.2190859006505;7115.53749006313;7118.679659415442;6390.680465976589;6391.201099862517;6453;6461.321561236003;6585.5719378240265;6318.9052164216655;6396.232452105777;6431.517636177399;6471.126397936218;6593.175853018372;5871.236739223874;5876.970615146897;5898.085796701518;5903.465099074186;5906.557008224315;4042.3734321180264;4096.795160241916;4117.300058989919;4174.186033723395;4191.874243772691;4049.7165198437006;4072.7963601820384;4088.182363527247;4126.649234814954;4186.6859985501815 09:03:47 INFO - PROCESS | 13814 | |4;prototype.html;295.20589613938506;299.9745021673156;301.5552060710452;303.71299122329395;306.77452072726555;4895;4915.901681966358;4919.262110683399;4928.802847886085;4967.925481117786;4826.3484429601995;4841.225403935371;4882.487338829425;4885.975570122153;4890.779914903829;3654.6162652921457;3754.3429899767566;3776.546814382264;3790.6209379062147;3799.525059367579;3693.778373297611;3794.848206071754;3837.3860182370827;3856.421536769493;3898.434726964588;3762.6425489578583;3804.5624753153324;3834.2906562285925;3846.7499612525235;3873.922521549567;3572.678458938708;3800.90497737556;3818.217265460574;3838.1556057667267;3846.9230615387673;3297.6207736110173;3309.3050459403553;3311.0563489405404;3318.9170270743184;3319.9502007469905;4743.620510359163;4748.857534273978;4753.595944344735;4759.452662943771;4825.517448255181;4301.440812694361;4306.726887565442;4313.28830742927;4328.891777705551;4330.051476835405;4832.879178020543;5077.543021128079;5080.831408775965;5084.415292241402;5105.2086926526445;3585.8565657373674;3596.2627661329366;3598.1364472526407;3601.2977469393477;3612.1692010837655;5067.5185857343495;5285.471452854761;5311.044012077825;5311.814086506954;5340.786368545254;3655.798931058764;3660.37773578487;3665.6884164846288;3665.8167091645846;3683.9447408288897;3682.6685598295744;3727.981360093182;3732.925341493209;3749.8687545935763;3761.1349389640536;4267.4025636410925;4267.4238977737605;4279.507856596531;4305.763183024964;4309.353596960418;4822.095272367395;5096.261042148942;5097.898042039138;5116.513931176532;5123;1288.1884412819863;1293.8512071111754;1295.799151131576;1295.9222446653232;1304.2262522968756;811.7240138352988;813.5281536708695;826.4710585225461;844.8648216285364;848.1518481518482;4358.891027724332;4493.5281795411665;4503.211937910853;4515.706479078849;4516.932246016312;5282.7622756976025;5284.625997240668;5286.577073834084;5293.100172970528;5321.600879934021;4444.400005999149;4468.123388176973;4484.215262329079;4486.59620634138;4547.317902314613;2653.243825509759;2785.4011387551773;2806.214260007201;2810.4660114578164;2828.137418087503;4905.877353066202;4943.146320129951;4947.950520494749;4950.900981980412;4952.331435256267;5208.166693329125;5377.946220537823;5378.865528361822;5408.296921400193;5424.918626220609;4881;4891.413030436371;4934.73002418877;4946.282788995575;4951.257311403318;5243.187305967581;5245.160774276097;5285.180796976475;5286.3392075990505;5291.523762861361;5050.646454748279;5125.564327032244;5171.586273098068;5197.298364720866;5222.817201397933;4920.48334924842;4923.975380123076;4937.580305674058;4938.1358262304675;4939.431965324034;3371.9494207587395;3387.356402283558;3388.2207092369385;3395.1342407685884;3405.335959487876;4675.883102922454;4704.600108990774;4710.222813235778;4722.740249286322;4902.509749025069;5050.898982020265;5066.594672426123;5085.821996230115;5091.694498330112;5092;5045.823396181116;5059.924101138412;5069.138246498178;5151.278820965143;5152.6650767699975;4836.637252206028;5021.623378246573;5028.64799464034;5065.442801291929;5074.797008119782;4839.854804355875;4974.975125124496;5153;5166.734150133241;5180.6891586504935;5002.774875130555;5022.773975171199;5040.773165207501;5045.924311135409;5048.343715316985 09:03:47 INFO - PROCESS | 13814 | |5;yui.html;604.6908146473959;636.2110982381845;650.9056186852904;718.9209186989431;723.9167495737988;11697.3566453845;12322.876771232284;12362.814557781629;12385.318807465586;13403.329833508335;12945.482180712785;13054.412551435184;13065.281409522473;13072.019598530102;13091.869081309183;622.0420552349376;751.1324420294568;780.8711562592165;801.4590151647615;805.9153788852174;793.9285464308211;805.4120492040814;806.0528878567688;806.4757907360233;806.8466991271669;841.5876220651867;842.3850589069982;844.9493030418164;847.2459511035183;847.7711018025129;641.4355367276789;800.3677095094868;825.529448214518;840.2941529115542;840.7309660908512;608.8751805879784;608.8903997280488;609.0559632569543;609.1684850179518;609.3358239518946;13696.452141914311;13725;13732.862671373257;13734.107283026571;13748.243846588533;12107.910288074116;12333.69165770854;12352.197107188003;12440.440180191914;12533.937330313382;10684.679459616224;10829.296095753829;10938.726531836688;11008;11143.108551315956;3999.340108882031;4024.3762216856435;4032.1330913853662;4035.3745169498775;4240.08838099807;59928.70035649794;60589.09116363258;60783.69608151931;62043;62178;7987.400944929153;8084.676612935535;8100.392470564731;8105.55419451924;8177.509349439053;15590.922045389927;15604.92197539005;15618.453354132778;15632.921835390978;17553.824461755474;6494.675266236669;6571.57284776488;6666.233383160901;6685.231198412245;6790.151231096113;3484.7909125452047;3541.1501239702284;3573.8213089345427;3584.139806446486;3646.398344273165;2701.594760785898;2801.957970630442;2805.8737356818992;2806.031918987946;2813.9015134470196;495.98016079357143;496.2704823908848;498.7456397237435;515.9045576568346;521.2780299285516;432.30830670926264;496.28782696830166;507.7359772918062;597.8923793717173;620.218524658933;8143.42995990275;8206.507609543447;8237;8429.620667069874;8457.80097174739;460.83640307690956;482.3632804697765;516.060769399689;516.1947362115112;589.7257775134583;3799.886003419902;4033.294173519681;4055.1484188320783;4105.220008198433;4193.1194449165405;88130.55934720414;93913;95152.52423737975;95317;95510;83644.58177709194;83735;84564.15435845686;84959;85175;74058.62970685112;74249;74546.62726686332;77295;77320;7665.540067595962;7727.884081738891;7818.491798033109;7826.0782707712115;7988.760337189894;29969.250768730082;35156;42471.301147954975;42972.57027429686;43476.565234347254;64116.35883641104;64928;64972;65071;65487;9746.463944483121;9782.119609234918;9891.208703303862;9944.403335799876;10089.798204036026;11332.433378331216;11368.772624547628;11437.793630598633;11669.708257293636;11750.588729394773;9943.254255930979;9956;10201.285909986229;10222.693319200436;10647.893521065;10112;10367.170626350025;10583.259171858204;10629.9468502657;11100.833487497855;10206.591736330463;10437.165026797686;10539.15686745074;10598.20513461478;10743.570257189938;8375.064153350282;8541.786455338666;8615.138486151585;8736.170063843925;9084.18242358191;8465.873011904949;8641.52471614042;8832;8924.419912705913;9139.908600914172 09:03:47 INFO - PROCESS | 13814 | __end_tp_report 09:03:47 INFO - PROCESS | 13814 | __start_cc_report 09:03:47 INFO - PROCESS | 13814 | _x_x_mozilla_cycle_collect,951 09:03:47 INFO - PROCESS | 13814 | __end_cc_report 09:03:47 INFO - PROCESS | 13814 | __startTimestamp1468253027651__endTimestamp 09:03:47 INFO - PROCESS | 13814 | 09:03:47 INFO - PROCESS | 13814 | ------- Summary: start ------- 09:03:47 INFO - PROCESS | 13814 | Number of tests: 6 09:03:47 INFO - PROCESS | 13814 | 09:03:47 INFO - PROCESS | 13814 | [#0] dojo.html Cycles:165 Average:4552.75 Median:4661.58 stddev:467.73 (10.0%) stddev-sans-first:442.48 09:03:47 INFO - PROCESS | 13814 | Values: 2567.3 2576.1 2609.3 2617.7 2619.8 4519.9 4584.3 4602.7 4626.3 4644.9 4590.7 4609.1 4611.1 4623.8 4661.6 4188.3 4197.1 4238.2 4281.3 4298.1 4232.4 4255.3 4294.4 4303.1 4307.8 4162.7 4213.6 4214.9 4223.9 4278.8 4133.2 4163.8 4194.1 4196.3 4196.7 4169.5 4172.0 4174.8 4211.4 4215.9 4534.5 4559.0 4583.3 4593.2 4601.3 4922.9 4961.2 4974.9 4995.1 5001.8 4954.8 5010.3 5021.3 5032.4 5034.4 4484.1 4520.8 4572.6 4635.5 4691.6 5039.0 5078.1 5102.7 5133.9 5137.6 4864.2 4908.3 4916.5 4925.4 4926.6 4843.6 4872.0 4909.9 4951.7 5006.1 4913.6 4917.9 4942.3 4945.8 4946.5 4872.7 4877.6 4881.8 4883.1 4926.3 4171.5 4216.3 4251.1 4252.8 4306.4 3693.0 3720.3 3723.1 3737.8 3769.3 4260.4 4261.4 4262.8 4298.0 4303.2 4815.4 4942.1 4957.6 4960.1 5011.1 4136.9 4229.2 4292.9 4296.9 4342.4 4519.4 4546.7 4548.5 4548.7 4601.8 4662.8 4664.9 4666.4 4670.3 4689.4 4787.7 4873.0 4926.9 4929.0 4939.6 4596.8 4620.9 4624.8 4635.1 4668.8 4628.3 4746.6 4764.2 4780.1 4824.3 4855.3 4902.1 4911.5 4921.6 4927.5 4722.2 4723.1 4739.0 4747.3 4767.8 4617.3 4689.8 4744.8 4756.6 4807.4 4669.6 4680.3 4708.8 4715.9 4717.8 4780.6 4785.3 4786.1 4833.6 4842.5 4537.4 4638.5 4638.8 4683.4 4683.8 09:03:47 INFO - PROCESS | 13814 | 09:03:47 INFO - PROCESS | 13814 | [#1] ext.html Cycles:180 Average:46947.48 Median:33670.08 stddev:87749.59 (260.6%) stddev-sans-first:87926.62 09:03:47 INFO - PROCESS | 13814 | Values: 556.6 573.0 582.8 584.7 597.3 39678.0 41256.0 41258.4 41432.2 45070.5 41692.8 42153.4 42197.0 42272.4 42313.6 7527.4 7653.4 7689.1 7967.0 8101.8 7701.3 9750.4 9990.1 10009.3 10422.5 10523.7 10580.6 10591.0 10605.3 10605.8 7662.2 10122.1 10166.8 10174.2 10437.4 10326.9 10409.7 10414.1 10414.5 10418.7 39400.4 39929.0 39943.8 39992.8 40105.0 2815.7 2817.4 2826.1 2870.9 2967.2 30023.0 30234.6 30275.2 30287.0 31271.4 3480.2 3491.3 3519.5 3545.6 3592.5 271961.0 271994.0 272616.0 272720.0 273699.6 32032.7 47755.3 48051.8 48066.5 48154.0 30415.8 30617.0 30627.7 30638.0 30660.4 11600.8 11681.8 11687.3 11734.7 11734.9 8364.8 8872.2 8968.8 9212.9 9244.6 7707.9 7763.3 7793.2 7811.4 7823.7 3056.6 3097.6 3107.5 3143.5 3170.3 870.4 887.4 900.1 941.8 983.3 28415.0 28685.7 28876.3 29392.4 29510.0 903.1 960.7 990.3 1006.4 1033.4 14335.2 14772.7 14837.1 15163.0 15167.8 414213.0 418163.0 418280.0 418902.0 419095.0 46209.8 47282.0 47351.1 47505.8 47600.8 1031.5 1125.6 1139.4 1166.9 1185.6 27796.3 28986.7 29000.4 29670.7 29984.9 42267.6 42400.8 42420.6 42455.2 42745.8 285225.0 287263.0 287505.0 288689.0 288728.0 22687.9 24735.8 25571.9 25811.1 26974.3 38698.0 38959.2 39238.8 39640.8 40374.8 37224.6 37272.4 37469.4 37928.1 38077.2 37031.4 37473.3 37487.0 37722.6 37776.8 32527.8 32570.5 32714.0 32999.0 33012.7 30872.0 33640.2 33700.0 33946.5 33996.5 24566.3 24871.4 25010.4 25086.7 25395.4 09:03:47 INFO - PROCESS | 13814 | 09:03:47 INFO - PROCESS | 13814 | [#2] jquery.html Cycles:180 Average:23272.13 Median:5101.69 stddev:60053.18 (1177.1%) stddev-sans-first:60196.97 09:03:47 INFO - PROCESS | 13814 | Values: 342.3 362.7 370.3 370.5 387.1 13153.7 16562.0 16974.0 17931.7 17953.6 15675.9 16138.4 17477.2 17503.9 17826.9 4420.9 4992.2 5182.5 5183.5 5187.4 5062.3 5099.7 5108.8 5113.6 5123.8 4902.3 5077.5 5117.6 5128.0 5133.4 5103.7 5121.8 5125.3 5128.6 5129.8 4561.7 4590.6 4877.4 4895.3 4907.7 12334.3 12386.7 12422.2 14172.4 21050.9 1815.5 1825.3 1844.7 1883.1 2374.3 8991.3 9030.5 9212.6 9488.6 9522.2 1648.7 1667.4 1774.6 1804.7 1827.5 64874.7 68342.0 69036.7 69884.3 71126.3 8725.5 9392.9 10052.8 10069.4 10101.7 12739.7 13660.5 13662.9 14044.2 14105.6 6403.4 6758.3 6793.2 6875.8 6879.2 5674.8 6057.5 6285.5 6441.5 6542.5 4313.4 4403.5 4411.6 4496.6 4504.4 1823.4 1864.7 1866.1 1871.6 1878.6 701.0 712.6 773.6 840.6 914.8 16715.2 16765.6 17426.2 17557.6 17746.6 769.9 852.0 853.4 865.5 870.5 9295.2 9873.6 9878.9 9879.7 9961.8 357940.0 359882.0 360620.0 363342.0 367052.0 78691.6 79481.0 79522.6 79553.0 79843.2 876.2 877.4 895.6 897.2 899.2 14996.9 15442.2 15571.8 15593.5 15729.0 32319.0 36640.8 37651.4 38417.8 38889.0 49681.0 51751.7 52447.2 52544.7 52717.7 7324.3 7348.5 7422.9 7495.0 7747.7 10774.5 11154.6 11355.1 11614.9 11642.0 9597.7 9667.8 9939.2 10024.1 10198.2 8962.1 9564.6 9682.7 9920.6 10002.9 9835.6 9964.6 10097.2 10171.5 10346.9 7505.5 7512.5 7591.6 7617.0 7645.7 8707.3 9627.6 9741.8 9815.5 9995.0 09:03:47 INFO - PROCESS | 13814 | 09:03:47 INFO - PROCESS | 13814 | [#3] mootools.html Cycles:180 Average:4960.43 Median:5239.09 stddev:2738.87 (52.3%) stddev-sans-first:2732.59 09:03:47 INFO - PROCESS | 13814 | Values: 1280.4 1351.9 1415.9 1649.4 1697.5 7166.7 7555.5 7629.4 7630.0 7634.1 6358.6 7170.2 7418.3 7434.6 7444.2 2213.3 2245.3 2247.0 2250.4 2251.4 1854.5 2167.7 2205.9 2212.9 2221.7 2123.4 2229.7 2232.5 2239.3 2242.9 2177.8 2203.6 2207.2 2210.1 2213.9 2177.9 2178.2 2182.7 2182.9 2185.1 7604.7 7653.0 7655.0 7657.0 7660.8 4370.3 4562.9 4604.2 4611.9 4613.4 2705.1 2746.3 2817.3 2824.9 2830.4 905.9 914.2 921.0 922.9 932.1 10016.4 10024.2 10051.1 10055.1 10062.6 3977.8 4158.7 4207.5 4263.6 4274.7 8606.0 8667.2 8679.9 8682.8 8688.0 4648.1 4648.5 4654.8 4663.1 4664.9 4172.9 4227.8 4233.7 4239.8 4240.1 3667.5 3713.4 3720.7 3767.3 3796.6 1070.4 1166.2 1176.7 1180.6 1181.5 603.5 658.4 658.4 695.1 800.1 5048.2 5221.7 5226.5 5237.2 5280.9 802.4 822.9 828.9 854.4 871.8 3375.0 3483.2 3486.7 3494.5 3507.2 9177.8 9493.8 9554.5 9582.6 9588.9 9156.1 9265.7 9267.0 9478.0 9506.7 6093.8 6767.5 7037.8 7054.0 7195.9 5184.6 5203.3 5240.9 5345.5 5477.3 8460.1 8597.1 8603.7 8610.2 8618.5 8625.5 8644.0 8693.0 8698.7 8712.2 6109.4 6410.2 6419.2 6491.1 6543.3 7049.6 7075.3 7099.2 7115.5 7118.7 6390.7 6391.2 6453.0 6461.3 6585.6 6318.9 6396.2 6431.5 6471.1 6593.2 5871.2 5877.0 5898.1 5903.5 5906.6 4042.4 4096.8 4117.3 4174.2 4191.9 4049.7 4072.8 4088.2 4126.6 4186.7 09:03:47 INFO - PROCESS | 13814 | 09:03:47 INFO - PROCESS | 13814 | [#4] prototype.html Cycles:180 Average:4206.42 Median:4829.61 stddev:1231.46 (25.5%) stddev-sans-first:1199.41 09:03:47 INFO - PROCESS | 13814 | Values: 295.2 300.0 301.6 303.7 306.8 4895.0 4915.9 4919.3 4928.8 4967.9 4826.3 4841.2 4882.5 4886.0 4890.8 3654.6 3754.3 3776.5 3790.6 3799.5 3693.8 3794.8 3837.4 3856.4 3898.4 3762.6 3804.6 3834.3 3846.7 3873.9 3572.7 3800.9 3818.2 3838.2 3846.9 3297.6 3309.3 3311.1 3318.9 3320.0 4743.6 4748.9 4753.6 4759.5 4825.5 4301.4 4306.7 4313.3 4328.9 4330.1 4832.9 5077.5 5080.8 5084.4 5105.2 3585.9 3596.3 3598.1 3601.3 3612.2 5067.5 5285.5 5311.0 5311.8 5340.8 3655.8 3660.4 3665.7 3665.8 3683.9 3682.7 3728.0 3732.9 3749.9 3761.1 4267.4 4267.4 4279.5 4305.8 4309.4 4822.1 5096.3 5097.9 5116.5 5123.0 1288.2 1293.9 1295.8 1295.9 1304.2 811.7 813.5 826.5 844.9 848.2 4358.9 4493.5 4503.2 4515.7 4516.9 5282.8 5284.6 5286.6 5293.1 5321.6 4444.4 4468.1 4484.2 4486.6 4547.3 2653.2 2785.4 2806.2 2810.5 2828.1 4905.9 4943.1 4948.0 4950.9 4952.3 5208.2 5377.9 5378.9 5408.3 5424.9 4881.0 4891.4 4934.7 4946.3 4951.3 5243.2 5245.2 5285.2 5286.3 5291.5 5050.6 5125.6 5171.6 5197.3 5222.8 4920.5 4924.0 4937.6 4938.1 4939.4 3371.9 3387.4 3388.2 3395.1 3405.3 4675.9 4704.6 4710.2 4722.7 4902.5 5050.9 5066.6 5085.8 5091.7 5092.0 5045.8 5059.9 5069.1 5151.3 5152.7 4836.6 5021.6 5028.6 5065.4 5074.8 4839.9 4975.0 5153.0 5166.7 5180.7 5002.8 5022.8 5040.8 5045.9 5048.3 09:03:47 INFO - PROCESS | 13814 | 09:03:47 INFO - PROCESS | 13814 | [#5] yui.html Cycles:180 Average:17173.91 Median:60686.39 stddev:25076.00 (41.3%) stddev-sans-first:25115.48 09:03:47 INFO - PROCESS | 13814 | Values: 604.7 636.2 650.9 718.9 723.9 11697.4 12322.9 12362.8 12385.3 13403.3 12945.5 13054.4 13065.3 13072.0 13091.9 622.0 751.1 780.9 801.5 805.9 793.9 805.4 806.1 806.5 806.8 841.6 842.4 844.9 847.2 847.8 641.4 800.4 825.5 840.3 840.7 608.9 608.9 609.1 609.2 609.3 13696.5 13725.0 13732.9 13734.1 13748.2 12107.9 12333.7 12352.2 12440.4 12533.9 10684.7 10829.3 10938.7 11008.0 11143.1 3999.3 4024.4 4032.1 4035.4 4240.1 59928.7 60589.1 60783.7 62043.0 62178.0 7987.4 8084.7 8100.4 8105.6 8177.5 15590.9 15604.9 15618.5 15632.9 17553.8 6494.7 6571.6 6666.2 6685.2 6790.2 3484.8 3541.2 3573.8 3584.1 3646.4 2701.6 2802.0 2805.9 2806.0 2813.9 496.0 496.3 498.7 515.9 521.3 432.3 496.3 507.7 597.9 620.2 8143.4 8206.5 8237.0 8429.6 8457.8 460.8 482.4 516.1 516.2 589.7 3799.9 4033.3 4055.1 4105.2 4193.1 88130.6 93913.0 95152.5 95317.0 95510.0 83644.6 83735.0 84564.2 84959.0 85175.0 74058.6 74249.0 74546.6 77295.0 77320.0 7665.5 7727.9 7818.5 7826.1 7988.8 29969.3 35156.0 42471.3 42972.6 43476.6 64116.4 64928.0 64972.0 65071.0 65487.0 9746.5 9782.1 9891.2 9944.4 10089.8 11332.4 11368.8 11437.8 11669.7 11750.6 9943.3 9956.0 10201.3 10222.7 10647.9 10112.0 10367.2 10583.3 10629.9 11100.8 10206.6 10437.2 10539.2 10598.2 10743.6 8375.1 8541.8 8615.1 8736.2 9084.2 8465.9 8641.5 8832.0 8924.4 9139.9 09:03:47 INFO - PROCESS | 13814 | -------- Summary: end -------- 09:03:47 INFO - PROCESS | 13814 | 09:03:48 INFO - TEST-INFO | 13814: exit 0 09:03:48 INFO - TEST-OK | dromaeo_css | took 1118617ms 09:03:48 INFO - TEST-START | kraken 09:03:48 INFO - operating with platform_type : linux_ 09:03:48 INFO - Initialising browser for kraken test... 09:03:48 INFO - TEST-INFO | started process 14000 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgXpg5E/profile http://localhost:34976/getInfo.html) 09:03:52 INFO - PROCESS | 14000 | __metrics Screen width/height:1600/1200 09:03:52 INFO - PROCESS | 14000 | colorDepth:24 09:03:52 INFO - PROCESS | 14000 | Browser inner width/height: 1024/697 09:03:52 INFO - PROCESS | 14000 | __metrics 09:03:53 INFO - PROCESS | 14000 | 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" 09:03:53 INFO - PROCESS | 14000 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:03:54 INFO - TEST-INFO | 14000: exit 0 09:03:54 INFO - Browser initialized. 09:03:54 INFO - Running cycle 1/1 for kraken test... 09:03:54 INFO - TEST-INFO | started process 14083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgXpg5E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:06 INFO - PROCESS | 14083 | RSS: Main: 158560256 09:04:06 INFO - PROCESS | 14083 | 09:04:09 INFO - PROCESS | 14083 | Cycle 1(1): loaded http://localhost:34976/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34976/tests/kraken/driver.html?testName=audio-beat-detection) 09:04:09 INFO - PROCESS | 14083 | RSS: Main: 217284608 09:04:09 INFO - PROCESS | 14083 | 09:04:12 INFO - PROCESS | 14083 | Cycle 1(1): loaded http://localhost:34976/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34976/tests/kraken/driver.html?testName=audio-dft) 09:04:13 INFO - PROCESS | 14083 | RSS: Main: 204464128 09:04:13 INFO - PROCESS | 14083 | 09:04:16 INFO - PROCESS | 14083 | Cycle 1(1): loaded http://localhost:34976/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34976/tests/kraken/driver.html?testName=audio-fft) 09:04:17 INFO - PROCESS | 14083 | RSS: Main: 270942208 09:04:17 INFO - PROCESS | 14083 | 09:04:19 INFO - PROCESS | 14083 | Cycle 1(1): loaded http://localhost:34976/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34976/tests/kraken/driver.html?testName=audio-oscillator) 09:04:20 INFO - PROCESS | 14083 | RSS: Main: 181915648 09:04:20 INFO - PROCESS | 14083 | 09:04:22 INFO - PROCESS | 14083 | Cycle 1(1): loaded http://localhost:34976/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34976/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:04:22 INFO - PROCESS | 14083 | RSS: Main: 186109952 09:04:22 INFO - PROCESS | 14083 | 09:04:26 INFO - PROCESS | 14083 | Cycle 1(1): loaded http://localhost:34976/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34976/tests/kraken/driver.html?testName=imaging-darkroom) 09:04:26 INFO - PROCESS | 14083 | RSS: Main: 221904896 09:04:26 INFO - PROCESS | 14083 | 09:04:30 INFO - PROCESS | 14083 | Cycle 1(1): loaded http://localhost:34976/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34976/tests/kraken/driver.html?testName=imaging-desaturate) 09:04:30 INFO - PROCESS | 14083 | RSS: Main: 217600000 09:04:30 INFO - PROCESS | 14083 | 09:04:33 INFO - PROCESS | 14083 | Cycle 1(1): loaded http://localhost:34976/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34976/tests/kraken/driver.html?testName=json-parse-financial) 09:04:34 INFO - PROCESS | 14083 | RSS: Main: 221233152 09:04:34 INFO - PROCESS | 14083 | 09:04:36 INFO - PROCESS | 14083 | Cycle 1(1): loaded http://localhost:34976/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34976/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:04:36 INFO - PROCESS | 14083 | RSS: Main: 205193216 09:04:36 INFO - PROCESS | 14083 | 09:04:38 INFO - PROCESS | 14083 | Cycle 1(1): loaded http://localhost:34976/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34976/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:04:39 INFO - PROCESS | 14083 | RSS: Main: 209924096 09:04:39 INFO - PROCESS | 14083 | 09:04:41 INFO - PROCESS | 14083 | Cycle 1(1): loaded http://localhost:34976/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34976/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:04:42 INFO - PROCESS | 14083 | RSS: Main: 209784832 09:04:42 INFO - PROCESS | 14083 | 09:04:44 INFO - PROCESS | 14083 | Cycle 1(1): loaded http://localhost:34976/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:04:45 INFO - PROCESS | 14083 | RSS: Main: 222916608 09:04:45 INFO - PROCESS | 14083 | 09:04:48 INFO - PROCESS | 14083 | Cycle 1(1): loaded http://localhost:34976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:04:48 INFO - PROCESS | 14083 | RSS: Main: 222158848 09:04:48 INFO - PROCESS | 14083 | 09:04:50 INFO - PROCESS | 14083 | Cycle 1(1): loaded http://localhost:34976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34976/tests/kraken/driver.html?testName=ai-astar) 09:04:50 INFO - PROCESS | 14083 | RSS: Main: 265416704 09:04:50 INFO - PROCESS | 14083 | 09:04:50 INFO - PROCESS | 14083 | __start_tp_report 09:04:50 INFO - PROCESS | 14083 | _x_x_mozilla_page_load 09:04:50 INFO - PROCESS | 14083 | _x_x_mozilla_page_load_details 09:04:50 INFO - PROCESS | 14083 | |i|pagename|runs| 09:04:50 INFO - PROCESS | 14083 | |0;ai-astar;105;115;115;113;113;115;113;114;115;113 09:04:50 INFO - PROCESS | 14083 | |1;audio-beat-detection;145;123;123;188;122;126;147;123;158;123 09:04:50 INFO - PROCESS | 14083 | |2;audio-dft;160;161;160;162;162;161;164;162;161;163 09:04:50 INFO - PROCESS | 14083 | |3;audio-fft;78;76;76;107;76;77;79;76;104;77 09:04:50 INFO - PROCESS | 14083 | |4;audio-oscillator;85;86;109;86;86;86;115;85;84;119 09:04:50 INFO - PROCESS | 14083 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;116;117;117 09:04:50 INFO - PROCESS | 14083 | |6;imaging-darkroom;146;146;146;146;147;146;146;147;147;147 09:04:50 INFO - PROCESS | 14083 | |7;imaging-desaturate;95;94;94;95;95;95;95;95;94;94 09:04:50 INFO - PROCESS | 14083 | |8;json-parse-financial;63;61;62;63;63;63;62;61;62;63 09:04:50 INFO - PROCESS | 14083 | |9;json-stringify-tinderbox;64;65;65;65;65;65;64;65;66;65 09:04:50 INFO - PROCESS | 14083 | |10;stanford-crypto-aes;86;82;78;77;78;77;80;81;78;79 09:04:50 INFO - PROCESS | 14083 | |11;stanford-crypto-ccm;138;128;135;130;127;143;128;129;172;128 09:04:50 INFO - PROCESS | 14083 | |12;stanford-crypto-pbkdf2;173;168;164;165;168;166;167;168;164;164 09:04:50 INFO - PROCESS | 14083 | |13;stanford-crypto-sha256-iterative;67;67;67;67;67;66;68;66;66;66 09:04:50 INFO - PROCESS | 14083 | __end_tp_report 09:04:50 INFO - PROCESS | 14083 | __start_cc_report 09:04:50 INFO - PROCESS | 14083 | _x_x_mozilla_cycle_collect,1912 09:04:50 INFO - PROCESS | 14083 | __end_cc_report 09:04:50 INFO - PROCESS | 14083 | __startTimestamp1468253090858__endTimestamp 09:04:50 INFO - PROCESS | 14083 | 09:04:50 INFO - PROCESS | 14083 | ------- Summary: start ------- 09:04:50 INFO - PROCESS | 14083 | Number of tests: 14 09:04:50 INFO - PROCESS | 14083 | 09:04:50 INFO - PROCESS | 14083 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.50 stddev:3.00 (2.6%) stddev-sans-first:1.00 09:04:50 INFO - PROCESS | 14083 | Values: 105.0 115.0 115.0 113.0 113.0 115.0 113.0 114.0 115.0 113.0 09:04:50 INFO - PROCESS | 14083 | 09:04:50 INFO - PROCESS | 14083 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:135.50 stddev:21.93 (16.2%) stddev-sans-first:23.11 09:04:50 INFO - PROCESS | 14083 | Values: 145.0 123.0 123.0 188.0 122.0 126.0 147.0 123.0 158.0 123.0 09:04:50 INFO - PROCESS | 14083 | 09:04:50 INFO - PROCESS | 14083 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.20 09:04:50 INFO - PROCESS | 14083 | Values: 160.0 161.0 160.0 162.0 162.0 161.0 164.0 162.0 161.0 163.0 09:04:50 INFO - PROCESS | 14083 | 09:04:50 INFO - PROCESS | 14083 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.50 stddev:12.13 (15.9%) stddev-sans-first:12.75 09:04:50 INFO - PROCESS | 14083 | Values: 78.0 76.0 76.0 107.0 76.0 77.0 79.0 76.0 104.0 77.0 09:04:50 INFO - PROCESS | 14083 | 09:04:50 INFO - PROCESS | 14083 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:85.50 stddev:14.18 (16.6%) stddev-sans-first:14.65 09:04:50 INFO - PROCESS | 14083 | Values: 85.0 86.0 109.0 86.0 86.0 86.0 115.0 85.0 84.0 119.0 09:04:50 INFO - PROCESS | 14083 | 09:04:50 INFO - PROCESS | 14083 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:04:50 INFO - PROCESS | 14083 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 09:04:50 INFO - PROCESS | 14083 | 09:04:50 INFO - PROCESS | 14083 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:04:50 INFO - PROCESS | 14083 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 147.0 147.0 09:04:50 INFO - PROCESS | 14083 | 09:04:50 INFO - PROCESS | 14083 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:04:50 INFO - PROCESS | 14083 | Values: 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 09:04:50 INFO - PROCESS | 14083 | 09:04:50 INFO - PROCESS | 14083 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 09:04:50 INFO - PROCESS | 14083 | Values: 63.0 61.0 62.0 63.0 63.0 63.0 62.0 61.0 62.0 63.0 09:04:50 INFO - PROCESS | 14083 | 09:04:50 INFO - PROCESS | 14083 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 09:04:50 INFO - PROCESS | 14083 | Values: 64.0 65.0 65.0 65.0 65.0 65.0 64.0 65.0 66.0 65.0 09:04:50 INFO - PROCESS | 14083 | 09:04:50 INFO - PROCESS | 14083 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.50 stddev:2.80 (3.5%) stddev-sans-first:1.76 09:04:50 INFO - PROCESS | 14083 | Values: 86.0 82.0 78.0 77.0 78.0 77.0 80.0 81.0 78.0 79.0 09:04:50 INFO - PROCESS | 14083 | 09:04:50 INFO - PROCESS | 14083 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:132.50 stddev:13.77 (10.4%) stddev-sans-first:14.59 09:04:50 INFO - PROCESS | 14083 | Values: 138.0 128.0 135.0 130.0 127.0 143.0 128.0 129.0 172.0 128.0 09:04:50 INFO - PROCESS | 14083 | 09:04:50 INFO - PROCESS | 14083 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:167.50 stddev:2.79 (1.7%) stddev-sans-first:1.80 09:04:50 INFO - PROCESS | 14083 | Values: 173.0 168.0 164.0 165.0 168.0 166.0 167.0 168.0 164.0 164.0 09:04:50 INFO - PROCESS | 14083 | 09:04:50 INFO - PROCESS | 14083 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 09:04:50 INFO - PROCESS | 14083 | Values: 67.0 67.0 67.0 67.0 67.0 66.0 68.0 66.0 66.0 66.0 09:04:50 INFO - PROCESS | 14083 | -------- Summary: end -------- 09:04:50 INFO - PROCESS | 14083 | 09:04:51 INFO - TEST-INFO | 14083: exit 0 09:04:51 INFO - TEST-OK | kraken | took 63408ms 09:04:51 INFO - SUITE-END | took 1182s 09:04:52 INFO - Completed test suite (00:19:42) 09:04:52 INFO - javascript benchmark 09:04:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2567.2811612748415, 2576.0854896511737, 2609.3085332386913, 2617.6989646190696, 2619.790416766659, 4519.90960180797, 4584.312353147029, 4602.677812553118, 4626.306054091888, 4644.930326045112, 4590.747508887018, 4609.147307748069, 4611.077784443108, 4623.7919293631785, 4661.5804577588015, 4188.329867221245, 4197.076643138505, 4238.237117318881, 4281.336392859112, 4298.140371925611, 4232.407462955189, 4255.255330317197, 4294.377315289281, 4303.074838909633, 4307.784610769465, 4162.708610397273, 4213.599708027732, 4214.91570168598, 4223.91552168958, 4278.764667943262, 4133.1940271647045, 4163.812628431728, 4194.098268872207, 4196.349565817303, 4196.748195108304, 4169.478815148106, 4171.97914010431, 4174.791260436997, 4211.389348544474, 4215.894602634928, 4534.478534968455, 4559.0, 4583.335416364608, 4593.173228818811, 4601.332806743037, 4922.926156107661, 4961.231009193581, 4974.925376119361, 4995.100881841304, 5001.774920128603, 4954.752262386903, 5010.348654674905, 5021.347224860745, 5032.370953630796, 5034.370703662043, 4484.1031793641405, 4520.751358675238, 4572.588467037916, 4635.513271106553, 4691.601213896857, 5039.0, 5078.08594453002, 5102.719350435687, 5133.922991155136, 5137.640365174477, 4864.221724524059, 4908.337374454474, 4916.459189489154, 4925.4335751388335, 4926.58124059459, 4843.564079232886, 4871.951280487221, 4909.852704418873, 4951.653384263139, 5006.07387633289, 4913.582345500601, 4917.901641967141, 4942.258661200777, 4945.752712364368, 4946.480619534969, 4872.6832755870755, 4877.609791216694, 4881.829135980294, 4883.072216278967, 4926.310316555685, 4171.478565179353, 4216.30430978885, 4251.107267473803, 4252.808623611883, 4306.397104405386, 3693.021349342426, 3720.2931443025736, 3723.0506220913494, 3737.8131093445763, 3769.2838360711376, 4260.360945858146, 4261.360795880642, 4262.829486820555, 4297.978510107492, 4303.246931786987, 4815.398075240595, 4942.061008408391, 4957.603391728653, 4960.057589058068, 5011.123053465629, 4136.896577585524, 4229.238737027365, 4292.948227684237, 4296.892577685583, 4342.370356298319, 4519.41247637805, 4546.727196368162, 4548.4541854977615, 4548.749818759934, 4601.792919318638, 4662.7668616569035, 4664.93002604968, 4666.3700400445505, 4670.252759558454, 4689.43726752785, 4787.664863459524, 4873.049755297683, 4926.926096108633, 4929.038837426668, 4939.5554400104165, 4596.8161273548685, 4620.861374158781, 4624.838130665411, 4635.096156249499, 4668.766561671835, 4628.259478483426, 4746.596539294199, 4764.190087685032, 4780.11567859947, 4824.252240902666, 4855.344528488608, 4902.068606964665, 4911.533404326583, 4921.606271498343, 4927.507249275044, 4722.220833562424, 4723.149833030087, 4738.976305118453, 4747.335373047707, 4767.76161191946, 4617.284320930261, 4689.835855745033, 4744.78648460827, 4756.619470442287, 4807.375041244755, 4669.60308373792, 4680.251159814414, 4708.8463326485235, 4715.905681886412, 4717.764111794328, 4780.593649539828, 4785.282207668738, 4786.138495070921, 4833.564979151753, 4842.539958703917, 4537.4328208973875, 4638.512956139557, 4638.814447422065, 4683.437987441529, 4683.8360657376825], "value": 4523.561802478611, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.5809753962667, 572.9799457019005, 582.8251524542636, 584.652131981471, 597.2743117112709, 39678.0, 41255.96860078496, 41258.38112428316, 41432.171356572886, 45070.549294507124, 41692.79153604228, 42153.36769948453, 42197.0, 42272.36591451123, 42313.57686423135, 7527.360174385184, 7653.387728981668, 7689.077310722721, 7967.00412448444, 8101.797455063612, 7701.306882380584, 9750.414975101517, 9990.050945160197, 10009.349392289514, 10422.530986105643, 10523.684289471328, 10580.576776928914, 10591.046805787477, 10605.310654807452, 10605.787884242349, 7662.1571627120975, 10122.139618132467, 10166.796664066676, 10174.186065114773, 10437.373757574569, 10326.896731032744, 10409.739756506073, 10414.062734353869, 10414.531346089445, 10418.68743937683, 39400.408993864825, 39929.0, 39943.8002809987, 39992.80003599993, 40105.0, 2815.6761972373233, 2817.4224284021725, 2826.053272153831, 2870.8851645934137, 2967.1988563087843, 30023.0, 30234.566483798928, 30275.243118921982, 30287.0, 31271.374572508423, 3480.216951185963, 3491.284286721216, 3519.542459480251, 3545.592256890465, 3592.4611308303965, 271961.0, 271994.0, 272616.0, 272720.0, 273699.6315018432, 32032.67967320297, 47755.28367074497, 48051.75974120177, 48066.5193348062, 48154.0, 30415.847920760254, 30617.0, 30627.69372306293, 30638.0, 30660.386792264475, 11600.825987610193, 11681.824772628417, 11687.298762074302, 11734.70663233426, 11734.882651173379, 8364.790880228044, 8872.157145071207, 8968.820623587622, 9212.907870921204, 9244.630214791334, 7707.922920770833, 7763.340116090196, 7793.220677932161, 7811.414143939227, 7823.687052517949, 3056.5720799088144, 3097.6282846058616, 3107.5183346581316, 3143.4813255812533, 3170.3342298117655, 870.4081224767219, 887.3921363865772, 900.0684291757999, 941.8445956417252, 983.2674657380297, 28415.0, 28685.713142868302, 28876.27809304784, 29392.412151756846, 29510.0, 903.1014140929817, 960.673371053845, 990.346371394876, 1006.3911333643186, 1033.3644808442752, 14335.211563363906, 14772.704545909022, 14837.10977341363, 15163.0, 15167.848321516864, 414213.0, 418163.0, 418280.0, 418902.0, 419095.0, 46209.76895115503, 47282.0, 47351.05297894023, 47505.762471188114, 47600.761996189794, 1031.5254982708038, 1125.5947858770835, 1139.3733446604501, 1166.854143232096, 1185.6383802940013, 27796.30509237285, 28986.710132899243, 29000.41999159963, 29670.703292967657, 29984.85007574948, 42267.57732422637, 42400.78799606106, 42420.57579424166, 42455.15089698251, 42745.78627106844, 285225.0, 287263.0, 287505.0, 288689.0, 288728.0, 22687.88656056709, 24735.752642473344, 25571.872140639178, 25811.096611618505, 26974.32564185911, 38698.0, 38959.2208155841, 39238.80380598193, 39640.80179599083, 40374.798126009184, 37224.62775372212, 37272.44091338686, 37469.4379584301, 37928.051798704146, 38077.238455231294, 37031.44528320666, 37473.2505349897, 37487.0, 37722.62277377191, 37776.81111594424, 32527.837360813046, 32570.51144232791, 32714.0, 32999.0, 33012.66987330096, 30872.0, 33640.1589960253, 33700.0, 33946.49080263847, 33996.49005264873, 24566.263012109666, 24871.37821554403, 25010.37474063163, 25086.749132509172, 25395.36511587225], "value": 16722.354371823378, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.31624067312265, 362.7460777455781, 370.32046195231743, 370.5312779334143, 387.0884068019813, 13153.67115822105, 16562.0, 16974.0, 17931.731024034616, 17953.551161220978, 15675.921620391882, 16138.435154769586, 17477.213525391355, 17503.91248043761, 17826.910865445654, 4420.911581768362, 4992.176290911995, 5182.533571978521, 5183.481651834805, 5187.429382767892, 5062.291279220912, 5099.71951542665, 5108.77010534525, 5113.642045056848, 5123.820666276681, 4902.264660300965, 5077.543021128097, 5117.590592752589, 5128.025675121715, 5133.435322114565, 5103.668261563005, 5121.795128194868, 5125.3080834087295, 5128.640995130342, 5129.820456284049, 4561.7262964222255, 4590.632749380042, 4877.414710234759, 4895.290182923492, 4907.730074845882, 12334.32161231132, 12386.690332741664, 12422.192557483735, 14172.433102675881, 21050.894745526326, 1815.5279627296998, 1825.2607693884, 1844.6679597672548, 1883.1243471785685, 2374.25211058516, 8991.325650576233, 9030.45817250967, 9212.631494740202, 9488.620455181785, 9522.190613797835, 1648.6810551558824, 1667.4164042585119, 1774.609585891102, 1804.7112462006148, 1827.4791684370023, 64874.67562662157, 68342.0, 69036.65481672609, 69884.30115698879, 71126.288737113, 8725.52009639476, 9392.8591071134, 10052.849207261897, 10069.395836249849, 10101.69694909154, 12739.745205096031, 13660.453581856813, 13662.863371366358, 14044.227567483886, 14105.576832695035, 6403.359664033653, 6758.290379510179, 6793.184817821893, 6875.759348422881, 6879.2432832388395, 5674.773009079673, 6057.4851137653795, 6285.465735412541, 6441.5490915635455, 6542.476601871934, 4313.352997050468, 4403.515613282536, 4411.647068234533, 4496.5503449655425, 4504.369388285642, 1823.4165067178376, 1864.7389365488843, 1866.132248504452, 1871.5976065146058, 1878.5585387433941, 700.9859802804017, 712.590260600157, 773.6441237031029, 840.5755093677653, 914.7804526913493, 16715.16424178786, 16765.580860478585, 17426.21582028812, 17557.561060973323, 17746.5563360917, 769.9191584883619, 851.9787005324793, 853.4452605806275, 865.4936861935712, 870.525563567857, 9295.163435290857, 9873.60505579783, 9878.851817222747, 9879.654212102541, 9961.80076398468, 357940.0, 359882.0, 360620.0, 363342.0, 367052.0, 78691.60654196692, 79481.0, 79522.6023869877, 79553.0, 79843.20156798357, 876.1851478125277, 877.3989816975393, 895.6283142495921, 897.2239013253488, 899.1952202778607, 14996.925015374853, 15442.150681712614, 15571.844281557493, 15593.454229101926, 15728.977616454893, 32319.0, 36640.816795916915, 37651.43522847105, 38417.80791096027, 38889.0, 49681.0, 51751.74124129355, 52447.21329180142, 52544.737276313375, 52717.736411317695, 7324.304191101837, 7348.52234604749, 7422.925770742223, 7495.0, 7747.6513556891205, 10774.46127693628, 11154.55381784752, 11355.091592672732, 11614.883851161718, 11642.0, 9597.712068637951, 9667.758306042406, 9939.155171810477, 10024.147947424259, 10198.235132365251, 8962.103789620985, 9564.569594368131, 9682.70951871445, 9920.553575088994, 10002.899971000197, 9835.557399916877, 9964.551595178089, 10097.19222462216, 10171.491425428847, 10346.896531034594, 7505.4746167767735, 7512.511686740344, 7591.620418978919, 7616.961915190389, 7645.6559454823555, 8707.259882910024, 9627.56675949598, 9741.805163896825, 9815.509224538888, 9994.950025249827], "value": 7922.710335850823, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.379016177154, 1351.8918486521077, 1415.9221242831647, 1649.381481944271, 1697.4822679082883, 7166.749163779269, 7555.471117021811, 7629.42779291554, 7629.961850190748, 7634.122075961259, 6358.61848289103, 7170.247124051978, 7418.2581741825925, 7434.628268586576, 7444.181140074601, 2213.2806837777707, 2245.3376254005107, 2247.045005872506, 2250.4148921280503, 2251.3583628665833, 1854.4900152458047, 2167.6856855755905, 2205.94485137872, 2212.856164349312, 2221.7444993825675, 2123.4160605833363, 2229.665550167472, 2232.4530490029965, 2239.261043855524, 2242.8766417847014, 2177.80399764022, 2203.55928814237, 2207.1612787140944, 2210.1380461619983, 2213.856099353553, 2177.858439201447, 2178.2485042660255, 2182.6835108909277, 2182.858114222586, 2185.136870935987, 7604.657790399446, 7653.043369578802, 7655.043119610049, 7656.9617151914445, 7660.846783064308, 4370.2570563004365, 4562.885927851797, 4604.171249175147, 4611.861644150647, 4613.354130421743, 2705.080272707269, 2746.299693578145, 2817.281593193743, 2824.887004519817, 2830.40561482089, 905.9275257979411, 914.2457472585144, 921.0, 922.8892532896028, 932.128459890005, 10016.399016058987, 10024.19806415485, 10051.145652619463, 10055.095041446304, 10062.64780732678, 3977.7812220327583, 4158.6673066154635, 4207.537170911197, 4263.616274535245, 4274.7435153890865, 8605.95697021511, 8667.219950204511, 8679.91320086791, 8682.826343473094, 8688.0, 4648.140094082605, 4648.465426475931, 4654.837080702159, 4663.067386522709, 4664.906701866012, 4172.937405938914, 4227.788610569459, 4233.661307095425, 4239.788010599519, 4240.088380998101, 3667.5048868402423, 3713.424419215026, 3720.739548231652, 3767.321882061255, 3796.5823759386444, 1070.373831308693, 1166.1836714299855, 1176.7293522489874, 1180.6281021478208, 1181.5273890443718, 603.4810063345607, 658.4271683635268, 658.4337469775988, 695.1449716848305, 800.1318569352202, 5048.242763585418, 5221.66059206158, 5226.451222621646, 5237.240600113038, 5280.894382112337, 802.4222559756965, 822.8683410654386, 828.8963879515061, 854.4104567848165, 871.8430682477215, 3374.983125084359, 3483.198864261234, 3486.7210623150086, 3494.4758286257265, 3507.2459421224557, 9177.816443671223, 9493.810123797486, 9554.522273886418, 9582.568784404719, 9588.90411095894, 9156.084391560791, 9265.72202833916, 9267.0, 9477.952610237042, 9506.667266645634, 6093.811706717236, 6767.492438067165, 7037.824054398681, 7054.0, 7195.89206161908, 5184.559312458483, 5203.297554830049, 5240.947590524046, 5345.465453454779, 5477.3427188737605, 8460.111688272642, 8597.140285971353, 8603.655853765778, 8610.225079742853, 8618.52598107085, 8625.525596092275, 8644.0, 8692.956535217283, 8698.652053918026, 8712.21590056898, 6109.389061093855, 6410.230772307353, 6419.165508483868, 6491.123698300669, 6543.280239173592, 7049.612271325126, 7075.327843854826, 7099.2190859006505, 7115.53749006313, 7118.679659415442, 6390.680465976589, 6391.201099862517, 6453.0, 6461.321561236003, 6585.5719378240265, 6318.9052164216655, 6396.232452105777, 6431.517636177399, 6471.126397936218, 6593.175853018372, 5871.236739223874, 5876.970615146897, 5898.085796701518, 5903.465099074186, 5906.557008224315, 4042.3734321180264, 4096.795160241916, 4117.300058989919, 4174.186033723395, 4191.874243772691, 4049.7165198437006, 4072.7963601820384, 4088.182363527247, 4126.649234814954, 4186.6859985501815], "value": 4009.662976634384, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.20589613938506, 299.9745021673156, 301.5552060710452, 303.71299122329395, 306.77452072726555, 4895.0, 4915.901681966358, 4919.262110683399, 4928.802847886085, 4967.925481117786, 4826.3484429601995, 4841.225403935371, 4882.487338829425, 4885.975570122153, 4890.779914903829, 3654.6162652921457, 3754.3429899767566, 3776.546814382264, 3790.6209379062147, 3799.525059367579, 3693.778373297611, 3794.848206071754, 3837.3860182370827, 3856.421536769493, 3898.434726964588, 3762.6425489578583, 3804.5624753153324, 3834.2906562285925, 3846.7499612525235, 3873.922521549567, 3572.678458938708, 3800.90497737556, 3818.217265460574, 3838.1556057667267, 3846.9230615387673, 3297.6207736110173, 3309.3050459403553, 3311.0563489405404, 3318.9170270743184, 3319.9502007469905, 4743.620510359163, 4748.857534273978, 4753.595944344735, 4759.452662943771, 4825.517448255181, 4301.440812694361, 4306.726887565442, 4313.28830742927, 4328.891777705551, 4330.051476835405, 4832.879178020543, 5077.543021128079, 5080.831408775965, 5084.415292241402, 5105.2086926526445, 3585.8565657373674, 3596.2627661329366, 3598.1364472526407, 3601.2977469393477, 3612.1692010837655, 5067.5185857343495, 5285.471452854761, 5311.044012077825, 5311.814086506954, 5340.786368545254, 3655.798931058764, 3660.37773578487, 3665.6884164846288, 3665.8167091645846, 3683.9447408288897, 3682.6685598295744, 3727.981360093182, 3732.925341493209, 3749.8687545935763, 3761.1349389640536, 4267.4025636410925, 4267.4238977737605, 4279.507856596531, 4305.763183024964, 4309.353596960418, 4822.095272367395, 5096.261042148942, 5097.898042039138, 5116.513931176532, 5123.0, 1288.1884412819863, 1293.8512071111754, 1295.799151131576, 1295.9222446653232, 1304.2262522968756, 811.7240138352988, 813.5281536708695, 826.4710585225461, 844.8648216285364, 848.1518481518482, 4358.891027724332, 4493.5281795411665, 4503.211937910853, 4515.706479078849, 4516.932246016312, 5282.7622756976025, 5284.625997240668, 5286.577073834084, 5293.100172970528, 5321.600879934021, 4444.400005999149, 4468.123388176973, 4484.215262329079, 4486.59620634138, 4547.317902314613, 2653.243825509759, 2785.4011387551773, 2806.214260007201, 2810.4660114578164, 2828.137418087503, 4905.877353066202, 4943.146320129951, 4947.950520494749, 4950.900981980412, 4952.331435256267, 5208.166693329125, 5377.946220537823, 5378.865528361822, 5408.296921400193, 5424.918626220609, 4881.0, 4891.413030436371, 4934.73002418877, 4946.282788995575, 4951.257311403318, 5243.187305967581, 5245.160774276097, 5285.180796976475, 5286.3392075990505, 5291.523762861361, 5050.646454748279, 5125.564327032244, 5171.586273098068, 5197.298364720866, 5222.817201397933, 4920.48334924842, 4923.975380123076, 4937.580305674058, 4938.1358262304675, 4939.431965324034, 3371.9494207587395, 3387.356402283558, 3388.2207092369385, 3395.1342407685884, 3405.335959487876, 4675.883102922454, 4704.600108990774, 4710.222813235778, 4722.740249286322, 4902.509749025069, 5050.898982020265, 5066.594672426123, 5085.821996230115, 5091.694498330112, 5092.0, 5045.823396181116, 5059.924101138412, 5069.138246498178, 5151.278820965143, 5152.6650767699975, 4836.637252206028, 5021.623378246573, 5028.64799464034, 5065.442801291929, 5074.797008119782, 4839.854804355875, 4974.975125124496, 5153.0, 5166.734150133241, 5180.6891586504935, 5002.774875130555, 5022.773975171199, 5040.773165207501, 5045.924311135409, 5048.343715316985], "value": 3813.5893319964484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.6908146473959, 636.2110982381845, 650.9056186852904, 718.9209186989431, 723.9167495737988, 11697.3566453845, 12322.876771232284, 12362.814557781629, 12385.318807465586, 13403.329833508335, 12945.482180712785, 13054.412551435184, 13065.281409522473, 13072.019598530102, 13091.869081309183, 622.0420552349376, 751.1324420294568, 780.8711562592165, 801.4590151647615, 805.9153788852174, 793.9285464308211, 805.4120492040814, 806.0528878567688, 806.4757907360233, 806.8466991271669, 841.5876220651867, 842.3850589069982, 844.9493030418164, 847.2459511035183, 847.7711018025129, 641.4355367276789, 800.3677095094868, 825.529448214518, 840.2941529115542, 840.7309660908512, 608.8751805879784, 608.8903997280488, 609.0559632569543, 609.1684850179518, 609.3358239518946, 13696.452141914311, 13725.0, 13732.862671373257, 13734.107283026571, 13748.243846588533, 12107.910288074116, 12333.69165770854, 12352.197107188003, 12440.440180191914, 12533.937330313382, 10684.679459616224, 10829.296095753829, 10938.726531836688, 11008.0, 11143.108551315956, 3999.340108882031, 4024.3762216856435, 4032.1330913853662, 4035.3745169498775, 4240.08838099807, 59928.70035649794, 60589.09116363258, 60783.69608151931, 62043.0, 62178.0, 7987.400944929153, 8084.676612935535, 8100.392470564731, 8105.55419451924, 8177.509349439053, 15590.922045389927, 15604.92197539005, 15618.453354132778, 15632.921835390978, 17553.824461755474, 6494.675266236669, 6571.57284776488, 6666.233383160901, 6685.231198412245, 6790.151231096113, 3484.7909125452047, 3541.1501239702284, 3573.8213089345427, 3584.139806446486, 3646.398344273165, 2701.594760785898, 2801.957970630442, 2805.8737356818992, 2806.031918987946, 2813.9015134470196, 495.98016079357143, 496.2704823908848, 498.7456397237435, 515.9045576568346, 521.2780299285516, 432.30830670926264, 496.28782696830166, 507.7359772918062, 597.8923793717173, 620.218524658933, 8143.42995990275, 8206.507609543447, 8237.0, 8429.620667069874, 8457.80097174739, 460.83640307690956, 482.3632804697765, 516.060769399689, 516.1947362115112, 589.7257775134583, 3799.886003419902, 4033.294173519681, 4055.1484188320783, 4105.220008198433, 4193.1194449165405, 88130.55934720414, 93913.0, 95152.52423737975, 95317.0, 95510.0, 83644.58177709194, 83735.0, 84564.15435845686, 84959.0, 85175.0, 74058.62970685112, 74249.0, 74546.62726686332, 77295.0, 77320.0, 7665.540067595962, 7727.884081738891, 7818.491798033109, 7826.0782707712115, 7988.760337189894, 29969.250768730082, 35156.0, 42471.301147954975, 42972.57027429686, 43476.565234347254, 64116.35883641104, 64928.0, 64972.0, 65071.0, 65487.0, 9746.463944483121, 9782.119609234918, 9891.208703303862, 9944.403335799876, 10089.798204036026, 11332.433378331216, 11368.772624547628, 11437.793630598633, 11669.708257293636, 11750.588729394773, 9943.254255930979, 9956.0, 10201.285909986229, 10222.693319200436, 10647.893521065, 10112.0, 10367.170626350025, 10583.259171858204, 10629.9468502657, 11100.833487497855, 10206.591736330463, 10437.165026797686, 10539.15686745074, 10598.20513461478, 10743.570257189938, 8375.064153350282, 8541.786455338666, 8615.138486151585, 8736.170063843925, 9084.18242358191, 8465.873011904949, 8641.52471614042, 8832.0, 8924.419912705913, 9139.908600914172], "value": 6289.155412336718, "unit": "score"}], "name": "dromaeo_css", "value": 6215.209467852205, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 115.0, 113.0, 113.0, 115.0, 113.0, 114.0, 115.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 123.0, 123.0, 188.0, 122.0, 126.0, 147.0, 123.0, 158.0, 123.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 162.0, 162.0, 161.0, 164.0, 162.0, 161.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 107.0, 76.0, 77.0, 79.0, 76.0, 104.0, 77.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 109.0, 86.0, 86.0, 86.0, 115.0, 85.0, 84.0, 119.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 62.0, 63.0, 63.0, 63.0, 62.0, 61.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 66.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 78.0, 77.0, 78.0, 77.0, 80.0, 81.0, 78.0, 79.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 128.0, 135.0, 130.0, 127.0, 143.0, 128.0, 129.0, 172.0, 128.0], "value": 135.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 168.0, 164.0, 165.0, 168.0, 166.0, 167.0, 168.0, 164.0, 164.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 68.0, 66.0, 66.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1523.0, "alertThreshold": 2.0}]} 09:04:52 INFO - Return code: 0 09:04:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:04:52 INFO - # TBPL SUCCESS # 09:04:52 INFO - Running post-action listener: _resource_record_post_action 09:04:52 INFO - ##### 09:04:52 INFO - ##### Finished run-tests step (success) 09:04:52 INFO - ##### 09:04:52 INFO - Running post-run listener: _resource_record_post_run 09:04:52 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551276544; Read time: 4; Write time: 664608 09:04:52 INFO - TinderboxPrint: CPU usage
13.0% 09:04:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 09:04:52 INFO - TinderboxPrint: I/O write bytes / time
551,276,544 / 664,608 09:04:52 INFO - TinderboxPrint: CPU idle
8,325.5 (87.0%) 09:04:52 INFO - TinderboxPrint: CPU user
1,201.3 (12.6%) 09:04:52 INFO - TinderboxPrint: Swap in / out
0 / 0 09:04:52 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 263249920; Read time: 0; Write time: 361572 09:04:52 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 288026624; Read time: 0; Write time: 303036 09:04:52 INFO - Running post-run listener: _upload_blobber_files 09:04:52 INFO - Blob upload gear active. 09:04:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:04:52 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 09:04:52 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:04:52 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:04:53 INFO - (blobuploader) - INFO - Open directory for files ... 09:04:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:04:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:04:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:57 INFO - (blobuploader) - INFO - Done attempting. 09:04:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:04:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:04:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:58 INFO - (blobuploader) - INFO - Done attempting. 09:04:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:04:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:04:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:59 INFO - (blobuploader) - INFO - Done attempting. 09:04:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:04:59 INFO - Return code: 0 09:04:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:04:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:04:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a89b003e5982731bafd1042d922cc4b04bdcbd1a7c986d436161102d13c56a2f399995b611945e145486c698d5c01435424001c8fef409323c0dafd0623e0822", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30a954c205af1ff516c580025a2eecb9c323ebdd1ec373be8de9523001c990a876eed6561396fdb3ba18526e0e57eed3cf2e13814355afb382a640a69751667c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea69f2db12ceb6d0f1a96666ff964aac971e2b116c4c1af9ddbcb8c528adf83128d8f628b3c1c04ab93f1087339d65abad4ac8ede08927fe92bc6209bfd0d2cd"} 09:04:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:04:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:04:59 INFO - Contents: 09:04:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a89b003e5982731bafd1042d922cc4b04bdcbd1a7c986d436161102d13c56a2f399995b611945e145486c698d5c01435424001c8fef409323c0dafd0623e0822", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30a954c205af1ff516c580025a2eecb9c323ebdd1ec373be8de9523001c990a876eed6561396fdb3ba18526e0e57eed3cf2e13814355afb382a640a69751667c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea69f2db12ceb6d0f1a96666ff964aac971e2b116c4c1af9ddbcb8c528adf83128d8f628b3c1c04ab93f1087339d65abad4ac8ede08927fe92bc6209bfd0d2cd"} 09:04:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:04:59 INFO - Copying logs to upload dir... 09:04:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:04:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.832884 ========= master_lag: 0.72 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-11 09:04:59.558487) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 09:04:59.565655) ========= 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=32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a89b003e5982731bafd1042d922cc4b04bdcbd1a7c986d436161102d13c56a2f399995b611945e145486c698d5c01435424001c8fef409323c0dafd0623e0822", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30a954c205af1ff516c580025a2eecb9c323ebdd1ec373be8de9523001c990a876eed6561396fdb3ba18526e0e57eed3cf2e13814355afb382a640a69751667c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea69f2db12ceb6d0f1a96666ff964aac971e2b116c4c1af9ddbcb8c528adf83128d8f628b3c1c04ab93f1087339d65abad4ac8ede08927fe92bc6209bfd0d2cd"} build_url:https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/VLWabnA-QkCE7X0clzdMpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a89b003e5982731bafd1042d922cc4b04bdcbd1a7c986d436161102d13c56a2f399995b611945e145486c698d5c01435424001c8fef409323c0dafd0623e0822", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30a954c205af1ff516c580025a2eecb9c323ebdd1ec373be8de9523001c990a876eed6561396fdb3ba18526e0e57eed3cf2e13814355afb382a640a69751667c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea69f2db12ceb6d0f1a96666ff964aac971e2b116c4c1af9ddbcb8c528adf83128d8f628b3c1c04ab93f1087339d65abad4ac8ede08927fe92bc6209bfd0d2cd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 09:04:59.590357) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 09:04:59.590653) ========= 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=32c5991c409366f7fec8a718000001d2-1468251723.332300-1637948292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 09:04:59.639828) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 09:04:59.640124) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 09:04:59.643429) ========= ========= Total master_lag: 0.84 =========