builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1468441201.31 results: success (0) buildid: 20160713123542 builduid: 53ce52e499ff445e9bf1958ef2a6c0fa revision: 006a4f4e68522332a36fd7eccd9664b73efae975 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 13:20:01.305782) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 13:20:01.306654) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 13:20:01.306943) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 13:20:01.354260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:20:01.354968) ========= 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=fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 13:20:01-- 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% 221M=0s 2016-07-13 13:20:01 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119685 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:20:01.489400) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:20:01.489743) ========= 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=fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014793 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:20:01.542528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:20:01.543108) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 006a4f4e68522332a36fd7eccd9664b73efae975 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 006a4f4e68522332a36fd7eccd9664b73efae975 --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=fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 13:20:01,984 truncating revision to first 12 chars 2016-07-13 13:20:01,984 Setting DEBUG logging. 2016-07-13 13:20:01,984 attempt 1/10 2016-07-13 13:20:01,984 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/006a4f4e6852?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 13:20:02,410 unpacking tar archive at: fx-team-006a4f4e6852/testing/mozharness/ program finished with exit code 0 elapsedTime=0.743359 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:20:02.304856) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 13:20:02.305175) ========= script_repo_revision: 006a4f4e68522332a36fd7eccd9664b73efae975 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 13:20:02.305646) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 13:20:02.305924) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 13:20:02.322988) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-13 13:20:02.323305) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:20:02 INFO - MultiFileLogger online at 20160713 13:20:02 in /builds/slave/test 13:20:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:20:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:20:02 INFO - {'append_to_log': False, 13:20:02 INFO - 'base_work_dir': '/builds/slave/test', 13:20:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:20:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:20:02 INFO - 'branch': 'Fx-Team-Non-PGO', 13:20:02 INFO - 'buildbot_json_path': 'buildprops.json', 13:20:02 INFO - 'config_files': ('talos/linux_config.py',), 13:20:02 INFO - 'default_actions': ('clobber', 13:20:02 INFO - 'read-buildbot-config', 13:20:02 INFO - 'download-and-extract', 13:20:02 INFO - 'populate-webroot', 13:20:02 INFO - 'create-virtualenv', 13:20:02 INFO - 'install', 13:20:02 INFO - 'run-tests'), 13:20:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:20:02 INFO - 'download_minidump_stackwalk': True, 13:20:02 INFO - 'download_symbols': 'ondemand', 13:20:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:20:02 INFO - 'tooltool.py': '/tools/tooltool.py', 13:20:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:20:02 INFO - '/tools/misc-python/virtualenv.py')}, 13:20:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:20:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:20:02 INFO - 'installer_path': 'installer.exe', 13:20:02 INFO - 'log_level': 'info', 13:20:02 INFO - 'log_name': 'talos', 13:20:02 INFO - 'log_to_console': True, 13:20:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:20:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:20:02 INFO - 'opt_config_files': (), 13:20:02 INFO - 'pip_index': False, 13:20:02 INFO - 'sps_profile': False, 13:20:02 INFO - 'sps_profile_interval': 0, 13:20:02 INFO - 'suite': 'dromaeojs', 13:20:02 INFO - 'system_bits': '32', 13:20:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:20:02 INFO - 'title': 'talos-linux64-ix-048', 13:20:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:20:02 INFO - 'use_talos_json': True, 13:20:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:20:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:20:02 INFO - 'work_dir': 'build'} 13:20:02 INFO - ##### 13:20:02 INFO - ##### Running clobber step. 13:20:02 INFO - ##### 13:20:02 INFO - Running pre-action listener: _resource_record_pre_action 13:20:02 INFO - Running main action method: clobber 13:20:02 INFO - rmtree: /builds/slave/test/build 13:20:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:20:03 INFO - Running post-action listener: _resource_record_post_action 13:20:03 INFO - ##### 13:20:03 INFO - ##### Finished clobber step (success) 13:20:03 INFO - ##### 13:20:03 INFO - ##### 13:20:03 INFO - ##### Running read-buildbot-config step. 13:20:03 INFO - ##### 13:20:03 INFO - Running pre-action listener: _resource_record_pre_action 13:20:03 INFO - Running main action method: read_buildbot_config 13:20:03 INFO - Using buildbot properties: 13:20:03 INFO - { 13:20:03 INFO - "project": "", 13:20:03 INFO - "product": "firefox", 13:20:03 INFO - "script_repo_revision": "production", 13:20:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:20:03 INFO - "repository": "", 13:20:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:20:03 INFO - "buildid": "20160713123542", 13:20:03 INFO - "pgo_build": "False", 13:20:03 INFO - "basedir": "/builds/slave/test", 13:20:03 INFO - "buildnumber": 1989, 13:20:03 INFO - "slavename": "talos-linux64-ix-048", 13:20:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:20:03 INFO - "platform": "ubuntu64_hw", 13:20:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:20:03 INFO - "branch": "fx-team", 13:20:03 INFO - "repo_path": "integration/fx-team", 13:20:03 INFO - "revision": "006a4f4e68522332a36fd7eccd9664b73efae975", 13:20:03 INFO - "stage_platform": "linux64", 13:20:03 INFO - "builduid": "53ce52e499ff445e9bf1958ef2a6c0fa", 13:20:03 INFO - "slavebuilddir": "test" 13:20:03 INFO - } 13:20:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:20:03 INFO - Running post-action listener: _resource_record_post_action 13:20:03 INFO - ##### 13:20:03 INFO - ##### Finished read-buildbot-config step (success) 13:20:03 INFO - ##### 13:20:03 INFO - ##### 13:20:03 INFO - ##### Running download-and-extract step. 13:20:03 INFO - ##### 13:20:03 INFO - Running pre-action listener: _resource_record_pre_action 13:20:03 INFO - Running main action method: download_and_extract 13:20:03 INFO - mkdir: /builds/slave/test/build/tests 13:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:20:03 INFO - https://queue.taskcluster.net/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:20:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:20:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:20:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/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 13:20:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/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 13:20:05 INFO - Downloaded 1361 bytes. 13:20:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:20:05 INFO - Using the following test package requirements: 13:20:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:20:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:20:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:20:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:05 INFO - u'jsshell-linux-x86_64.zip'], 13:20:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:20:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:20:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:20:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:20:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:20:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:20:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:20:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:20:05 INFO - https://queue.taskcluster.net/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:20:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:20:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:20:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/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 13:20:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/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 13:20:07 INFO - Downloaded 22755434 bytes. 13:20:07 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'] 13:20:07 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 13:20:08 INFO - Return code: 0 13:20:08 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 13:20:08 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')]} 13:20:08 INFO - https://queue.taskcluster.net/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:20:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:20:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:20:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/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 13:20:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/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 13:20:10 INFO - Downloaded 22755434 bytes. 13:20:10 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'] 13:20:10 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 13:20:12 INFO - Return code: 0 13:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:20:12 INFO - https://queue.taskcluster.net/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:20:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:20:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:20:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/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 13:20:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/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 13:20:13 INFO - Downloaded 14403317 bytes. 13:20:13 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'] 13:20:13 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 13:20:13 INFO - Return code: 0 13:20:13 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')]} 13:20:13 INFO - https://queue.taskcluster.net/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:20:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:20:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:20:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/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 13:20:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/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 13:20:15 INFO - Downloaded 57041566 bytes. 13:20:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:20:15 INFO - mkdir: /builds/slave/test/properties 13:20:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:20:15 INFO - Writing to file /builds/slave/test/properties/build_url 13:20:15 INFO - Contents: 13:20:15 INFO - build_url:https://queue.taskcluster.net/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:20:16 INFO - Running post-action listener: _resource_record_post_action 13:20:16 INFO - Running post-action listener: set_extra_try_arguments 13:20:16 INFO - ##### 13:20:16 INFO - ##### Finished download-and-extract step (success) 13:20:16 INFO - ##### 13:20:16 INFO - ##### 13:20:16 INFO - ##### Running populate-webroot step. 13:20:16 INFO - ##### 13:20:16 INFO - Running pre-action listener: _resource_record_pre_action 13:20:16 INFO - Running main action method: populate_webroot 13:20:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:20:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:20:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:20:16 INFO - '--tppagecycles', 13:20:16 INFO - '7'], 13:20:16 INFO - 'tests': ['tsvgm']}}, 13:20:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:20:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:20:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:20:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:20:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:20:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:20:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:16 INFO - 'talos_options': ['--disable-e10s'], 13:20:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:20:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:20:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:16 INFO - 'talos_options': ['--disable-e10s'], 13:20:16 INFO - 'tests': ['damp', 'tps']}, 13:20:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:16 INFO - 'tests': ['damp', 'tps']}, 13:20:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:20:16 INFO - 'tests': ['dromaeo_dom']}, 13:20:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:20:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:20:16 INFO - 'tests': ['basic_compositor_video']}, 13:20:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:20:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:20:16 INFO - 'tests': ['a11yr', 13:20:16 INFO - 'ts_paint', 13:20:16 INFO - 'tpaint', 13:20:16 INFO - 'sessionrestore', 13:20:16 INFO - 'sessionrestore_no_auto_restore', 13:20:16 INFO - 'tabpaint']}, 13:20:16 INFO - 'other-e10s': {'tests': ['a11yr', 13:20:16 INFO - 'ts_paint', 13:20:16 INFO - 'tpaint', 13:20:16 INFO - 'sessionrestore', 13:20:16 INFO - 'sessionrestore_no_auto_restore', 13:20:16 INFO - 'tabpaint']}, 13:20:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:20:16 INFO - 'ts_paint', 13:20:16 INFO - 'tpaint', 13:20:16 INFO - 'sessionrestore', 13:20:16 INFO - 'sessionrestore_no_auto_restore', 13:20:16 INFO - 'tabpaint']}, 13:20:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:20:16 INFO - 'ts_paint', 13:20:16 INFO - 'tpaint', 13:20:16 INFO - 'sessionrestore', 13:20:16 INFO - 'sessionrestore_no_auto_restore', 13:20:16 INFO - 'tabpaint']}, 13:20:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:20:16 INFO - 'tests': ['a11yr', 13:20:16 INFO - 'ts_paint', 13:20:16 INFO - 'tpaint', 13:20:16 INFO - 'sessionrestore', 13:20:16 INFO - 'sessionrestore_no_auto_restore', 13:20:16 INFO - 'tabpaint']}, 13:20:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:20:16 INFO - 'tests': ['a11yr', 13:20:16 INFO - 'ts_paint', 13:20:16 INFO - 'tpaint', 13:20:16 INFO - 'sessionrestore', 13:20:16 INFO - 'sessionrestore_no_auto_restore', 13:20:16 INFO - 'tabpaint']}, 13:20:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:20:16 INFO - 'tests': ['tsvgx', 13:20:16 INFO - 'tsvgr_opacity', 13:20:16 INFO - 'tart', 13:20:16 INFO - 'tscrollx', 13:20:16 INFO - 'cart']}, 13:20:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:20:16 INFO - 'tsvgr_opacity', 13:20:16 INFO - 'tart', 13:20:16 INFO - 'tscrollx', 13:20:16 INFO - 'cart']}, 13:20:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:16 INFO - 'talos_options': ['--disable-e10s'], 13:20:16 INFO - 'tests': ['tp5o']}, 13:20:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:16 INFO - 'tests': ['tp5o']}, 13:20:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:16 INFO - 'talos_options': ['--disable-e10s', 13:20:16 INFO - '--xperf_path', 13:20:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:20:16 INFO - 'tests': ['tp5n']}, 13:20:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:16 INFO - 'talos_options': ['--xperf_path', 13:20:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:20:16 INFO - 'tests': ['tp5n']}}, 13:20:16 INFO - 'talos.zip': {'path': '', 13:20:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:20:16 INFO - Running post-action listener: _resource_record_post_action 13:20:16 INFO - ##### 13:20:16 INFO - ##### Finished populate-webroot step (success) 13:20:16 INFO - ##### 13:20:16 INFO - ##### 13:20:16 INFO - ##### Running create-virtualenv step. 13:20:16 INFO - ##### 13:20:16 INFO - Running pre-action listener: _resource_record_pre_action 13:20:16 INFO - Running main action method: create_virtualenv 13:20:16 INFO - Creating virtualenv /builds/slave/test/build/venv 13:20:16 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 13:20:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:20:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:20:16 INFO - Using real prefix '/usr' 13:20:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:20:16 INFO - Installing distribute.............................................................................................................................................................................................done. 13:20:18 INFO - Installing pip.................done. 13:20:18 INFO - Return code: 0 13:20:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:20:18 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')]} 13:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:18 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')]} 13:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:18 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 0x257a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28393b0>, '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 0x283a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', '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 13:20:18 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 13:20:18 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 13:20:18 INFO - Using env: {'DISPLAY': ':0', 13:20:18 INFO - 'HOME': '/home/cltbld', 13:20:18 INFO - 'LANG': 'en_US.UTF-8', 13:20:18 INFO - 'LANGUAGE': 'en_US:en', 13:20:18 INFO - 'LOGNAME': 'cltbld', 13:20:18 INFO - 'MAIL': '/var/mail/cltbld', 13:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:18 INFO - 'MOZ_NO_REMOTE': '1', 13:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:18 INFO - 'NO_EM_RESTART': '1', 13:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:18 INFO - 'PWD': '/builds/slave/test', 13:20:18 INFO - 'SHELL': '/bin/bash', 13:20:18 INFO - 'SHLVL': '1', 13:20:18 INFO - 'TERM': 'linux', 13:20:18 INFO - 'TMOUT': '86400', 13:20:18 INFO - 'USER': 'cltbld', 13:20:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', 13:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:18 INFO - '_': '/tools/buildbot/bin/python'} 13:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:19 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 13:20:19 INFO - Cleaning up... 13:20:19 INFO - Return code: 0 13:20:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:20:19 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')]} 13:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:19 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')]} 13:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:19 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 0x257a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28393b0>, '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 0x283a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', '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 13:20:19 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 13:20:19 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 13:20:19 INFO - Using env: {'DISPLAY': ':0', 13:20:19 INFO - 'HOME': '/home/cltbld', 13:20:19 INFO - 'LANG': 'en_US.UTF-8', 13:20:19 INFO - 'LANGUAGE': 'en_US:en', 13:20:19 INFO - 'LOGNAME': 'cltbld', 13:20:19 INFO - 'MAIL': '/var/mail/cltbld', 13:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:19 INFO - 'MOZ_NO_REMOTE': '1', 13:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:19 INFO - 'NO_EM_RESTART': '1', 13:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:19 INFO - 'PWD': '/builds/slave/test', 13:20:19 INFO - 'SHELL': '/bin/bash', 13:20:19 INFO - 'SHLVL': '1', 13:20:19 INFO - 'TERM': 'linux', 13:20:19 INFO - 'TMOUT': '86400', 13:20:19 INFO - 'USER': 'cltbld', 13:20:19 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', 13:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:19 INFO - '_': '/tools/buildbot/bin/python'} 13:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:19 INFO - Downloading/unpacking psutil>=3.1.1 13:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:20:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:20:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:20:21 INFO - Installing collected packages: psutil 13:20:21 INFO - Running setup.py install for psutil 13:20:21 INFO - building 'psutil._psutil_linux' extension 13:20:21 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 13:20:21 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 13:20:21 INFO - building 'psutil._psutil_posix' extension 13:20:21 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 13:20:21 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 13:20:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:20:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:20:21 INFO - Successfully installed psutil 13:20:21 INFO - Cleaning up... 13:20:21 INFO - Return code: 0 13:20:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:20: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')]} 13:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20: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')]} 13:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:21 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 0x257a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28393b0>, '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 0x283a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', '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 13:20:21 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 13:20:21 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 13:20:21 INFO - Using env: {'DISPLAY': ':0', 13:20:21 INFO - 'HOME': '/home/cltbld', 13:20:21 INFO - 'LANG': 'en_US.UTF-8', 13:20:21 INFO - 'LANGUAGE': 'en_US:en', 13:20:21 INFO - 'LOGNAME': 'cltbld', 13:20:21 INFO - 'MAIL': '/var/mail/cltbld', 13:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:21 INFO - 'MOZ_NO_REMOTE': '1', 13:20:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:21 INFO - 'NO_EM_RESTART': '1', 13:20:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:21 INFO - 'PWD': '/builds/slave/test', 13:20:21 INFO - 'SHELL': '/bin/bash', 13:20:21 INFO - 'SHLVL': '1', 13:20:21 INFO - 'TERM': 'linux', 13:20:21 INFO - 'TMOUT': '86400', 13:20:21 INFO - 'USER': 'cltbld', 13:20:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', 13:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:21 INFO - '_': '/tools/buildbot/bin/python'} 13:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:20:22 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 13:20:22 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 13:20:22 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 13:20:22 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 13:20:22 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 13:20:22 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 13:20:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:20:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:20:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:20:24 INFO - Installing collected packages: mozsystemmonitor 13:20:24 INFO - Running setup.py install for mozsystemmonitor 13:20:24 INFO - Successfully installed mozsystemmonitor 13:20:24 INFO - Cleaning up... 13:20:24 INFO - Return code: 0 13:20:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:24 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 0x257a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28393b0>, '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 0x283a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', '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 13:20:24 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 13:20:24 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 13:20:24 INFO - Using env: {'DISPLAY': ':0', 13:20:24 INFO - 'HOME': '/home/cltbld', 13:20:24 INFO - 'LANG': 'en_US.UTF-8', 13:20:24 INFO - 'LANGUAGE': 'en_US:en', 13:20:24 INFO - 'LOGNAME': 'cltbld', 13:20:24 INFO - 'MAIL': '/var/mail/cltbld', 13:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:24 INFO - 'MOZ_NO_REMOTE': '1', 13:20:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:24 INFO - 'NO_EM_RESTART': '1', 13:20:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:24 INFO - 'PWD': '/builds/slave/test', 13:20:24 INFO - 'SHELL': '/bin/bash', 13:20:24 INFO - 'SHLVL': '1', 13:20:24 INFO - 'TERM': 'linux', 13:20:24 INFO - 'TMOUT': '86400', 13:20:24 INFO - 'USER': 'cltbld', 13:20:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', 13:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:24 INFO - '_': '/tools/buildbot/bin/python'} 13:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:24 INFO - Downloading/unpacking jsonschema==2.5.1 13:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:20:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:20:26 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 13:20:26 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 13:20:26 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 13:20:26 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 13:20:26 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 13:20:26 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 13:20:26 INFO - Downloading functools32-3.2.3-2.tar.gz 13:20:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:20:26 INFO - warning: no files found matching '*.txt' 13:20:26 INFO - no previously-included directories found matching 'build' 13:20:26 INFO - no previously-included directories found matching 'dist' 13:20:26 INFO - no previously-included directories found matching '.git*' 13:20:26 INFO - Installing collected packages: jsonschema, functools32 13:20:26 INFO - Running setup.py install for functools32 13:20:26 INFO - warning: no files found matching '*.txt' 13:20:26 INFO - no previously-included directories found matching 'build' 13:20:26 INFO - no previously-included directories found matching 'dist' 13:20:26 INFO - no previously-included directories found matching '.git*' 13:20:26 INFO - Successfully installed jsonschema functools32 13:20:26 INFO - Cleaning up... 13:20:26 INFO - Return code: 0 13:20:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:20: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')]} 13:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20: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')]} 13:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:26 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 0x257a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28393b0>, '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 0x283a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', '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 13:20:26 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 13:20:26 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 13:20:26 INFO - Using env: {'DISPLAY': ':0', 13:20:26 INFO - 'HOME': '/home/cltbld', 13:20:26 INFO - 'LANG': 'en_US.UTF-8', 13:20:26 INFO - 'LANGUAGE': 'en_US:en', 13:20:26 INFO - 'LOGNAME': 'cltbld', 13:20:26 INFO - 'MAIL': '/var/mail/cltbld', 13:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:26 INFO - 'MOZ_NO_REMOTE': '1', 13:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:26 INFO - 'NO_EM_RESTART': '1', 13:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:26 INFO - 'PWD': '/builds/slave/test', 13:20:26 INFO - 'SHELL': '/bin/bash', 13:20:26 INFO - 'SHLVL': '1', 13:20:26 INFO - 'TERM': 'linux', 13:20:26 INFO - 'TMOUT': '86400', 13:20:26 INFO - 'USER': 'cltbld', 13:20:26 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', 13:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:26 INFO - '_': '/tools/buildbot/bin/python'} 13:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:26 INFO - Downloading/unpacking blobuploader==1.2.4 13:20:26 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 13:20:26 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 13:20:26 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 13:20:26 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 13:20:26 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 13:20:26 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 13:20:28 INFO - Downloading blobuploader-1.2.4.tar.gz 13:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:20:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:20:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:29 INFO - Downloading docopt-0.6.1.tar.gz 13:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:20:29 INFO - Installing collected packages: blobuploader, requests, docopt 13:20:29 INFO - Running setup.py install for blobuploader 13:20:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:20:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:20:29 INFO - Running setup.py install for requests 13:20:30 INFO - Running setup.py install for docopt 13:20:30 INFO - Successfully installed blobuploader requests docopt 13:20:30 INFO - Cleaning up... 13:20:30 INFO - Return code: 0 13:20:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:30 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 0x257a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28393b0>, '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 0x283a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', '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 13:20:30 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 13:20:30 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 13:20:30 INFO - Using env: {'DISPLAY': ':0', 13:20:30 INFO - 'HOME': '/home/cltbld', 13:20:30 INFO - 'LANG': 'en_US.UTF-8', 13:20:30 INFO - 'LANGUAGE': 'en_US:en', 13:20:30 INFO - 'LOGNAME': 'cltbld', 13:20:30 INFO - 'MAIL': '/var/mail/cltbld', 13:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:30 INFO - 'MOZ_NO_REMOTE': '1', 13:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:30 INFO - 'NO_EM_RESTART': '1', 13:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:30 INFO - 'PWD': '/builds/slave/test', 13:20:30 INFO - 'SHELL': '/bin/bash', 13:20:30 INFO - 'SHLVL': '1', 13:20:30 INFO - 'TERM': 'linux', 13:20:30 INFO - 'TMOUT': '86400', 13:20:30 INFO - 'USER': 'cltbld', 13:20:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', 13:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:30 INFO - '_': '/tools/buildbot/bin/python'} 13:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:20:30 INFO - Running setup.py (path:/tmp/pip-aqoXxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:20:30 INFO - Running setup.py (path:/tmp/pip-DHdQvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:20:30 INFO - Running setup.py (path:/tmp/pip-OwF7H7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:20:30 INFO - Running setup.py (path:/tmp/pip-Tqt40Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:20:30 INFO - Running setup.py (path:/tmp/pip-h1iwN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:20:30 INFO - Running setup.py (path:/tmp/pip-ahGjBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:20:30 INFO - Running setup.py (path:/tmp/pip-hbwYvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:20:31 INFO - Running setup.py (path:/tmp/pip-orJa_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:20:31 INFO - Running setup.py (path:/tmp/pip-xQSBD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:20:31 INFO - Running setup.py (path:/tmp/pip-6rtGY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:20:31 INFO - Running setup.py (path:/tmp/pip-Kkmm8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:20:31 INFO - Running setup.py (path:/tmp/pip-k2_S5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:20:31 INFO - Running setup.py (path:/tmp/pip-M0JNVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:20:31 INFO - Running setup.py (path:/tmp/pip-qY6eO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:31 INFO - Running setup.py (path:/tmp/pip-pVfLko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:20:31 INFO - Running setup.py (path:/tmp/pip-ZW8eGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:20:31 INFO - Running setup.py (path:/tmp/pip-seYCyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:20:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:20:31 INFO - Running setup.py install for manifestparser 13:20:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:20:31 INFO - Running setup.py install for mozcrash 13:20:31 INFO - Running setup.py install for mozdebug 13:20:32 INFO - Running setup.py install for mozdevice 13:20:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:20:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:20:32 INFO - Running setup.py install for mozfile 13:20:32 INFO - Running setup.py install for mozhttpd 13:20:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:20:32 INFO - Running setup.py install for mozinfo 13:20:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:20:32 INFO - Running setup.py install for mozInstall 13:20:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:20:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:20:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:20:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:20:32 INFO - Running setup.py install for mozleak 13:20:32 INFO - Running setup.py install for mozlog 13:20:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:20:32 INFO - Running setup.py install for moznetwork 13:20:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:20:32 INFO - Running setup.py install for mozprocess 13:20:33 INFO - Running setup.py install for mozprofile 13:20:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:20:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:20:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:20:33 INFO - Running setup.py install for mozrunner 13:20:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:20:33 INFO - Running setup.py install for mozscreenshot 13:20:33 INFO - Running setup.py install for moztest 13:20:33 INFO - Running setup.py install for mozversion 13:20:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:20:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:20:33 INFO - Cleaning up... 13:20:33 INFO - Return code: 0 13:20:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:20: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')]} 13:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20: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')]} 13:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:33 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 0x257a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28393b0>, '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 0x283a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', '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 13:20:33 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 13:20:33 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 13:20:33 INFO - Using env: {'DISPLAY': ':0', 13:20:33 INFO - 'HOME': '/home/cltbld', 13:20:33 INFO - 'LANG': 'en_US.UTF-8', 13:20:33 INFO - 'LANGUAGE': 'en_US:en', 13:20:33 INFO - 'LOGNAME': 'cltbld', 13:20:33 INFO - 'MAIL': '/var/mail/cltbld', 13:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:33 INFO - 'MOZ_NO_REMOTE': '1', 13:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:33 INFO - 'NO_EM_RESTART': '1', 13:20:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:33 INFO - 'PWD': '/builds/slave/test', 13:20:33 INFO - 'SHELL': '/bin/bash', 13:20:33 INFO - 'SHLVL': '1', 13:20:33 INFO - 'TERM': 'linux', 13:20:33 INFO - 'TMOUT': '86400', 13:20:33 INFO - 'USER': 'cltbld', 13:20:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', 13:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:33 INFO - '_': '/tools/buildbot/bin/python'} 13:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:20:33 INFO - Running setup.py (path:/tmp/pip-N_htFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:20:33 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)) 13:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:20:33 INFO - Running setup.py (path:/tmp/pip-EMSHkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:20:33 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)) 13:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:20:33 INFO - Running setup.py (path:/tmp/pip-O1DrUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:20:34 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)) 13:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:20:34 INFO - Running setup.py (path:/tmp/pip-qBD3xV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:20:34 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)) 13:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:20:34 INFO - Running setup.py (path:/tmp/pip-o2kSbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:20:34 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)) 13:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:20:34 INFO - Running setup.py (path:/tmp/pip-DvlTKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:20:34 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)) 13:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:20:34 INFO - Running setup.py (path:/tmp/pip-GNZcoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:20:34 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)) 13:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:20:34 INFO - Running setup.py (path:/tmp/pip-rlCy_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:20:34 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)) 13:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:20:34 INFO - Running setup.py (path:/tmp/pip-EA4VPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:20:34 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)) 13:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:20:34 INFO - Running setup.py (path:/tmp/pip-MFTeLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:20:34 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)) 13:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:20:34 INFO - Running setup.py (path:/tmp/pip-lXf2ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:20:34 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)) 13:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:20:34 INFO - Running setup.py (path:/tmp/pip-mUPBHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:20:34 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)) 13:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:20:34 INFO - Running setup.py (path:/tmp/pip-52c_pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:20:34 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)) 13:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:20:34 INFO - Running setup.py (path:/tmp/pip-eqPOOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:20:34 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)) 13:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:34 INFO - Running setup.py (path:/tmp/pip-VrnoE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:34 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)) 13:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:20:34 INFO - Running setup.py (path:/tmp/pip-T2mscB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:20:34 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)) 13:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:20:34 INFO - Running setup.py (path:/tmp/pip-WSbXxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:20:35 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)) 13:20:35 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)) 13:20:35 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)) 13:20:35 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)) 13:20:35 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)) 13:20:35 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)) 13:20:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:20:35 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 13:20:35 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 13:20:35 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 13:20:35 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 13:20:35 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 13:20:35 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 13:20:36 INFO - Downloading blessings-1.6.tar.gz 13:20:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:20:37 INFO - Installing collected packages: blessings 13:20:37 INFO - Running setup.py install for blessings 13:20:37 INFO - Successfully installed blessings 13:20:37 INFO - Cleaning up... 13:20:37 INFO - Return code: 0 13:20:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:20:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:20:37 INFO - Reading from file tmpfile_stdout 13:20:37 INFO - Current package versions: 13:20:37 INFO - argparse == 1.2.1 13:20:37 INFO - blessings == 1.6 13:20:37 INFO - blobuploader == 1.2.4 13:20:37 INFO - docopt == 0.6.1 13:20:37 INFO - functools32 == 3.2.3-2 13:20:37 INFO - jsonschema == 2.5.1 13:20:37 INFO - manifestparser == 1.1 13:20:37 INFO - mozInstall == 1.12 13:20:37 INFO - mozcrash == 0.17 13:20:37 INFO - mozdebug == 0.1 13:20:37 INFO - mozdevice == 0.48 13:20:37 INFO - mozfile == 1.2 13:20:37 INFO - mozhttpd == 0.7 13:20:37 INFO - mozinfo == 0.9 13:20:37 INFO - mozleak == 0.1 13:20:37 INFO - mozlog == 3.2 13:20:37 INFO - moznetwork == 0.27 13:20:37 INFO - mozprocess == 0.23 13:20:37 INFO - mozprofile == 0.28 13:20:37 INFO - mozrunner == 6.12 13:20:37 INFO - mozscreenshot == 0.1 13:20:37 INFO - mozsystemmonitor == 0.3 13:20:37 INFO - moztest == 0.7 13:20:37 INFO - mozversion == 1.4 13:20:37 INFO - psutil == 3.1.1 13:20:37 INFO - requests == 1.2.3 13:20:37 INFO - wsgiref == 0.1.2 13:20:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:20:37 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')]} 13:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:37 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')]} 13:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:37 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 0x257a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28393b0>, '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 0x283a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', '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 13:20:37 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 13:20:37 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 13:20:37 INFO - Using env: {'DISPLAY': ':0', 13:20:37 INFO - 'HOME': '/home/cltbld', 13:20:37 INFO - 'LANG': 'en_US.UTF-8', 13:20:37 INFO - 'LANGUAGE': 'en_US:en', 13:20:37 INFO - 'LOGNAME': 'cltbld', 13:20:37 INFO - 'MAIL': '/var/mail/cltbld', 13:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:37 INFO - 'MOZ_NO_REMOTE': '1', 13:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:37 INFO - 'NO_EM_RESTART': '1', 13:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:37 INFO - 'PWD': '/builds/slave/test', 13:20:37 INFO - 'SHELL': '/bin/bash', 13:20:37 INFO - 'SHLVL': '1', 13:20:37 INFO - 'TERM': 'linux', 13:20:37 INFO - 'TMOUT': '86400', 13:20:37 INFO - 'USER': 'cltbld', 13:20:37 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', 13:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:37 INFO - '_': '/tools/buildbot/bin/python'} 13:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:37 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)) 13:20:37 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)) 13:20:37 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)) 13:20:37 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)) 13:20:37 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)) 13:20:37 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)) 13:20:37 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)) 13:20:37 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)) 13:20:37 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)) 13:20:37 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)) 13:20:37 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)) 13:20:37 INFO - Cleaning up... 13:20:37 INFO - Return code: 0 13:20:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:20:37 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')]} 13:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:37 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')]} 13:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:37 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 0x257a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28393b0>, '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 0x283a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', '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 13:20:37 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 13:20:37 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 13:20:37 INFO - Using env: {'DISPLAY': ':0', 13:20:37 INFO - 'HOME': '/home/cltbld', 13:20:37 INFO - 'LANG': 'en_US.UTF-8', 13:20:37 INFO - 'LANGUAGE': 'en_US:en', 13:20:37 INFO - 'LOGNAME': 'cltbld', 13:20:37 INFO - 'MAIL': '/var/mail/cltbld', 13:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:37 INFO - 'MOZ_NO_REMOTE': '1', 13:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:37 INFO - 'NO_EM_RESTART': '1', 13:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:37 INFO - 'PWD': '/builds/slave/test', 13:20:37 INFO - 'SHELL': '/bin/bash', 13:20:37 INFO - 'SHLVL': '1', 13:20:37 INFO - 'TERM': 'linux', 13:20:37 INFO - 'TMOUT': '86400', 13:20:37 INFO - 'USER': 'cltbld', 13:20:37 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', 13:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:37 INFO - '_': '/tools/buildbot/bin/python'} 13:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:20:37 INFO - Cleaning up... 13:20:37 INFO - Return code: 0 13:20:37 INFO - Running post-action listener: _resource_record_post_action 13:20:37 INFO - Running post-action listener: _start_resource_monitoring 13:20:37 INFO - Starting resource monitoring. 13:20:37 INFO - ##### 13:20:37 INFO - ##### Finished create-virtualenv step (success) 13:20:37 INFO - ##### 13:20:37 INFO - ##### 13:20:37 INFO - ##### Running install step. 13:20:37 INFO - ##### 13:20:37 INFO - Running pre-action listener: _resource_record_pre_action 13:20:37 INFO - Running main action method: install 13:20:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:20:38 INFO - Reading from file tmpfile_stdout 13:20:38 INFO - Detecting whether we're running mozinstall >=1.0... 13:20:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:20:38 INFO - Reading from file tmpfile_stdout 13:20:38 INFO - Output received: 13:20:38 INFO - Usage: mozinstall [options] installer 13:20:38 INFO - Options: 13:20:38 INFO - -h, --help show this help message and exit 13:20:38 INFO - -d DEST, --destination=DEST 13:20:38 INFO - Directory to install application into. [default: 13:20:38 INFO - "/builds/slave/test"] 13:20:38 INFO - --app=APP Application being installed. [default: firefox] 13:20:38 INFO - mkdir: /builds/slave/test/build/application 13:20:38 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'] 13:20:38 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 13:20:54 INFO - Reading from file tmpfile_stdout 13:20:54 INFO - Output received: 13:20:54 INFO - /builds/slave/test/build/application/firefox/firefox 13:20:54 INFO - Running post-action listener: _resource_record_post_action 13:20:54 INFO - ##### 13:20:54 INFO - ##### Finished install step (success) 13:20:54 INFO - ##### 13:20:54 INFO - ##### 13:20:54 INFO - ##### Running run-tests step. 13:20:54 INFO - ##### 13:20:54 INFO - Running pre-action listener: _resource_record_pre_action 13:20:54 INFO - Running main action method: run_tests 13:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:20:54 INFO - Python 2.7.3 13:20:54 INFO - Return code: 0 13:20:54 INFO - grabbing minidump binary from tooltool 13:20:54 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')]} 13:20:54 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 0x28393b0>, '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 0x283a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:20:54 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 13:20:54 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 13:20:54 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 13:20:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:20:54 INFO - Return code: 0 13:20:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:20:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:20:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:20:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:20:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 13:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 13:20:54 INFO - Using env: {'DISPLAY': ':0', 13:20:54 INFO - 'HOME': '/home/cltbld', 13:20:54 INFO - 'LANG': 'en_US.UTF-8', 13:20:54 INFO - 'LANGUAGE': 'en_US:en', 13:20:54 INFO - 'LOGNAME': 'cltbld', 13:20:54 INFO - 'MAIL': '/var/mail/cltbld', 13:20:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:20:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:54 INFO - 'MOZ_NO_REMOTE': '1', 13:20:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:54 INFO - 'NO_EM_RESTART': '1', 13:20:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:54 INFO - 'PWD': '/builds/slave/test', 13:20:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:20:54 INFO - 'SHELL': '/bin/bash', 13:20:54 INFO - 'SHLVL': '1', 13:20:54 INFO - 'TERM': 'linux', 13:20:54 INFO - 'TMOUT': '86400', 13:20:54 INFO - 'USER': 'cltbld', 13:20:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368', 13:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:54 INFO - '_': '/tools/buildbot/bin/python'} 13:20:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 13:20:54 INFO - mozversion application_buildid: 20160713123542 13:20:54 INFO - mozversion application_changeset: 006a4f4e68522332a36fd7eccd9664b73efae975 13:20:54 INFO - mozversion application_display_name: Nightly 13:20:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:20:54 INFO - mozversion application_name: Firefox 13:20:54 INFO - mozversion application_remotingname: firefox 13:20:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:20:54 INFO - mozversion application_vendor: Mozilla 13:20:54 INFO - mozversion application_version: 50.0a1 13:20:54 INFO - mozversion platform_buildid: 20160713123542 13:20:54 INFO - mozversion platform_changeset: 006a4f4e68522332a36fd7eccd9664b73efae975 13:20:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:20:54 INFO - mozversion platform_version: 50.0a1 13:20:54 INFO - using testdate: 1468441254 13:20:54 INFO - actual date: 1468441254 13:20:54 INFO - starting webserver on 'localhost:59875' 13:20:54 INFO - SUITE-START | Running 2 tests 13:20:54 INFO - TEST-START | dromaeo_css 13:20:54 INFO - operating with platform_type : linux_ 13:20:54 INFO - Initialising browser for dromaeo_css test... 13:20:54 INFO - TEST-INFO | started process 10398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0NKGne/profile http://localhost:59875/getInfo.html) 13:20:59 INFO - PROCESS | 10398 | __metrics Screen width/height:1600/1200 13:20:59 INFO - PROCESS | 10398 | colorDepth:24 13:20:59 INFO - PROCESS | 10398 | Browser inner width/height: 1024/697 13:20:59 INFO - PROCESS | 10398 | __metrics 13:21:00 INFO - PROCESS | 10398 | 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" 13:21:00 INFO - PROCESS | 10398 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:21:00 INFO - PROCESS | 10398 | console.error: PushService: 13:21:00 INFO - PROCESS | 10398 | stateChangeProcessEnqueue: Error transitioning state 13:21:00 INFO - PROCESS | 10398 | UnknownError 13:21:01 INFO - TEST-INFO | 10398: exit 0 13:21:01 INFO - Browser initialized. 13:21:01 INFO - Running cycle 1/1 for dromaeo_css test... 13:21:01 INFO - TEST-INFO | started process 10481 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0NKGne/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:21:13 INFO - PROCESS | 10481 | RSS: Main: 159465472 13:21:13 INFO - PROCESS | 10481 | 13:22:04 INFO - PROCESS | 10481 | 1468441324958 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] 13:24:16 INFO - PROCESS | 10481 | Cycle 1(1): loaded http://localhost:59875/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59875/tests/dromaeo/cssquery-ext.html) 13:24:17 INFO - PROCESS | 10481 | RSS: Main: 271577088 13:24:17 INFO - PROCESS | 10481 | 13:27:20 INFO - PROCESS | 10481 | Cycle 1(1): loaded http://localhost:59875/tests/dromaeo/cssquery-ext.html (next: http://localhost:59875/tests/dromaeo/cssquery-jquery.html) 13:27:21 INFO - PROCESS | 10481 | RSS: Main: 240652288 13:27:21 INFO - PROCESS | 10481 | 13:30:23 INFO - PROCESS | 10481 | Cycle 1(1): loaded http://localhost:59875/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59875/tests/dromaeo/cssquery-mootools.html) 13:30:23 INFO - PROCESS | 10481 | RSS: Main: 247603200 13:30:23 INFO - PROCESS | 10481 | 13:33:26 INFO - PROCESS | 10481 | Cycle 1(1): loaded http://localhost:59875/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59875/tests/dromaeo/cssquery-prototype.html) 13:33:26 INFO - PROCESS | 10481 | RSS: Main: 242262016 13:33:26 INFO - PROCESS | 10481 | 13:36:29 INFO - PROCESS | 10481 | Cycle 1(1): loaded http://localhost:59875/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59875/tests/dromaeo/cssquery-yui.html) 13:36:30 INFO - PROCESS | 10481 | RSS: Main: 212033536 13:36:30 INFO - PROCESS | 10481 | 13:39:33 INFO - PROCESS | 10481 | Cycle 1(1): loaded http://localhost:59875/tests/dromaeo/cssquery-yui.html (next: http://localhost:59875/tests/dromaeo/cssquery-dojo.html) 13:39:33 INFO - PROCESS | 10481 | RSS: Main: 279392256 13:39:33 INFO - PROCESS | 10481 | 13:39:33 INFO - PROCESS | 10481 | __start_tp_report 13:39:33 INFO - PROCESS | 10481 | _x_x_mozilla_page_load 13:39:33 INFO - PROCESS | 10481 | _x_x_mozilla_page_load_details 13:39:33 INFO - PROCESS | 10481 | |i|pagename|runs| 13:39:33 INFO - PROCESS | 10481 | |0;dojo.html;2574.253466494716;2587.4436996045847;2615.1500762252263;2622.8688565571715;2625.0418597212024;4459.241928872091;4535.70517916336;4594.402727645405;4621.214393553096;4637.698549594278;4567.337736028274;4583.839565615204;4594.081183763244;4675.438947326317;4675.602573781224;4265.765382903939;4285.185814695214;4302.827886884521;4323.913521729579;4384;4254.319308910575;4328.545502722216;4352.260115780325;4367.934480982788;4386.6929314947965;4080.8163632636306;4283.229018776619;4303.655707543405;4331.198728235287;4334.479862416514;4118.897027574305;4177.3316269396755;4178.895527611804;4190.161967606491;4207.705460617758;4158.9376159357635;4193.580641935812;4201.117765269297;4202.3696445533105;4246.57534246576;4426.048399594103;4587.518310577375;4634.86095417138;4640.257558790611;4645.256758918591;4746.715197088186;4828.420589529243;4874.4150701916;4952.108620448318;4953.083679519301;4919.631027672939;4948.653594248404;4965.503449655042;4984.750762461862;4985.551300382983;4476.529964353696;4519.728816271035;4631.58315751584;4651.744154071558;4656.3713898623255;4985.675931064469;5022.7990880365105;5058.46886076964;5074.13739664258;5078.873028174251;4825.686330388514;4832.710037397767;4865.099956508057;4876.853694389174;4881.487443818419;4754.144254034307;4900.068986892479;4916.115099282163;4952.925706114411;4954.653174277766;4875.95124048762;4879.609631229493;4888.584470319992;4928.137575924199;4950.702957822542;4871.025794841046;4873.756312184448;4879.585235255043;4891.1685013547785;4943.060818444484;3966.5438474575217;4020.8793736187963;4122.40225167349;4123.4021066945725;4183.247015537172;3656.451532270181;3667.6807489222297;3671.687906527975;3707.5180226570374;3729.5710993236125;4255.063885945087;4280.143971205771;4288.24955632763;4308.095299987038;4327.567243275647;4779.5220477951925;4834.20235661119;4868.196747536616;4882.292067650242;4995.075910956485;4199.076203235283;4207.137536804948;4217.915641687149;4250.553691862372;4264.914701705949;4393.934090988638;4402.757848318309;4406.294992801137;4409.007973206003;4448.466184057934;4482.910341793081;4581.633469322513;4621.30680397943;4632.884177895579;4676.742779147112;4909.042736666459;4911.066897289504;4925.556699897026;4933.309336692938;4981.402231732215;4629.837955671535;4641.141388843075;4643.117807616542;4644.512326205835;4691.483936767021;4662.557057079572;4752.714837109785;4762.809487620457;4801.975990120167;4803.879903002453;4838.250071238964;4857.0528746894015;4875.90248195027;4881.926771098365;4928.088303663833;4625.768711564476;4763.499832517675;4773.164696178085;4773.284007398918;4792.329073929723;4734.905301894012;4762.761861906822;4793.23308270689;4799.544043315879;4805.038992201504;4720.268358404453;4736.881577960578;4744.217204161275;4777.665563410667;4778.37881075458;4682.484926658133;4729.905401891874;4820.108279968217;4832.516748325139;4868.026394721141;4648.628109751279;4664.93002604968;4670.696404733681;4694.6244300456565;4712.104700106968 13:39:33 INFO - PROCESS | 10481 | |1;ext.html;569.308290427131;578.1010528627982;579.6377264209868;582.3390451837165;591.7839988404231;27444.725552744465;39354.606453935485;40922;40930.181396372056;44654.553454465444;41142.38286425706;41638.58361416385;41655.583444165546;41669.37495937564;41735.165296694126;7536.924630753704;7836.8040798980055;7980.800479987989;7982.082060563022;7986.480878742892;7669.501482403653;7739.7678069658;7744.380449564022;10087.344322619043;10396.844047339297;10383.792324153512;10437.373757574533;10447.059764621183;10449.895501044968;10456.790864182749;10200.540975656113;10240.539175737034;10250.9487452563;10269.178465722762;10270.640527581574;7477.513961592534;9992.600295988152;10374.948125259401;10383.84424233637;10666.946665266702;39233.41149882754;39456.40815387772;39474;39576;39615.801920990496;2826.1662809471254;2904.549794781791;2958.792884498086;3168.984155079233;3636.7636103653176;29406.70593294061;29746;30009.549856752164;30192.396152076835;30747.692523074707;2920.182348942278;2963.866626001835;2966.1546459259007;2972.078655616766;3014.351914338406;258722;258763;259735;260653;260929;31997.52003719946;50824.237636435486;51422;51466.5666791651;51477.7426112867;31924.36151277008;33833;33837.96972181677;33838.32323353568;33859.492107618404;13648.385822638005;13839.723205535833;13852.792208116887;13853.722925541433;13857.168569885838;10438.217133715001;11292.266002709797;11420.086393088533;11433.428328583537;11446.08431325492;7689.307962283309;7878.448508604457;7903.525788452711;7994.120646728855;8065.758027259074;3045.2234680156416;3072.0937323489625;3100.8449577521483;3115.143335582733;3134.9216269593444;813.938954578409;845.3659755183612;905.330055758747;952.7728068131595;962.8748262725801;27400.451990960068;27922.581161282596;27957.30106747307;28164;28489.145325640264;947.924166066713;964.1852634523816;968.2689569375218;969.6606187834343;987.6000219910948;14913.478028268959;14944.925275373553;14976.47582334613;15059.096454212782;15183.16492592918;394301;395815;398700;398811;399435;49108.263376049385;49560.256596151085;49620.50379496231;49681.50318496841;49715.50284497109;1069.187417562658;1103.4096758234145;1165.6153469355093;1174.1487421619258;1177.8998785103363;28294;29196.854015730634;29361.70638293675;29905.700942991163;29916.102516924526;41246.38130428106;41528.37707434451;41565.168696626504;41673.37489937593;41685.58314416938;298791;303524;303569;303976;304088;22012.119515219212;24100.87949560241;24918.12786552462;25077.74922250754;25134.74865251324;40566.59433405628;41122;41434;41518.37722434106;42536.78731606322;34948.56699230167;35568.28863422769;36093;36149.81925090358;36273.63726362808;35877.82061089678;36237.45643815292;36238.8188059058;36414.08964775902;36844.81577592095;34534.30931381308;34824.65175348315;35209.119772005906;35850.46224306586;35869;30269;32178.83910580432;32325.51511727279;32675.509867352484;32676;24498.67262610049;24707.505849883262;24951.87524062368;25316.873415632803;25436.745632543436 13:39:33 INFO - PROCESS | 10481 | |2;jquery.html;350.24871650310104;364.66450865204007;367.99080022999425;377.3999341047734;399.658292160203;13102.868971310285;17438;17603.911980440094;18494.44516664499;19665.70501442476;17663.293468261254;17717.46847594571;17882.28470861167;18066;18294.451166464994;5443.292371991645;5762.049261871786;5766.077427611583;5842.707864606774;5848.181254624356;4125.463689720347;5721.427857214266;6596;6939.306069393071;6939.826504337381;6827.180738311385;6887.691338645666;7026.89459658103;7033.964830175842;7038.788836334918;6956.060931774196;6992.056072430259;7004.4396448284015;7017.228104908456;7020.508564400494;6517.4134327910715;6820.386165245102;6836.521443498957;6841.2132604750595;6843.281455447156;23971.52056958851;24103.638445423334;24490.87754561216;24730.752692473026;24786.38034049145;1902.3722171683312;1956.3739603326942;1981.6433042052424;1987;2063.9484012899798;14004.92997535016;14641.41434342625;14758.409663613442;14774.409023639042;15255.542333730005;1861.4880907750342;1908.885466871992;1909.9427017189507;1912.1108684461792;1922.2407149175997;78300.60849695715;79320.60339698322;81354.59322703349;82011.5899420505;83883;13943;14888.181150036851;16465.67068658644;17005.57486062858;17158.656826863393;29947.700522994928;30046.54930176049;30210.395792084037;30442;30442.238944026576;8978.416402933788;8981.371304008788;9110.86333704995;9252.213561847318;9367.765805854908;7646.3882889368715;7675.731349402744;7771.883421748678;7782.883256751154;7798.454108212484;8405.789855253668;8436.831263374697;8525.275351595059;8558.101399353103;8605.698800541952;3178.253110519026;3200.487921932526;3295.6210035845706;3324.384988777084;3412.488126781003;781.7498400511895;834.8372067446911;839.6431516605418;883.5802993578128;911.1844898815523;16499.917500412423;17391.73912391315;17416;17515.386961456286;17811.73282400765;795.5743677132706;804.3484777330265;805.8831469437016;818.2650209018701;871.899731530882;9086.954565227265;9649.228061755042;9658.75853103664;9679.612815487302;9710.563024663907;344675;345848;346136;348324;363751;49757.75121124371;49960;61683.6915815418;79834;81656;845.2139510255645;883.3419102768479;886.1271647427279;895.1987970766128;899.1907283444821;11698.76602467929;15046.849531504546;15687.352553080653;16072;16570.83429165693;36220.456693150154;37845.81077094707;39492;39823.402648960866;39961.80019099886;49733.254001189285;50267;50496;50593.494065058876;50914.74542627263;5937;7314.780556583311;7577.393808495417;7603.619819008917;7692.7692169235015;10471.790564188826;10812.513436895515;11029.779404411707;11148.108151348035;11279.887201127884;9424.858627120462;9530.523473826419;9573.425594464354;9627.759306017406;9853.852192217266;9397.81204375895;9428.717138485856;9478.85781713261;9578.185854202471;9841.458719770195;9329.580168892551;9347.579358928728;9553.904460955302;9769.951150244204;9963.651272205729;7361.82210846262;7461.477696561188;7480.887786683313;7607.771766847003;7656.732014379692;7382.630868456448;8765.430247033923;9632.711018669452;9688.75778105553;9792.461414622265 13:39:33 INFO - PROCESS | 10481 | |3;mootools.html;1347.973040539189;1394.9816633857283;1441.7260720463112;1648.085312651478;1687.7468379743036;7712;8129.878051829212;8199;8201.958990205056;8203.91796082039;6566.474682025427;6721.831954201148;6773.254941956381;6950.026996220533;8017.759467215993;1848.7873894502102;2133.4666333416644;2178.3247193370107;2194.100418828281;2218.223621732389;2203.0526873444414;2217.5786600545925;2236.4408897775556;2236.664500324956;2238.597052530544;1686.7132587460162;2206.0734491513604;2209.9005544750526;2210.5026369066914;2212.314182603398;1843.778746550409;1873.372420239208;1874.6344462829686;2070.078814927358;2136.8290536757177;2125.1180759984586;2129.446343950584;2132.1791110422446;2132.9761714377187;2133.573285342922;8016.7194148204535;8074.555899425529;8075.232852878967;8078.8788168177525;8082.43422960393;4435.955640443586;4587.816487340502;4588.839390621312;4594.74728889911;4597.195490789099;2700.0954680182163;2708.0521817363765;2779.5274803283287;2785.2758282846607;2790.2884764384953;779.2830595851773;826.2068414322258;835.1147783349669;840.2437805974611;841.6296829395108;11052.447377631086;11058.668239952814;11082.556697732081;11107.111431085574;11121.165912556591;4050.5746896575433;4099.7745124017865;4257.063446041866;4264.829406823755;4272.957270427318;9361.157495825271;9365.11031452011;9366.67216647414;9387.57755900986;9394.530273486298;4671.579557839811;4671.813127474863;4686;4689.296605509133;4694.6713730039255;4216.936745948813;4230.534641189467;4237.279662457389;4238.830446782156;4241.830326786894;3738.0841693785196;3741.401375779862;3755.9248815024093;3762.3415902217002;3866.3427217373114;1150.9844208174468;1159.8724140344555;1177.0818761366147;1179.404400777619;1213.4963989944074;794.0511089248292;800.2117913854848;807.4428644235459;824.7608193623902;831.8876951611576;5203.505666961632;5287.233351164136;5411.891762164813;5451.945480545144;5478.671279723229;847.9745607631781;850.4047166983013;878.7978764884112;879.1033146190978;879.6173664455982;3563.2873425315042;3567.1795487038125;3606.495090687306;3696.704263658901;3821.541415030214;9587.616495340108;9709.66016189444;9957.302988790716;9974.551145198338;9980.650677226262;9627.374220675634;10042.648507302209;10050.849237261447;10063.19494440443;10067.345622534658;7453.031105956191;7559.697612095564;7573.507721998052;7578.507397019176;7600.391968642606;5093.668911520887;5155.767990440364;5161.870953226199;5209.296744939385;5443.863903402446;8604.655813767378;8928.86606700913;8966.730998070068;8991.55042247898;9171.816563668555;9154.542272886461;9361.531923403667;9374.296927730311;9376.531173441437;9430.57562409707;5976.372480889618;6129.632222066691;6132.17215675878;6288.874222515616;6289.559730818982;7405.518641288299;7582.924170758442;7607.581583012766;7860.3318717909615;7861.803454913673;6788.694508747217;6815.93184068153;6915.446764258747;7005.929940700527;7048.083749112582;6948.33990770876;7001.824954376181;7015.614141222281;7093.432525397852;7122.893156602551;6456.935430645822;6635.8009259722285;6636.9004464932095;6637.435817955527;6641.767538136142;4271.5514870938105;4432;4446.288593825102;4466.263066594105;4495.2358099123885;4509.661775366795;4613.746243956614;4634.189016922092;4661.347411362344;4756.429228492603 13:39:33 INFO - PROCESS | 10481 | |4;prototype.html;287.5313239419747;297.9106268119564;306.10311786465655;306.74080402060264;307.18902098460086;4742.383490146285;4819.927701084483;4861.222204447289;4865.61075113991;4867.610591152708;4534.208987449963;4659.836905708301;4665.136949664306;4708.2702181161885;4796.712197268166;3680.7239457040696;3727.8257348935;3743.4010558310742;3796.905077373074;3798.2213646202463;3777.9055523611855;3795.2219794942107;3807.904802379935;3815.351390263662;3829.5213098362706;3605.429001355765;3766.2467506498674;3785.318642644323;3786.962130378702;3803.9348982284864;3584;3711.610280920505;3737.289914916157;3749.137698329372;3762.6425489578446;3341.5154802553493;3347.3640008398324;3386.4920261960656;3387.5934887813373;3396.083057574466;4666.673332866701;4678.929816052762;4758.595519380857;4759.547842954914;4766.142094423002;4042.2925987952285;4289.099289149282;4332.068605249855;4345.608895199415;4349.064951035542;4962.305277261186;5008.874778130539;5009.674371165863;5010.649254552182;5014.573761230264;3581.6776490116013;3592.6407359264126;3606;3607.4228123500116;3615.7107431405425;5035.798568057273;5303.920441193385;5312.73436328182;5325.988062268157;5332.226827110047;3676.7242456815848;3682.760620559655;3691.9630803692157;3697.90755231116;3702.241040586673;3733.775973441602;3737.5141231639714;3749.6625303722794;3758.605346438639;3761.887143385703;4272.5727427257025;4275.29457639486;4278.6949980255695;4286.249906266391;4286.635635970977;4783.784729687172;5017.774200161001;5025.422076461181;5093.414257360377;5122.154844450699;1268.207370393504;1277.5847849448967;1287.993560032194;1288.4974859804684;1292.2311224821217;812.3907069697726;816.3591580609193;829.9792505187298;842.3471809347682;842.5955541340069;4027.7715296834162;4046.352583586612;4055.8174882130374;4076.7553946763287;4087.6321131097748;4534.911621210886;4589.380433641482;4591.793369298322;4595.621313605905;4656.930146047812;3991.2815693175507;4008.238434697398;4018.553320804508;4058.289799285113;4229.725067870579;2521.722610512842;2549.228286340975;2663.6670416197976;2710.1598504463677;2715.2397328747984;4890.95109048912;4897.338859253955;4898.779554920037;4952.257161425815;4968.90062198754;5277.63056586043;5324.41431442541;5335.279737235501;5336;5344.770702738392;4730.2431610942085;4855.927161092586;4874.7562621868765;4907.68100073494;4913.164761990471;5157.252198431282;5176;5189.455107213688;5230.34620672416;5234.633575649668;5081.18701007837;5135.743212839268;5152.896942061063;5174.197999310113;5179.45615710345;4774.641901857444;4889.413270407432;4910.803567857389;4919.606431485544;4925.38432695913;3629.1108678373967;3642.2533380657433;3656.61605531426;3657.177135144678;3659.1949771050326;5189.896202075862;5198.9740051299505;5199.948000520098;5201.92197117036;5235.685858848481;4806.567408933212;5002.774875130701;5012.04771093491;5024.949750502448;5082.0434132859855;4956.298817144593;4966.602671786321;4984.37695288089;4995.700257984533;5028.170351892043;4936.531029552187;4939.753012349296;4943.975280123576;4948.773052126486;4951.876203094951;4830.9854930465;4907.484714104968;5001.499850015115;5063;5063.443021267732;4981.925271120864;4987.501249874984;5021.5229553192385;5030.974845125751;5037.823676171316 13:39:33 INFO - PROCESS | 10481 | |5;yui.html;625.4589779840437;656.3370995294754;670.728355016218;688.6212583079305;728.3081072980668;12581.622551323464;13370.53203137889;13457;13486.190828550294;13585.388657510435;13857.93071034646;14453.566393008201;14484.913631477628;15046.924765376185;15090.47183348583;626.239119469844;765.1124695353391;781.4334607409626;794.519315813933;796.7928338631939;782.7064850680995;788.3693045563555;791.9010123734533;792.1603100713234;793.1434051224693;828.9378296627747;832.6045128563944;832.7543374704446;833.9874901876477;835.2107258640588;645.5513418174371;794.2176955698632;795.1134485049187;823.5141266652673;827.1067247372823;603.0863242188088;603.5322624965687;604.3141034925347;604.5163868904903;604.6130476495047;13351.065425420224;13390.933045334808;13392.397342119531;13402.329883505785;13414.396352164078;12424.440900159514;12698.492060317576;12786.594361816615;12786.872131278662;12946.093773435863;11802.586909458214;11978.281303121754;12051.096167787451;12118.81821772674;12470.625881223577;4008.6191811777835;4017;4075.409065685459;4112.362583799516;4190.994161401241;61164;61694;62123.37876621221;62380;62503;10249.436281004468;10410.271281010257;10441.373517588969;10526.157907367393;10835.18736094796;18137;18171.454856354332;18230.270789168284;18238.270469181083;18256.45230643056;6171.506279497629;6197.25632924052;6213.347598502182;6213.627182369072;6260.342664020212;3747.063234191452;3853.845846166178;3888.7277890547957;3917.177392747555;3934.6458818706456;2789.6652401711517;2891.103757835078;2893.132060381877;2893.6382952130984;2895.826250424939;459.3729559151734;470.22178294921275;479.3456931288766;480.69235689158967;484.72855201087503;416.1411105703834;416.92078505083936;444.16053658584656;524.29482346245;527.730857262791;7422.294881986203;7633;7634.389248860078;7894.684212631545;7926.167752386032;510.6093838213769;513.3403576404377;514.0422503188069;526.0557299647143;527.2855281094139;3633.2733453309443;3743.2700623378178;3770.6040865709256;3809.8476060957805;3926.391409331558;57559.42440575625;80869.59565202137;83229.58385208035;97498.51250743702;97746;82084.17915820765;83355.16644833474;84037.57981210055;84424.15575844285;85702.57148714217;53150.46849531533;72627;72713.96637475718;73332.26667733361;75418.62290688511;6847.281035491202;6887.724491020504;7004.684789184397;7055.2591977841585;7086.929130708627;42490.150196995266;42614.36078458888;43413;43463.56536434595;44707.776461117486;62873;64834;65126.34873651392;65732;66894.66552667205;9813.803723925625;10145.239107067147;10834.67495975122;10910.2362834604;11007.339559626447;12608.684782880502;12684.619461416172;13107.475700971854;13194.80207796903;13234.139780914595;7907.762767116996;10334.328268662513;11245.437728113726;11254.662360129209;12013.75972480563;11275.323480590863;11591.782862799284;11659.591914283299;11724.296542207494;11864.584739534075;11836.82244766312;11895.226810257305;11906.583269585522;11949.761004779682;12286;9023.548822558978;9052.818943621223;9283;9345.0654934506;9481.09929556691;9683.176929960751;10128.097689452738;10190.745231369276;10246.19623816926;10277.691669249934 13:39:33 INFO - PROCESS | 10481 | __end_tp_report 13:39:33 INFO - PROCESS | 10481 | __start_cc_report 13:39:33 INFO - PROCESS | 10481 | _x_x_mozilla_cycle_collect,1051 13:39:33 INFO - PROCESS | 10481 | __end_cc_report 13:39:33 INFO - PROCESS | 10481 | __startTimestamp1468442373474__endTimestamp 13:39:33 INFO - PROCESS | 10481 | 13:39:33 INFO - PROCESS | 10481 | ------- Summary: start ------- 13:39:33 INFO - PROCESS | 10481 | Number of tests: 6 13:39:33 INFO - PROCESS | 10481 | 13:39:33 INFO - PROCESS | 10481 | [#0] dojo.html Cycles:165 Average:4539.78 Median:4656.37 stddev:463.74 (10.0%) stddev-sans-first:438.78 13:39:33 INFO - PROCESS | 10481 | Values: 2574.3 2587.4 2615.2 2622.9 2625.0 4459.2 4535.7 4594.4 4621.2 4637.7 4567.3 4583.8 4594.1 4675.4 4675.6 4265.8 4285.2 4302.8 4323.9 4384.0 4254.3 4328.5 4352.3 4367.9 4386.7 4080.8 4283.2 4303.7 4331.2 4334.5 4118.9 4177.3 4178.9 4190.2 4207.7 4158.9 4193.6 4201.1 4202.4 4246.6 4426.0 4587.5 4634.9 4640.3 4645.3 4746.7 4828.4 4874.4 4952.1 4953.1 4919.6 4948.7 4965.5 4984.8 4985.6 4476.5 4519.7 4631.6 4651.7 4656.4 4985.7 5022.8 5058.5 5074.1 5078.9 4825.7 4832.7 4865.1 4876.9 4881.5 4754.1 4900.1 4916.1 4952.9 4954.7 4876.0 4879.6 4888.6 4928.1 4950.7 4871.0 4873.8 4879.6 4891.2 4943.1 3966.5 4020.9 4122.4 4123.4 4183.2 3656.5 3667.7 3671.7 3707.5 3729.6 4255.1 4280.1 4288.2 4308.1 4327.6 4779.5 4834.2 4868.2 4882.3 4995.1 4199.1 4207.1 4217.9 4250.6 4264.9 4393.9 4402.8 4406.3 4409.0 4448.5 4482.9 4581.6 4621.3 4632.9 4676.7 4909.0 4911.1 4925.6 4933.3 4981.4 4629.8 4641.1 4643.1 4644.5 4691.5 4662.6 4752.7 4762.8 4802.0 4803.9 4838.3 4857.1 4875.9 4881.9 4928.1 4625.8 4763.5 4773.2 4773.3 4792.3 4734.9 4762.8 4793.2 4799.5 4805.0 4720.3 4736.9 4744.2 4777.7 4778.4 4682.5 4729.9 4820.1 4832.5 4868.0 4648.6 4664.9 4670.7 4694.6 4712.1 13:39:33 INFO - PROCESS | 10481 | 13:39:33 INFO - PROCESS | 10481 | [#1] ext.html Cycles:180 Average:46577.48 Median:32675.75 stddev:85688.35 (262.2%) stddev-sans-first:85859.10 13:39:33 INFO - PROCESS | 10481 | Values: 569.3 578.1 579.6 582.3 591.8 27444.7 39354.6 40922.0 40930.2 44654.6 41142.4 41638.6 41655.6 41669.4 41735.2 7536.9 7836.8 7980.8 7982.1 7986.5 7669.5 7739.8 7744.4 10087.3 10396.8 10383.8 10437.4 10447.1 10449.9 10456.8 10200.5 10240.5 10250.9 10269.2 10270.6 7477.5 9992.6 10374.9 10383.8 10666.9 39233.4 39456.4 39474.0 39576.0 39615.8 2826.2 2904.5 2958.8 3169.0 3636.8 29406.7 29746.0 30009.5 30192.4 30747.7 2920.2 2963.9 2966.2 2972.1 3014.4 258722.0 258763.0 259735.0 260653.0 260929.0 31997.5 50824.2 51422.0 51466.6 51477.7 31924.4 33833.0 33838.0 33838.3 33859.5 13648.4 13839.7 13852.8 13853.7 13857.2 10438.2 11292.3 11420.1 11433.4 11446.1 7689.3 7878.4 7903.5 7994.1 8065.8 3045.2 3072.1 3100.8 3115.1 3134.9 813.9 845.4 905.3 952.8 962.9 27400.5 27922.6 27957.3 28164.0 28489.1 947.9 964.2 968.3 969.7 987.6 14913.5 14944.9 14976.5 15059.1 15183.2 394301.0 395815.0 398700.0 398811.0 399435.0 49108.3 49560.3 49620.5 49681.5 49715.5 1069.2 1103.4 1165.6 1174.1 1177.9 28294.0 29196.9 29361.7 29905.7 29916.1 41246.4 41528.4 41565.2 41673.4 41685.6 298791.0 303524.0 303569.0 303976.0 304088.0 22012.1 24100.9 24918.1 25077.7 25134.7 40566.6 41122.0 41434.0 41518.4 42536.8 34948.6 35568.3 36093.0 36149.8 36273.6 35877.8 36237.5 36238.8 36414.1 36844.8 34534.3 34824.7 35209.1 35850.5 35869.0 30269.0 32178.8 32325.5 32675.5 32676.0 24498.7 24707.5 24951.9 25316.9 25436.7 13:39:33 INFO - PROCESS | 10481 | 13:39:33 INFO - PROCESS | 10481 | [#2] jquery.html Cycles:180 Average:24392.85 Median:34100.55 stddev:57938.66 (169.9%) stddev-sans-first:58073.07 13:39:33 INFO - PROCESS | 10481 | Values: 350.2 364.7 368.0 377.4 399.7 13102.9 17438.0 17603.9 18494.4 19665.7 17663.3 17717.5 17882.3 18066.0 18294.5 5443.3 5762.0 5766.1 5842.7 5848.2 4125.5 5721.4 6596.0 6939.3 6939.8 6827.2 6887.7 7026.9 7034.0 7038.8 6956.1 6992.1 7004.4 7017.2 7020.5 6517.4 6820.4 6836.5 6841.2 6843.3 23971.5 24103.6 24490.9 24730.8 24786.4 1902.4 1956.4 1981.6 1987.0 2063.9 14004.9 14641.4 14758.4 14774.4 15255.5 1861.5 1908.9 1909.9 1912.1 1922.2 78300.6 79320.6 81354.6 82011.6 83883.0 13943.0 14888.2 16465.7 17005.6 17158.7 29947.7 30046.5 30210.4 30442.0 30442.2 8978.4 8981.4 9110.9 9252.2 9367.8 7646.4 7675.7 7771.9 7782.9 7798.5 8405.8 8436.8 8525.3 8558.1 8605.7 3178.3 3200.5 3295.6 3324.4 3412.5 781.7 834.8 839.6 883.6 911.2 16499.9 17391.7 17416.0 17515.4 17811.7 795.6 804.3 805.9 818.3 871.9 9087.0 9649.2 9658.8 9679.6 9710.6 344675.0 345848.0 346136.0 348324.0 363751.0 49757.8 49960.0 61683.7 79834.0 81656.0 845.2 883.3 886.1 895.2 899.2 11698.8 15046.8 15687.4 16072.0 16570.8 36220.5 37845.8 39492.0 39823.4 39961.8 49733.3 50267.0 50496.0 50593.5 50914.7 5937.0 7314.8 7577.4 7603.6 7692.8 10471.8 10812.5 11029.8 11148.1 11279.9 9424.9 9530.5 9573.4 9627.8 9853.9 9397.8 9428.7 9478.9 9578.2 9841.5 9329.6 9347.6 9553.9 9770.0 9963.7 7361.8 7461.5 7480.9 7607.8 7656.7 7382.6 8765.4 9632.7 9688.8 9792.5 13:39:33 INFO - PROCESS | 10481 | 13:39:33 INFO - PROCESS | 10481 | [#3] mootools.html Cycles:180 Average:5189.91 Median:5158.82 stddev:2978.47 (57.7%) stddev-sans-first:2972.83 13:39:33 INFO - PROCESS | 10481 | Values: 1348.0 1395.0 1441.7 1648.1 1687.7 7712.0 8129.9 8199.0 8202.0 8203.9 6566.5 6721.8 6773.3 6950.0 8017.8 1848.8 2133.5 2178.3 2194.1 2218.2 2203.1 2217.6 2236.4 2236.7 2238.6 1686.7 2206.1 2209.9 2210.5 2212.3 1843.8 1873.4 1874.6 2070.1 2136.8 2125.1 2129.4 2132.2 2133.0 2133.6 8016.7 8074.6 8075.2 8078.9 8082.4 4436.0 4587.8 4588.8 4594.7 4597.2 2700.1 2708.1 2779.5 2785.3 2790.3 779.3 826.2 835.1 840.2 841.6 11052.4 11058.7 11082.6 11107.1 11121.2 4050.6 4099.8 4257.1 4264.8 4273.0 9361.2 9365.1 9366.7 9387.6 9394.5 4671.6 4671.8 4686.0 4689.3 4694.7 4216.9 4230.5 4237.3 4238.8 4241.8 3738.1 3741.4 3755.9 3762.3 3866.3 1151.0 1159.9 1177.1 1179.4 1213.5 794.1 800.2 807.4 824.8 831.9 5203.5 5287.2 5411.9 5451.9 5478.7 848.0 850.4 878.8 879.1 879.6 3563.3 3567.2 3606.5 3696.7 3821.5 9587.6 9709.7 9957.3 9974.6 9980.7 9627.4 10042.6 10050.8 10063.2 10067.3 7453.0 7559.7 7573.5 7578.5 7600.4 5093.7 5155.8 5161.9 5209.3 5443.9 8604.7 8928.9 8966.7 8991.6 9171.8 9154.5 9361.5 9374.3 9376.5 9430.6 5976.4 6129.6 6132.2 6288.9 6289.6 7405.5 7582.9 7607.6 7860.3 7861.8 6788.7 6815.9 6915.4 7005.9 7048.1 6948.3 7001.8 7015.6 7093.4 7122.9 6456.9 6635.8 6636.9 6637.4 6641.8 4271.6 4432.0 4446.3 4466.3 4495.2 4509.7 4613.7 4634.2 4661.3 4756.4 13:39:33 INFO - PROCESS | 10481 | 13:39:33 INFO - PROCESS | 10481 | [#4] prototype.html Cycles:180 Average:4147.77 Median:4719.26 stddev:1208.89 (25.6%) stddev-sans-first:1177.05 13:39:33 INFO - PROCESS | 10481 | Values: 287.5 297.9 306.1 306.7 307.2 4742.4 4819.9 4861.2 4865.6 4867.6 4534.2 4659.8 4665.1 4708.3 4796.7 3680.7 3727.8 3743.4 3796.9 3798.2 3777.9 3795.2 3807.9 3815.4 3829.5 3605.4 3766.2 3785.3 3787.0 3803.9 3584.0 3711.6 3737.3 3749.1 3762.6 3341.5 3347.4 3386.5 3387.6 3396.1 4666.7 4678.9 4758.6 4759.5 4766.1 4042.3 4289.1 4332.1 4345.6 4349.1 4962.3 5008.9 5009.7 5010.6 5014.6 3581.7 3592.6 3606.0 3607.4 3615.7 5035.8 5303.9 5312.7 5326.0 5332.2 3676.7 3682.8 3692.0 3697.9 3702.2 3733.8 3737.5 3749.7 3758.6 3761.9 4272.6 4275.3 4278.7 4286.2 4286.6 4783.8 5017.8 5025.4 5093.4 5122.2 1268.2 1277.6 1288.0 1288.5 1292.2 812.4 816.4 830.0 842.3 842.6 4027.8 4046.4 4055.8 4076.8 4087.6 4534.9 4589.4 4591.8 4595.6 4656.9 3991.3 4008.2 4018.6 4058.3 4229.7 2521.7 2549.2 2663.7 2710.2 2715.2 4891.0 4897.3 4898.8 4952.3 4968.9 5277.6 5324.4 5335.3 5336.0 5344.8 4730.2 4855.9 4874.8 4907.7 4913.2 5157.3 5176.0 5189.5 5230.3 5234.6 5081.2 5135.7 5152.9 5174.2 5179.5 4774.6 4889.4 4910.8 4919.6 4925.4 3629.1 3642.3 3656.6 3657.2 3659.2 5189.9 5199.0 5199.9 5201.9 5235.7 4806.6 5002.8 5012.0 5024.9 5082.0 4956.3 4966.6 4984.4 4995.7 5028.2 4936.5 4939.8 4944.0 4948.8 4951.9 4831.0 4907.5 5001.5 5063.0 5063.4 4981.9 4987.5 5021.5 5031.0 5037.8 13:39:33 INFO - PROCESS | 10481 | 13:39:33 INFO - PROCESS | 10481 | [#5] yui.html Cycles:180 Average:17230.96 Median:464.80 stddev:24078.07 (5180.3%) stddev-sans-first:24113.33 13:39:33 INFO - PROCESS | 10481 | Values: 625.5 656.3 670.7 688.6 728.3 12581.6 13370.5 13457.0 13486.2 13585.4 13857.9 14453.6 14484.9 15046.9 15090.5 626.2 765.1 781.4 794.5 796.8 782.7 788.4 791.9 792.2 793.1 828.9 832.6 832.8 834.0 835.2 645.6 794.2 795.1 823.5 827.1 603.1 603.5 604.3 604.5 604.6 13351.1 13390.9 13392.4 13402.3 13414.4 12424.4 12698.5 12786.6 12786.9 12946.1 11802.6 11978.3 12051.1 12118.8 12470.6 4008.6 4017.0 4075.4 4112.4 4191.0 61164.0 61694.0 62123.4 62380.0 62503.0 10249.4 10410.3 10441.4 10526.2 10835.2 18137.0 18171.5 18230.3 18238.3 18256.5 6171.5 6197.3 6213.3 6213.6 6260.3 3747.1 3853.8 3888.7 3917.2 3934.6 2789.7 2891.1 2893.1 2893.6 2895.8 459.4 470.2 479.3 480.7 484.7 416.1 416.9 444.2 524.3 527.7 7422.3 7633.0 7634.4 7894.7 7926.2 510.6 513.3 514.0 526.1 527.3 3633.3 3743.3 3770.6 3809.8 3926.4 57559.4 80869.6 83229.6 97498.5 97746.0 82084.2 83355.2 84037.6 84424.2 85702.6 53150.5 72627.0 72714.0 73332.3 75418.6 6847.3 6887.7 7004.7 7055.3 7086.9 42490.2 42614.4 43413.0 43463.6 44707.8 62873.0 64834.0 65126.3 65732.0 66894.7 9813.8 10145.2 10834.7 10910.2 11007.3 12608.7 12684.6 13107.5 13194.8 13234.1 7907.8 10334.3 11245.4 11254.7 12013.8 11275.3 11591.8 11659.6 11724.3 11864.6 11836.8 11895.2 11906.6 11949.8 12286.0 9023.5 9052.8 9283.0 9345.1 9481.1 9683.2 10128.1 10190.7 10246.2 10277.7 13:39:33 INFO - PROCESS | 10481 | -------- Summary: end -------- 13:39:33 INFO - PROCESS | 10481 | 13:39:34 INFO - TEST-INFO | 10481: exit 0 13:39:34 INFO - TEST-OK | dromaeo_css | took 1119443ms 13:39:34 INFO - TEST-START | kraken 13:39:34 INFO - operating with platform_type : linux_ 13:39:34 INFO - Initialising browser for kraken test... 13:39:34 INFO - TEST-INFO | started process 10669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGX4TPu/profile http://localhost:59875/getInfo.html) 13:39:38 INFO - PROCESS | 10669 | __metrics Screen width/height:1600/1200 13:39:38 INFO - PROCESS | 10669 | colorDepth:24 13:39:38 INFO - PROCESS | 10669 | Browser inner width/height: 1024/697 13:39:38 INFO - PROCESS | 10669 | __metrics 13:39:39 INFO - PROCESS | 10669 | 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" 13:39:39 INFO - PROCESS | 10669 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:39:40 INFO - TEST-INFO | 10669: exit 0 13:39:40 INFO - Browser initialized. 13:39:40 INFO - Running cycle 1/1 for kraken test... 13:39:40 INFO - TEST-INFO | started process 10753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGX4TPu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:39:52 INFO - PROCESS | 10753 | RSS: Main: 159498240 13:39:52 INFO - PROCESS | 10753 | 13:39:55 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:59875/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59875/tests/kraken/driver.html?testName=audio-beat-detection) 13:39:56 INFO - PROCESS | 10753 | RSS: Main: 217571328 13:39:56 INFO - PROCESS | 10753 | 13:39:58 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:59875/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59875/tests/kraken/driver.html?testName=audio-dft) 13:39:59 INFO - PROCESS | 10753 | RSS: Main: 205422592 13:39:59 INFO - PROCESS | 10753 | 13:40:02 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:59875/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59875/tests/kraken/driver.html?testName=audio-fft) 13:40:03 INFO - PROCESS | 10753 | RSS: Main: 271233024 13:40:03 INFO - PROCESS | 10753 | 13:40:05 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:59875/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59875/tests/kraken/driver.html?testName=audio-oscillator) 13:40:06 INFO - PROCESS | 10753 | RSS: Main: 181829632 13:40:06 INFO - PROCESS | 10753 | 13:40:08 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:59875/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59875/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:40:08 INFO - PROCESS | 10753 | RSS: Main: 185683968 13:40:08 INFO - PROCESS | 10753 | 13:40:12 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:59875/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59875/tests/kraken/driver.html?testName=imaging-darkroom) 13:40:12 INFO - PROCESS | 10753 | RSS: Main: 222175232 13:40:12 INFO - PROCESS | 10753 | 13:40:16 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:59875/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59875/tests/kraken/driver.html?testName=imaging-desaturate) 13:40:16 INFO - PROCESS | 10753 | RSS: Main: 217661440 13:40:16 INFO - PROCESS | 10753 | 13:40:19 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:59875/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59875/tests/kraken/driver.html?testName=json-parse-financial) 13:40:20 INFO - PROCESS | 10753 | RSS: Main: 220688384 13:40:20 INFO - PROCESS | 10753 | 13:40:22 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:59875/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59875/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:40:22 INFO - PROCESS | 10753 | RSS: Main: 206733312 13:40:22 INFO - PROCESS | 10753 | 13:40:24 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:59875/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59875/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:40:25 INFO - PROCESS | 10753 | RSS: Main: 212140032 13:40:25 INFO - PROCESS | 10753 | 13:40:27 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:59875/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59875/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:40:28 INFO - PROCESS | 10753 | RSS: Main: 213434368 13:40:28 INFO - PROCESS | 10753 | 13:40:30 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:59875/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59875/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:40:31 INFO - PROCESS | 10753 | RSS: Main: 224972800 13:40:31 INFO - PROCESS | 10753 | 13:40:34 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:59875/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59875/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:40:34 INFO - PROCESS | 10753 | RSS: Main: 226672640 13:40:34 INFO - PROCESS | 10753 | 13:40:36 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:59875/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59875/tests/kraken/driver.html?testName=ai-astar) 13:40:36 INFO - PROCESS | 10753 | RSS: Main: 269615104 13:40:36 INFO - PROCESS | 10753 | 13:40:36 INFO - PROCESS | 10753 | __start_tp_report 13:40:36 INFO - PROCESS | 10753 | _x_x_mozilla_page_load 13:40:36 INFO - PROCESS | 10753 | _x_x_mozilla_page_load_details 13:40:36 INFO - PROCESS | 10753 | |i|pagename|runs| 13:40:36 INFO - PROCESS | 10753 | |0;ai-astar;106;116;115;116;114;113;114;113;115;113 13:40:36 INFO - PROCESS | 10753 | |1;audio-beat-detection;151;120;124;179;124;123;146;127;168;123 13:40:36 INFO - PROCESS | 10753 | |2;audio-dft;162;162;161;160;161;162;162;161;160;160 13:40:36 INFO - PROCESS | 10753 | |3;audio-fft;76;75;76;113;77;76;77;76;112;75 13:40:36 INFO - PROCESS | 10753 | |4;audio-oscillator;86;86;123;85;84;85;115;84;85;133 13:40:36 INFO - PROCESS | 10753 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 13:40:36 INFO - PROCESS | 10753 | |6;imaging-darkroom;146;146;147;146;147;146;147;145;146;147 13:40:36 INFO - PROCESS | 10753 | |7;imaging-desaturate;95;95;95;95;95;96;94;95;95;96 13:40:36 INFO - PROCESS | 10753 | |8;json-parse-financial;64;65;66;64;65;65;64;64;74;71 13:40:36 INFO - PROCESS | 10753 | |9;json-stringify-tinderbox;66;65;66;65;65;65;65;65;67;65 13:40:36 INFO - PROCESS | 10753 | |10;stanford-crypto-aes;80;79;78;78;79;88;80;79;89;93 13:40:36 INFO - PROCESS | 10753 | |11;stanford-crypto-ccm;137;134;128;135;127;126;129;128;169;140 13:40:36 INFO - PROCESS | 10753 | |12;stanford-crypto-pbkdf2;175;167;168;165;170;174;166;167;166;167 13:40:36 INFO - PROCESS | 10753 | |13;stanford-crypto-sha256-iterative;68;66;73;67;66;65;66;65;69;64 13:40:36 INFO - PROCESS | 10753 | __end_tp_report 13:40:36 INFO - PROCESS | 10753 | __start_cc_report 13:40:36 INFO - PROCESS | 10753 | _x_x_mozilla_cycle_collect,1898 13:40:36 INFO - PROCESS | 10753 | __end_cc_report 13:40:36 INFO - PROCESS | 10753 | __startTimestamp1468442436904__endTimestamp 13:40:36 INFO - PROCESS | 10753 | 13:40:36 INFO - PROCESS | 10753 | ------- Summary: start ------- 13:40:36 INFO - PROCESS | 10753 | Number of tests: 14 13:40:36 INFO - PROCESS | 10753 | 13:40:36 INFO - PROCESS | 10753 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.50 stddev:2.88 (2.5%) stddev-sans-first:1.22 13:40:36 INFO - PROCESS | 10753 | Values: 106.0 116.0 115.0 116.0 114.0 113.0 114.0 113.0 115.0 113.0 13:40:36 INFO - PROCESS | 10753 | 13:40:36 INFO - PROCESS | 10753 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:136.50 stddev:21.34 (15.6%) stddev-sans-first:22.15 13:40:36 INFO - PROCESS | 10753 | Values: 151.0 120.0 124.0 179.0 124.0 123.0 146.0 127.0 168.0 123.0 13:40:36 INFO - PROCESS | 10753 | 13:40:36 INFO - PROCESS | 10753 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.87 13:40:36 INFO - PROCESS | 10753 | Values: 162.0 162.0 161.0 160.0 161.0 162.0 162.0 161.0 160.0 160.0 13:40:36 INFO - PROCESS | 10753 | 13:40:36 INFO - PROCESS | 10753 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:15.41 (20.3%) stddev-sans-first:16.11 13:40:36 INFO - PROCESS | 10753 | Values: 76.0 75.0 76.0 113.0 77.0 76.0 77.0 76.0 112.0 75.0 13:40:36 INFO - PROCESS | 10753 | 13:40:36 INFO - PROCESS | 10753 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:85.00 stddev:19.17 (22.5%) stddev-sans-first:19.94 13:40:36 INFO - PROCESS | 10753 | Values: 86.0 86.0 123.0 85.0 84.0 85.0 115.0 84.0 85.0 133.0 13:40:36 INFO - PROCESS | 10753 | 13:40:36 INFO - PROCESS | 10753 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 13:40:36 INFO - PROCESS | 10753 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 13:40:36 INFO - PROCESS | 10753 | 13:40:36 INFO - PROCESS | 10753 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 13:40:36 INFO - PROCESS | 10753 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 147.0 145.0 146.0 147.0 13:40:36 INFO - PROCESS | 10753 | 13:40:36 INFO - PROCESS | 10753 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 13:40:36 INFO - PROCESS | 10753 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 94.0 95.0 95.0 96.0 13:40:36 INFO - PROCESS | 10753 | 13:40:36 INFO - PROCESS | 10753 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:65.00 stddev:3.46 (5.3%) stddev-sans-first:3.57 13:40:36 INFO - PROCESS | 10753 | Values: 64.0 65.0 66.0 64.0 65.0 65.0 64.0 64.0 74.0 71.0 13:40:36 INFO - PROCESS | 10753 | 13:40:36 INFO - PROCESS | 10753 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 13:40:36 INFO - PROCESS | 10753 | Values: 66.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 67.0 65.0 13:40:36 INFO - PROCESS | 10753 | 13:40:36 INFO - PROCESS | 10753 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:80.00 stddev:5.50 (6.9%) stddev-sans-first:5.77 13:40:36 INFO - PROCESS | 10753 | Values: 80.0 79.0 78.0 78.0 79.0 88.0 80.0 79.0 89.0 93.0 13:40:36 INFO - PROCESS | 10753 | 13:40:36 INFO - PROCESS | 10753 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:134.50 stddev:12.75 (9.5%) stddev-sans-first:13.51 13:40:36 INFO - PROCESS | 10753 | Values: 137.0 134.0 128.0 135.0 127.0 126.0 129.0 128.0 169.0 140.0 13:40:36 INFO - PROCESS | 10753 | 13:40:36 INFO - PROCESS | 10753 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:167.50 stddev:3.44 (2.1%) stddev-sans-first:2.73 13:40:36 INFO - PROCESS | 10753 | Values: 175.0 167.0 168.0 165.0 170.0 174.0 166.0 167.0 166.0 167.0 13:40:36 INFO - PROCESS | 10753 | 13:40:36 INFO - PROCESS | 10753 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.50 stddev:2.60 (3.9%) stddev-sans-first:2.73 13:40:36 INFO - PROCESS | 10753 | Values: 68.0 66.0 73.0 67.0 66.0 65.0 66.0 65.0 69.0 64.0 13:40:36 INFO - PROCESS | 10753 | -------- Summary: end -------- 13:40:36 INFO - PROCESS | 10753 | 13:40:38 INFO - TEST-INFO | 10753: exit 0 13:40:38 INFO - TEST-OK | kraken | took 63825ms 13:40:38 INFO - SUITE-END | took 1183s 13:40:38 INFO - Completed test suite (00:19:43) 13:40:38 INFO - javascript benchmark 13:40:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2574.253466494716, 2587.4436996045847, 2615.1500762252263, 2622.8688565571715, 2625.0418597212024, 4459.241928872091, 4535.70517916336, 4594.402727645405, 4621.214393553096, 4637.698549594278, 4567.337736028274, 4583.839565615204, 4594.081183763244, 4675.438947326317, 4675.602573781224, 4265.765382903939, 4285.185814695214, 4302.827886884521, 4323.913521729579, 4384.0, 4254.319308910575, 4328.545502722216, 4352.260115780325, 4367.934480982788, 4386.6929314947965, 4080.8163632636306, 4283.229018776619, 4303.655707543405, 4331.198728235287, 4334.479862416514, 4118.897027574305, 4177.3316269396755, 4178.895527611804, 4190.161967606491, 4207.705460617758, 4158.9376159357635, 4193.580641935812, 4201.117765269297, 4202.3696445533105, 4246.57534246576, 4426.048399594103, 4587.518310577375, 4634.86095417138, 4640.257558790611, 4645.256758918591, 4746.715197088186, 4828.420589529243, 4874.4150701916, 4952.108620448318, 4953.083679519301, 4919.631027672939, 4948.653594248404, 4965.503449655042, 4984.750762461862, 4985.551300382983, 4476.529964353696, 4519.728816271035, 4631.58315751584, 4651.744154071558, 4656.3713898623255, 4985.675931064469, 5022.7990880365105, 5058.46886076964, 5074.13739664258, 5078.873028174251, 4825.686330388514, 4832.710037397767, 4865.099956508057, 4876.853694389174, 4881.487443818419, 4754.144254034307, 4900.068986892479, 4916.115099282163, 4952.925706114411, 4954.653174277766, 4875.95124048762, 4879.609631229493, 4888.584470319992, 4928.137575924199, 4950.702957822542, 4871.025794841046, 4873.756312184448, 4879.585235255043, 4891.1685013547785, 4943.060818444484, 3966.5438474575217, 4020.8793736187963, 4122.40225167349, 4123.4021066945725, 4183.247015537172, 3656.451532270181, 3667.6807489222297, 3671.687906527975, 3707.5180226570374, 3729.5710993236125, 4255.063885945087, 4280.143971205771, 4288.24955632763, 4308.095299987038, 4327.567243275647, 4779.5220477951925, 4834.20235661119, 4868.196747536616, 4882.292067650242, 4995.075910956485, 4199.076203235283, 4207.137536804948, 4217.915641687149, 4250.553691862372, 4264.914701705949, 4393.934090988638, 4402.757848318309, 4406.294992801137, 4409.007973206003, 4448.466184057934, 4482.910341793081, 4581.633469322513, 4621.30680397943, 4632.884177895579, 4676.742779147112, 4909.042736666459, 4911.066897289504, 4925.556699897026, 4933.309336692938, 4981.402231732215, 4629.837955671535, 4641.141388843075, 4643.117807616542, 4644.512326205835, 4691.483936767021, 4662.557057079572, 4752.714837109785, 4762.809487620457, 4801.975990120167, 4803.879903002453, 4838.250071238964, 4857.0528746894015, 4875.90248195027, 4881.926771098365, 4928.088303663833, 4625.768711564476, 4763.499832517675, 4773.164696178085, 4773.284007398918, 4792.329073929723, 4734.905301894012, 4762.761861906822, 4793.23308270689, 4799.544043315879, 4805.038992201504, 4720.268358404453, 4736.881577960578, 4744.217204161275, 4777.665563410667, 4778.37881075458, 4682.484926658133, 4729.905401891874, 4820.108279968217, 4832.516748325139, 4868.026394721141, 4648.628109751279, 4664.93002604968, 4670.696404733681, 4694.6244300456565, 4712.104700106968], "value": 4511.104269127425, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.308290427131, 578.1010528627982, 579.6377264209868, 582.3390451837165, 591.7839988404231, 27444.725552744465, 39354.606453935485, 40922.0, 40930.181396372056, 44654.553454465444, 41142.38286425706, 41638.58361416385, 41655.583444165546, 41669.37495937564, 41735.165296694126, 7536.924630753704, 7836.8040798980055, 7980.800479987989, 7982.082060563022, 7986.480878742892, 7669.501482403653, 7739.7678069658, 7744.380449564022, 10087.344322619043, 10396.844047339297, 10383.792324153512, 10437.373757574533, 10447.059764621183, 10449.895501044968, 10456.790864182749, 10200.540975656113, 10240.539175737034, 10250.9487452563, 10269.178465722762, 10270.640527581574, 7477.513961592534, 9992.600295988152, 10374.948125259401, 10383.84424233637, 10666.946665266702, 39233.41149882754, 39456.40815387772, 39474.0, 39576.0, 39615.801920990496, 2826.1662809471254, 2904.549794781791, 2958.792884498086, 3168.984155079233, 3636.7636103653176, 29406.70593294061, 29746.0, 30009.549856752164, 30192.396152076835, 30747.692523074707, 2920.182348942278, 2963.866626001835, 2966.1546459259007, 2972.078655616766, 3014.351914338406, 258722.0, 258763.0, 259735.0, 260653.0, 260929.0, 31997.52003719946, 50824.237636435486, 51422.0, 51466.5666791651, 51477.7426112867, 31924.36151277008, 33833.0, 33837.96972181677, 33838.32323353568, 33859.492107618404, 13648.385822638005, 13839.723205535833, 13852.792208116887, 13853.722925541433, 13857.168569885838, 10438.217133715001, 11292.266002709797, 11420.086393088533, 11433.428328583537, 11446.08431325492, 7689.307962283309, 7878.448508604457, 7903.525788452711, 7994.120646728855, 8065.758027259074, 3045.2234680156416, 3072.0937323489625, 3100.8449577521483, 3115.143335582733, 3134.9216269593444, 813.938954578409, 845.3659755183612, 905.330055758747, 952.7728068131595, 962.8748262725801, 27400.451990960068, 27922.581161282596, 27957.30106747307, 28164.0, 28489.145325640264, 947.924166066713, 964.1852634523816, 968.2689569375218, 969.6606187834343, 987.6000219910948, 14913.478028268959, 14944.925275373553, 14976.47582334613, 15059.096454212782, 15183.16492592918, 394301.0, 395815.0, 398700.0, 398811.0, 399435.0, 49108.263376049385, 49560.256596151085, 49620.50379496231, 49681.50318496841, 49715.50284497109, 1069.187417562658, 1103.4096758234145, 1165.6153469355093, 1174.1487421619258, 1177.8998785103363, 28294.0, 29196.854015730634, 29361.70638293675, 29905.700942991163, 29916.102516924526, 41246.38130428106, 41528.37707434451, 41565.168696626504, 41673.37489937593, 41685.58314416938, 298791.0, 303524.0, 303569.0, 303976.0, 304088.0, 22012.119515219212, 24100.87949560241, 24918.12786552462, 25077.74922250754, 25134.74865251324, 40566.59433405628, 41122.0, 41434.0, 41518.37722434106, 42536.78731606322, 34948.56699230167, 35568.28863422769, 36093.0, 36149.81925090358, 36273.63726362808, 35877.82061089678, 36237.45643815292, 36238.8188059058, 36414.08964775902, 36844.81577592095, 34534.30931381308, 34824.65175348315, 35209.119772005906, 35850.46224306586, 35869.0, 30269.0, 32178.83910580432, 32325.51511727279, 32675.509867352484, 32676.0, 24498.67262610049, 24707.505849883262, 24951.87524062368, 25316.873415632803, 25436.745632543436], "value": 16792.034263304842, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.24871650310104, 364.66450865204007, 367.99080022999425, 377.3999341047734, 399.658292160203, 13102.868971310285, 17438.0, 17603.911980440094, 18494.44516664499, 19665.70501442476, 17663.293468261254, 17717.46847594571, 17882.28470861167, 18066.0, 18294.451166464994, 5443.292371991645, 5762.049261871786, 5766.077427611583, 5842.707864606774, 5848.181254624356, 4125.463689720347, 5721.427857214266, 6596.0, 6939.306069393071, 6939.826504337381, 6827.180738311385, 6887.691338645666, 7026.89459658103, 7033.964830175842, 7038.788836334918, 6956.060931774196, 6992.056072430259, 7004.4396448284015, 7017.228104908456, 7020.508564400494, 6517.4134327910715, 6820.386165245102, 6836.521443498957, 6841.2132604750595, 6843.281455447156, 23971.52056958851, 24103.638445423334, 24490.87754561216, 24730.752692473026, 24786.38034049145, 1902.3722171683312, 1956.3739603326942, 1981.6433042052424, 1987.0, 2063.9484012899798, 14004.92997535016, 14641.41434342625, 14758.409663613442, 14774.409023639042, 15255.542333730005, 1861.4880907750342, 1908.885466871992, 1909.9427017189507, 1912.1108684461792, 1922.2407149175997, 78300.60849695715, 79320.60339698322, 81354.59322703349, 82011.5899420505, 83883.0, 13943.0, 14888.181150036851, 16465.67068658644, 17005.57486062858, 17158.656826863393, 29947.700522994928, 30046.54930176049, 30210.395792084037, 30442.0, 30442.238944026576, 8978.416402933788, 8981.371304008788, 9110.86333704995, 9252.213561847318, 9367.765805854908, 7646.3882889368715, 7675.731349402744, 7771.883421748678, 7782.883256751154, 7798.454108212484, 8405.789855253668, 8436.831263374697, 8525.275351595059, 8558.101399353103, 8605.698800541952, 3178.253110519026, 3200.487921932526, 3295.6210035845706, 3324.384988777084, 3412.488126781003, 781.7498400511895, 834.8372067446911, 839.6431516605418, 883.5802993578128, 911.1844898815523, 16499.917500412423, 17391.73912391315, 17416.0, 17515.386961456286, 17811.73282400765, 795.5743677132706, 804.3484777330265, 805.8831469437016, 818.2650209018701, 871.899731530882, 9086.954565227265, 9649.228061755042, 9658.75853103664, 9679.612815487302, 9710.563024663907, 344675.0, 345848.0, 346136.0, 348324.0, 363751.0, 49757.75121124371, 49960.0, 61683.6915815418, 79834.0, 81656.0, 845.2139510255645, 883.3419102768479, 886.1271647427279, 895.1987970766128, 899.1907283444821, 11698.76602467929, 15046.849531504546, 15687.352553080653, 16072.0, 16570.83429165693, 36220.456693150154, 37845.81077094707, 39492.0, 39823.402648960866, 39961.80019099886, 49733.254001189285, 50267.0, 50496.0, 50593.494065058876, 50914.74542627263, 5937.0, 7314.780556583311, 7577.393808495417, 7603.619819008917, 7692.7692169235015, 10471.790564188826, 10812.513436895515, 11029.779404411707, 11148.108151348035, 11279.887201127884, 9424.858627120462, 9530.523473826419, 9573.425594464354, 9627.759306017406, 9853.852192217266, 9397.81204375895, 9428.717138485856, 9478.85781713261, 9578.185854202471, 9841.458719770195, 9329.580168892551, 9347.579358928728, 9553.904460955302, 9769.951150244204, 9963.651272205729, 7361.82210846262, 7461.477696561188, 7480.887786683313, 7607.771766847003, 7656.732014379692, 7382.630868456448, 8765.430247033923, 9632.711018669452, 9688.75778105553, 9792.461414622265], "value": 9167.53187967387, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.973040539189, 1394.9816633857283, 1441.7260720463112, 1648.085312651478, 1687.7468379743036, 7712.0, 8129.878051829212, 8199.0, 8201.958990205056, 8203.91796082039, 6566.474682025427, 6721.831954201148, 6773.254941956381, 6950.026996220533, 8017.759467215993, 1848.7873894502102, 2133.4666333416644, 2178.3247193370107, 2194.100418828281, 2218.223621732389, 2203.0526873444414, 2217.5786600545925, 2236.4408897775556, 2236.664500324956, 2238.597052530544, 1686.7132587460162, 2206.0734491513604, 2209.9005544750526, 2210.5026369066914, 2212.314182603398, 1843.778746550409, 1873.372420239208, 1874.6344462829686, 2070.078814927358, 2136.8290536757177, 2125.1180759984586, 2129.446343950584, 2132.1791110422446, 2132.9761714377187, 2133.573285342922, 8016.7194148204535, 8074.555899425529, 8075.232852878967, 8078.8788168177525, 8082.43422960393, 4435.955640443586, 4587.816487340502, 4588.839390621312, 4594.74728889911, 4597.195490789099, 2700.0954680182163, 2708.0521817363765, 2779.5274803283287, 2785.2758282846607, 2790.2884764384953, 779.2830595851773, 826.2068414322258, 835.1147783349669, 840.2437805974611, 841.6296829395108, 11052.447377631086, 11058.668239952814, 11082.556697732081, 11107.111431085574, 11121.165912556591, 4050.5746896575433, 4099.7745124017865, 4257.063446041866, 4264.829406823755, 4272.957270427318, 9361.157495825271, 9365.11031452011, 9366.67216647414, 9387.57755900986, 9394.530273486298, 4671.579557839811, 4671.813127474863, 4686.0, 4689.296605509133, 4694.6713730039255, 4216.936745948813, 4230.534641189467, 4237.279662457389, 4238.830446782156, 4241.830326786894, 3738.0841693785196, 3741.401375779862, 3755.9248815024093, 3762.3415902217002, 3866.3427217373114, 1150.9844208174468, 1159.8724140344555, 1177.0818761366147, 1179.404400777619, 1213.4963989944074, 794.0511089248292, 800.2117913854848, 807.4428644235459, 824.7608193623902, 831.8876951611576, 5203.505666961632, 5287.233351164136, 5411.891762164813, 5451.945480545144, 5478.671279723229, 847.9745607631781, 850.4047166983013, 878.7978764884112, 879.1033146190978, 879.6173664455982, 3563.2873425315042, 3567.1795487038125, 3606.495090687306, 3696.704263658901, 3821.541415030214, 9587.616495340108, 9709.66016189444, 9957.302988790716, 9974.551145198338, 9980.650677226262, 9627.374220675634, 10042.648507302209, 10050.849237261447, 10063.19494440443, 10067.345622534658, 7453.031105956191, 7559.697612095564, 7573.507721998052, 7578.507397019176, 7600.391968642606, 5093.668911520887, 5155.767990440364, 5161.870953226199, 5209.296744939385, 5443.863903402446, 8604.655813767378, 8928.86606700913, 8966.730998070068, 8991.55042247898, 9171.816563668555, 9154.542272886461, 9361.531923403667, 9374.296927730311, 9376.531173441437, 9430.57562409707, 5976.372480889618, 6129.632222066691, 6132.17215675878, 6288.874222515616, 6289.559730818982, 7405.518641288299, 7582.924170758442, 7607.581583012766, 7860.3318717909615, 7861.803454913673, 6788.694508747217, 6815.93184068153, 6915.446764258747, 7005.929940700527, 7048.083749112582, 6948.33990770876, 7001.824954376181, 7015.614141222281, 7093.432525397852, 7122.893156602551, 6456.935430645822, 6635.8009259722285, 6636.9004464932095, 6637.435817955527, 6641.767538136142, 4271.5514870938105, 4432.0, 4446.288593825102, 4466.263066594105, 4495.2358099123885, 4509.661775366795, 4613.746243956614, 4634.189016922092, 4661.347411362344, 4756.429228492603], "value": 4135.302639245132, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.5313239419747, 297.9106268119564, 306.10311786465655, 306.74080402060264, 307.18902098460086, 4742.383490146285, 4819.927701084483, 4861.222204447289, 4865.61075113991, 4867.610591152708, 4534.208987449963, 4659.836905708301, 4665.136949664306, 4708.2702181161885, 4796.712197268166, 3680.7239457040696, 3727.8257348935, 3743.4010558310742, 3796.905077373074, 3798.2213646202463, 3777.9055523611855, 3795.2219794942107, 3807.904802379935, 3815.351390263662, 3829.5213098362706, 3605.429001355765, 3766.2467506498674, 3785.318642644323, 3786.962130378702, 3803.9348982284864, 3584.0, 3711.610280920505, 3737.289914916157, 3749.137698329372, 3762.6425489578446, 3341.5154802553493, 3347.3640008398324, 3386.4920261960656, 3387.5934887813373, 3396.083057574466, 4666.673332866701, 4678.929816052762, 4758.595519380857, 4759.547842954914, 4766.142094423002, 4042.2925987952285, 4289.099289149282, 4332.068605249855, 4345.608895199415, 4349.064951035542, 4962.305277261186, 5008.874778130539, 5009.674371165863, 5010.649254552182, 5014.573761230264, 3581.6776490116013, 3592.6407359264126, 3606.0, 3607.4228123500116, 3615.7107431405425, 5035.798568057273, 5303.920441193385, 5312.73436328182, 5325.988062268157, 5332.226827110047, 3676.7242456815848, 3682.760620559655, 3691.9630803692157, 3697.90755231116, 3702.241040586673, 3733.775973441602, 3737.5141231639714, 3749.6625303722794, 3758.605346438639, 3761.887143385703, 4272.5727427257025, 4275.29457639486, 4278.6949980255695, 4286.249906266391, 4286.635635970977, 4783.784729687172, 5017.774200161001, 5025.422076461181, 5093.414257360377, 5122.154844450699, 1268.207370393504, 1277.5847849448967, 1287.993560032194, 1288.4974859804684, 1292.2311224821217, 812.3907069697726, 816.3591580609193, 829.9792505187298, 842.3471809347682, 842.5955541340069, 4027.7715296834162, 4046.352583586612, 4055.8174882130374, 4076.7553946763287, 4087.6321131097748, 4534.911621210886, 4589.380433641482, 4591.793369298322, 4595.621313605905, 4656.930146047812, 3991.2815693175507, 4008.238434697398, 4018.553320804508, 4058.289799285113, 4229.725067870579, 2521.722610512842, 2549.228286340975, 2663.6670416197976, 2710.1598504463677, 2715.2397328747984, 4890.95109048912, 4897.338859253955, 4898.779554920037, 4952.257161425815, 4968.90062198754, 5277.63056586043, 5324.41431442541, 5335.279737235501, 5336.0, 5344.770702738392, 4730.2431610942085, 4855.927161092586, 4874.7562621868765, 4907.68100073494, 4913.164761990471, 5157.252198431282, 5176.0, 5189.455107213688, 5230.34620672416, 5234.633575649668, 5081.18701007837, 5135.743212839268, 5152.896942061063, 5174.197999310113, 5179.45615710345, 4774.641901857444, 4889.413270407432, 4910.803567857389, 4919.606431485544, 4925.38432695913, 3629.1108678373967, 3642.2533380657433, 3656.61605531426, 3657.177135144678, 3659.1949771050326, 5189.896202075862, 5198.9740051299505, 5199.948000520098, 5201.92197117036, 5235.685858848481, 4806.567408933212, 5002.774875130701, 5012.04771093491, 5024.949750502448, 5082.0434132859855, 4956.298817144593, 4966.602671786321, 4984.37695288089, 4995.700257984533, 5028.170351892043, 4936.531029552187, 4939.753012349296, 4943.975280123576, 4948.773052126486, 4951.876203094951, 4830.9854930465, 4907.484714104968, 5001.499850015115, 5063.0, 5063.443021267732, 4981.925271120864, 4987.501249874984, 5021.5229553192385, 5030.974845125751, 5037.823676171316], "value": 3764.2711972117863, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.4589779840437, 656.3370995294754, 670.728355016218, 688.6212583079305, 728.3081072980668, 12581.622551323464, 13370.53203137889, 13457.0, 13486.190828550294, 13585.388657510435, 13857.93071034646, 14453.566393008201, 14484.913631477628, 15046.924765376185, 15090.47183348583, 626.239119469844, 765.1124695353391, 781.4334607409626, 794.519315813933, 796.7928338631939, 782.7064850680995, 788.3693045563555, 791.9010123734533, 792.1603100713234, 793.1434051224693, 828.9378296627747, 832.6045128563944, 832.7543374704446, 833.9874901876477, 835.2107258640588, 645.5513418174371, 794.2176955698632, 795.1134485049187, 823.5141266652673, 827.1067247372823, 603.0863242188088, 603.5322624965687, 604.3141034925347, 604.5163868904903, 604.6130476495047, 13351.065425420224, 13390.933045334808, 13392.397342119531, 13402.329883505785, 13414.396352164078, 12424.440900159514, 12698.492060317576, 12786.594361816615, 12786.872131278662, 12946.093773435863, 11802.586909458214, 11978.281303121754, 12051.096167787451, 12118.81821772674, 12470.625881223577, 4008.6191811777835, 4017.0, 4075.409065685459, 4112.362583799516, 4190.994161401241, 61164.0, 61694.0, 62123.37876621221, 62380.0, 62503.0, 10249.436281004468, 10410.271281010257, 10441.373517588969, 10526.157907367393, 10835.18736094796, 18137.0, 18171.454856354332, 18230.270789168284, 18238.270469181083, 18256.45230643056, 6171.506279497629, 6197.25632924052, 6213.347598502182, 6213.627182369072, 6260.342664020212, 3747.063234191452, 3853.845846166178, 3888.7277890547957, 3917.177392747555, 3934.6458818706456, 2789.6652401711517, 2891.103757835078, 2893.132060381877, 2893.6382952130984, 2895.826250424939, 459.3729559151734, 470.22178294921275, 479.3456931288766, 480.69235689158967, 484.72855201087503, 416.1411105703834, 416.92078505083936, 444.16053658584656, 524.29482346245, 527.730857262791, 7422.294881986203, 7633.0, 7634.389248860078, 7894.684212631545, 7926.167752386032, 510.6093838213769, 513.3403576404377, 514.0422503188069, 526.0557299647143, 527.2855281094139, 3633.2733453309443, 3743.2700623378178, 3770.6040865709256, 3809.8476060957805, 3926.391409331558, 57559.42440575625, 80869.59565202137, 83229.58385208035, 97498.51250743702, 97746.0, 82084.17915820765, 83355.16644833474, 84037.57981210055, 84424.15575844285, 85702.57148714217, 53150.46849531533, 72627.0, 72713.96637475718, 73332.26667733361, 75418.62290688511, 6847.281035491202, 6887.724491020504, 7004.684789184397, 7055.2591977841585, 7086.929130708627, 42490.150196995266, 42614.36078458888, 43413.0, 43463.56536434595, 44707.776461117486, 62873.0, 64834.0, 65126.34873651392, 65732.0, 66894.66552667205, 9813.803723925625, 10145.239107067147, 10834.67495975122, 10910.2362834604, 11007.339559626447, 12608.684782880502, 12684.619461416172, 13107.475700971854, 13194.80207796903, 13234.139780914595, 7907.762767116996, 10334.328268662513, 11245.437728113726, 11254.662360129209, 12013.75972480563, 11275.323480590863, 11591.782862799284, 11659.591914283299, 11724.296542207494, 11864.584739534075, 11836.82244766312, 11895.226810257305, 11906.583269585522, 11949.761004779682, 12286.0, 9023.548822558978, 9052.818943621223, 9283.0, 9345.0654934506, 9481.09929556691, 9683.176929960751, 10128.097689452738, 10190.745231369276, 10246.19623816926, 10277.691669249934], "value": 6432.107739754872, "unit": "score"}], "name": "dromaeo_css", "value": 6412.664661840346, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 115.0, 116.0, 114.0, 113.0, 114.0, 113.0, 115.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 120.0, 124.0, 179.0, 124.0, 123.0, 146.0, 127.0, 168.0, 123.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 160.0, 161.0, 162.0, 162.0, 161.0, 160.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 113.0, 77.0, 76.0, 77.0, 76.0, 112.0, 75.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 123.0, 85.0, 84.0, 85.0, 115.0, 84.0, 85.0, 133.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 145.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 64.0, 65.0, 65.0, 64.0, 64.0, 74.0, 71.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 67.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 78.0, 79.0, 88.0, 80.0, 79.0, 89.0, 93.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 134.0, 128.0, 135.0, 127.0, 126.0, 129.0, 128.0, 169.0, 140.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 167.0, 168.0, 165.0, 170.0, 174.0, 166.0, 167.0, 166.0, 167.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 73.0, 67.0, 66.0, 65.0, 66.0, 65.0, 69.0, 64.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1536.0, "alertThreshold": 2.0}]} 13:40:38 INFO - Return code: 0 13:40:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:40:38 INFO - # TBPL SUCCESS # 13:40:38 INFO - Running post-action listener: _resource_record_post_action 13:40:38 INFO - ##### 13:40:38 INFO - ##### Finished run-tests step (success) 13:40:38 INFO - ##### 13:40:38 INFO - Running post-run listener: _resource_record_post_run 13:40:38 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545067008; Read time: 20; Write time: 724276 13:40:38 INFO - TinderboxPrint: CPU usage
13.0% 13:40:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 13:40:38 INFO - TinderboxPrint: I/O write bytes / time
545,067,008 / 724,276 13:40:38 INFO - TinderboxPrint: CPU idle
8,330.3 (87.0%) 13:40:38 INFO - TinderboxPrint: CPU user
1,204.2 (12.6%) 13:40:38 INFO - TinderboxPrint: Swap in / out
0 / 0 13:40:38 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 256012288; Read time: 0; Write time: 386276 13:40:38 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 289054720; Read time: 0; Write time: 338000 13:40:39 INFO - Running post-run listener: _upload_blobber_files 13:40:39 INFO - Blob upload gear active. 13:40:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:40:39 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 13:40:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:40:39 INFO - (blobuploader) - INFO - Open directory for files ... 13:40:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:40:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:40:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:40:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:40:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:40:42 INFO - (blobuploader) - INFO - Done attempting. 13:40:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:40:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:40:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:40:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:40:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:40:43 INFO - (blobuploader) - INFO - Done attempting. 13:40:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:40:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:40:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:40:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:40:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:40:44 INFO - (blobuploader) - INFO - Done attempting. 13:40:44 INFO - (blobuploader) - INFO - Iteration through files over. 13:40:44 INFO - Return code: 0 13:40:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:40:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:40:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a7afde85e60a08cdcb8506490a61603aed2f282ee548369dc48b74ad397b547866a849b8df0a177ebff37b02b847d2df26213564ed330356678c629ecc9dfc5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7ab9c31f5918cef4387f3851b26e2240185533f51e61ba2449976780bf9a1daa13e4954bec40d33a016486836e916f55970adf57292943511b1c4be6d07d30a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c0d3016d45876d3f45ebf590e2cd726157b75057d7b2cfb49e87e0c1aaf731eb712f5674cb830070660ae98ea1ff27d2c41c69ca1b98ddb5f810fee854ce0af"} 13:40:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:40:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:40:44 INFO - Contents: 13:40:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a7afde85e60a08cdcb8506490a61603aed2f282ee548369dc48b74ad397b547866a849b8df0a177ebff37b02b847d2df26213564ed330356678c629ecc9dfc5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7ab9c31f5918cef4387f3851b26e2240185533f51e61ba2449976780bf9a1daa13e4954bec40d33a016486836e916f55970adf57292943511b1c4be6d07d30a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c0d3016d45876d3f45ebf590e2cd726157b75057d7b2cfb49e87e0c1aaf731eb712f5674cb830070660ae98ea1ff27d2c41c69ca1b98ddb5f810fee854ce0af"} 13:40:44 INFO - Running post-run listener: copy_logs_to_upload_dir 13:40:44 INFO - Copying logs to upload dir... 13:40:44 INFO - mkdir: /builds/slave/test/build/upload/logs 13:40:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.065784 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-13 13:40:44.394989) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 13:40:44.399290) ========= 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=fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a7afde85e60a08cdcb8506490a61603aed2f282ee548369dc48b74ad397b547866a849b8df0a177ebff37b02b847d2df26213564ed330356678c629ecc9dfc5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7ab9c31f5918cef4387f3851b26e2240185533f51e61ba2449976780bf9a1daa13e4954bec40d33a016486836e916f55970adf57292943511b1c4be6d07d30a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c0d3016d45876d3f45ebf590e2cd726157b75057d7b2cfb49e87e0c1aaf731eb712f5674cb830070660ae98ea1ff27d2c41c69ca1b98ddb5f810fee854ce0af"} build_url:https://queue.taskcluster.net/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/LsXEYzdBSFqcn7OV7cD-YQ/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/Fx-Team-Non-PGO/sha512/a7afde85e60a08cdcb8506490a61603aed2f282ee548369dc48b74ad397b547866a849b8df0a177ebff37b02b847d2df26213564ed330356678c629ecc9dfc5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7ab9c31f5918cef4387f3851b26e2240185533f51e61ba2449976780bf9a1daa13e4954bec40d33a016486836e916f55970adf57292943511b1c4be6d07d30a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c0d3016d45876d3f45ebf590e2cd726157b75057d7b2cfb49e87e0c1aaf731eb712f5674cb830070660ae98ea1ff27d2c41c69ca1b98ddb5f810fee854ce0af"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 13:40:44.426991) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:40:44.427644) ========= 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=fa44defc139c4ba8574fe040000001db-1468439924.264049-1617057368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004661 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:40:44.510619) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 13:40:44.511071) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 13:40:44.511491) ========= ========= Total master_lag: 0.17 =========