builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-055 starttime: 1468264500.64 results: success (0) buildid: 20160711114525 builduid: 1fa7349acafa462d9091d5f51f345c79 revision: dbe1d746fdff01e041486a83734a1cb677d4e474 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 12:15:00.638581) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 12:15:00.639149) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 12:15:00.639422) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 12:15:00.670742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 12:15:00.671021) ========= 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=bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 12:15: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 71.2M=0s 2016-07-11 12:15:01 (71.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090086 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 12:15:00.795850) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 12:15:00.796149) ========= 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=bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014207 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 12:15:00.860860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 12:15:00.861181) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dbe1d746fdff01e041486a83734a1cb677d4e474 --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 dbe1d746fdff01e041486a83734a1cb677d4e474 --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=bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 12:15:01,302 truncating revision to first 12 chars 2016-07-11 12:15:01,303 Setting DEBUG logging. 2016-07-11 12:15:01,303 attempt 1/10 2016-07-11 12:15:01,303 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dbe1d746fdff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 12:15:01,603 unpacking tar archive at: fx-team-dbe1d746fdff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628553 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 12:15:01.505294) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 12:15:01.505611) ========= script_repo_revision: dbe1d746fdff01e041486a83734a1cb677d4e474 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 12:15:01.506135) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 12:15:01.506406) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 12:15:01.514552) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-11 12:15:01.514829) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:15:02 INFO - MultiFileLogger online at 20160711 12:15:02 in /builds/slave/test 12:15:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:15:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:15:02 INFO - {'append_to_log': False, 12:15:02 INFO - 'base_work_dir': '/builds/slave/test', 12:15:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:15:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:15:02 INFO - 'branch': 'Fx-Team-Non-PGO', 12:15:02 INFO - 'buildbot_json_path': 'buildprops.json', 12:15:02 INFO - 'config_files': ('talos/linux_config.py',), 12:15:02 INFO - 'default_actions': ('clobber', 12:15:02 INFO - 'read-buildbot-config', 12:15:02 INFO - 'download-and-extract', 12:15:02 INFO - 'populate-webroot', 12:15:02 INFO - 'create-virtualenv', 12:15:02 INFO - 'install', 12:15:02 INFO - 'run-tests'), 12:15:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:15:02 INFO - 'download_minidump_stackwalk': True, 12:15:02 INFO - 'download_symbols': 'ondemand', 12:15:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:15:02 INFO - 'tooltool.py': '/tools/tooltool.py', 12:15:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:15:02 INFO - '/tools/misc-python/virtualenv.py')}, 12:15:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:15:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:15:02 INFO - 'installer_path': 'installer.exe', 12:15:02 INFO - 'log_level': 'info', 12:15:02 INFO - 'log_name': 'talos', 12:15:02 INFO - 'log_to_console': True, 12:15:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:15:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:15:02 INFO - 'opt_config_files': (), 12:15:02 INFO - 'pip_index': False, 12:15:02 INFO - 'sps_profile': False, 12:15:02 INFO - 'sps_profile_interval': 0, 12:15:02 INFO - 'suite': 'dromaeojs-e10s', 12:15:02 INFO - 'system_bits': '32', 12:15:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:15:02 INFO - 'title': 'talos-linux64-ix-055', 12:15:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:15:02 INFO - 'use_talos_json': True, 12:15:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:15:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:15:02 INFO - 'work_dir': 'build'} 12:15:02 INFO - ##### 12:15:02 INFO - ##### Running clobber step. 12:15:02 INFO - ##### 12:15:02 INFO - Running pre-action listener: _resource_record_pre_action 12:15:02 INFO - Running main action method: clobber 12:15:02 INFO - rmtree: /builds/slave/test/build 12:15:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:15:02 INFO - Running post-action listener: _resource_record_post_action 12:15:02 INFO - ##### 12:15:02 INFO - ##### Finished clobber step (success) 12:15:02 INFO - ##### 12:15:02 INFO - ##### 12:15:02 INFO - ##### Running read-buildbot-config step. 12:15:02 INFO - ##### 12:15:02 INFO - Running pre-action listener: _resource_record_pre_action 12:15:02 INFO - Running main action method: read_buildbot_config 12:15:02 INFO - Using buildbot properties: 12:15:02 INFO - { 12:15:02 INFO - "project": "", 12:15:02 INFO - "product": "firefox", 12:15:02 INFO - "script_repo_revision": "production", 12:15:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:15:02 INFO - "repository": "", 12:15:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 12:15:02 INFO - "buildid": "20160711114525", 12:15:02 INFO - "pgo_build": "False", 12:15:02 INFO - "basedir": "/builds/slave/test", 12:15:02 INFO - "buildnumber": 1444, 12:15:02 INFO - "slavename": "talos-linux64-ix-055", 12:15:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:15:02 INFO - "platform": "ubuntu64_hw", 12:15:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:15:02 INFO - "branch": "fx-team", 12:15:02 INFO - "repo_path": "integration/fx-team", 12:15:02 INFO - "revision": "dbe1d746fdff01e041486a83734a1cb677d4e474", 12:15:02 INFO - "stage_platform": "linux64", 12:15:02 INFO - "builduid": "1fa7349acafa462d9091d5f51f345c79", 12:15:02 INFO - "slavebuilddir": "test" 12:15:02 INFO - } 12:15:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:15:02 INFO - Running post-action listener: _resource_record_post_action 12:15:02 INFO - ##### 12:15:02 INFO - ##### Finished read-buildbot-config step (success) 12:15:02 INFO - ##### 12:15:02 INFO - ##### 12:15:02 INFO - ##### Running download-and-extract step. 12:15:02 INFO - ##### 12:15:02 INFO - Running pre-action listener: _resource_record_pre_action 12:15:02 INFO - Running main action method: download_and_extract 12:15:02 INFO - mkdir: /builds/slave/test/build/tests 12:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:02 INFO - https://queue.taskcluster.net/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:15:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:15:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:15:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/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 12:15:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/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 12:15:07 INFO - Downloaded 1361 bytes. 12:15:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:15:07 INFO - Using the following test package requirements: 12:15:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:15:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:15:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:15:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:07 INFO - u'jsshell-linux-x86_64.zip'], 12:15:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:15:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:15:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:15:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:15:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:15:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:15:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:15:07 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')]} 12:15:07 INFO - https://queue.taskcluster.net/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:15:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:15:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:15:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/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 12:15:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/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 12:15:12 INFO - Downloaded 22700380 bytes. 12:15:12 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'] 12:15:12 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 12:15:13 INFO - Return code: 0 12:15:13 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 12:15: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')]} 12:15:13 INFO - https://queue.taskcluster.net/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:15:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:15:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:15:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/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 12:15:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/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 12:15:18 INFO - Downloaded 22700380 bytes. 12:15:18 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'] 12:15:18 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 12:15:20 INFO - Return code: 0 12:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:20 INFO - https://queue.taskcluster.net/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:15:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:15:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:15:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/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 12:15:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/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 12:15:21 INFO - Downloaded 14403333 bytes. 12:15:21 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'] 12:15:21 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 12:15:21 INFO - Return code: 0 12:15: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')]} 12:15:21 INFO - https://queue.taskcluster.net/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:15:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:15:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:15:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/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 12:15:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFfILNi-TF2zbXT7BnW9Vg/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 12:15:23 INFO - Downloaded 56653124 bytes. 12:15:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:15:23 INFO - mkdir: /builds/slave/test/properties 12:15:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:15:23 INFO - Writing to file /builds/slave/test/properties/build_url 12:15:23 INFO - Contents: 12:15:23 INFO - build_url:https://queue.taskcluster.net/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:15:23 INFO - Running post-action listener: _resource_record_post_action 12:15:23 INFO - Running post-action listener: set_extra_try_arguments 12:15:23 INFO - ##### 12:15:23 INFO - ##### Finished download-and-extract step (success) 12:15:23 INFO - ##### 12:15:23 INFO - ##### 12:15:23 INFO - ##### Running populate-webroot step. 12:15:23 INFO - ##### 12:15:23 INFO - Running pre-action listener: _resource_record_pre_action 12:15:23 INFO - Running main action method: populate_webroot 12:15:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:15:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:15:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:15:23 INFO - '--tppagecycles', 12:15:23 INFO - '7'], 12:15:23 INFO - 'tests': ['tsvgm']}}, 12:15:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:15:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:15:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:15:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:15:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:15:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:15:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:23 INFO - 'talos_options': ['--disable-e10s'], 12:15:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:23 INFO - 'talos_options': ['--disable-e10s'], 12:15:23 INFO - 'tests': ['damp', 'tps']}, 12:15:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:23 INFO - 'tests': ['damp', 'tps']}, 12:15:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:15:23 INFO - 'tests': ['dromaeo_dom']}, 12:15:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:15:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:15:23 INFO - 'tests': ['basic_compositor_video']}, 12:15:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:15:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:15:23 INFO - 'tests': ['a11yr', 12:15:23 INFO - 'ts_paint', 12:15:23 INFO - 'tpaint', 12:15:23 INFO - 'sessionrestore', 12:15:23 INFO - 'sessionrestore_no_auto_restore', 12:15:23 INFO - 'tabpaint']}, 12:15:23 INFO - 'other-e10s': {'tests': ['a11yr', 12:15:23 INFO - 'ts_paint', 12:15:23 INFO - 'tpaint', 12:15:23 INFO - 'sessionrestore', 12:15:23 INFO - 'sessionrestore_no_auto_restore', 12:15:23 INFO - 'tabpaint']}, 12:15:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:15:23 INFO - 'ts_paint', 12:15:23 INFO - 'tpaint', 12:15:23 INFO - 'sessionrestore', 12:15:23 INFO - 'sessionrestore_no_auto_restore', 12:15:23 INFO - 'tabpaint']}, 12:15:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:15:23 INFO - 'ts_paint', 12:15:23 INFO - 'tpaint', 12:15:23 INFO - 'sessionrestore', 12:15:23 INFO - 'sessionrestore_no_auto_restore', 12:15:23 INFO - 'tabpaint']}, 12:15:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:15:23 INFO - 'tests': ['a11yr', 12:15:23 INFO - 'ts_paint', 12:15:23 INFO - 'tpaint', 12:15:23 INFO - 'sessionrestore', 12:15:23 INFO - 'sessionrestore_no_auto_restore', 12:15:23 INFO - 'tabpaint']}, 12:15:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:15:23 INFO - 'tests': ['a11yr', 12:15:23 INFO - 'ts_paint', 12:15:23 INFO - 'tpaint', 12:15:23 INFO - 'sessionrestore', 12:15:23 INFO - 'sessionrestore_no_auto_restore', 12:15:23 INFO - 'tabpaint']}, 12:15:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:15:23 INFO - 'tests': ['tsvgx', 12:15:23 INFO - 'tsvgr_opacity', 12:15:23 INFO - 'tart', 12:15:23 INFO - 'tscrollx', 12:15:23 INFO - 'cart']}, 12:15:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:15:23 INFO - 'tsvgr_opacity', 12:15:23 INFO - 'tart', 12:15:23 INFO - 'tscrollx', 12:15:23 INFO - 'cart']}, 12:15:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:23 INFO - 'talos_options': ['--disable-e10s'], 12:15:23 INFO - 'tests': ['tp5o']}, 12:15:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:23 INFO - 'tests': ['tp5o']}, 12:15:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:23 INFO - 'talos_options': ['--disable-e10s', 12:15:23 INFO - '--xperf_path', 12:15:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:23 INFO - 'tests': ['tp5n']}, 12:15:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:23 INFO - 'talos_options': ['--xperf_path', 12:15:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:23 INFO - 'tests': ['tp5n']}}, 12:15:23 INFO - 'talos.zip': {'path': '', 12:15:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:15:23 INFO - Running post-action listener: _resource_record_post_action 12:15:23 INFO - ##### 12:15:23 INFO - ##### Finished populate-webroot step (success) 12:15:23 INFO - ##### 12:15:23 INFO - ##### 12:15:23 INFO - ##### Running create-virtualenv step. 12:15:23 INFO - ##### 12:15:23 INFO - Running pre-action listener: _resource_record_pre_action 12:15:23 INFO - Running main action method: create_virtualenv 12:15:23 INFO - Creating virtualenv /builds/slave/test/build/venv 12:15:23 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 12:15:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:15:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:15:24 INFO - Using real prefix '/usr' 12:15:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:15:24 INFO - Installing distribute.............................................................................................................................................................................................done. 12:15:26 INFO - Installing pip.................done. 12:15:26 INFO - Return code: 0 12:15:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:15: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')]} 12:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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')]} 12:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2289030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547570>, '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 0x2548470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', '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 12:15: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', 'pip>=1.5'] in /builds/slave/test/build 12:15: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 pip>=1.5 12:15:26 INFO - Using env: {'DISPLAY': ':0', 12:15:26 INFO - 'HOME': '/home/cltbld', 12:15:26 INFO - 'LANG': 'en_US.UTF-8', 12:15:26 INFO - 'LANGUAGE': 'en_US:en', 12:15:26 INFO - 'LOGNAME': 'cltbld', 12:15:26 INFO - 'MAIL': '/var/mail/cltbld', 12:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:26 INFO - 'MOZ_NO_REMOTE': '1', 12:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:26 INFO - 'NO_EM_RESTART': '1', 12:15:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:26 INFO - 'PWD': '/builds/slave/test', 12:15:26 INFO - 'SHELL': '/bin/bash', 12:15:26 INFO - 'SHLVL': '1', 12:15:26 INFO - 'TERM': 'linux', 12:15:26 INFO - 'TMOUT': '86400', 12:15:26 INFO - 'USER': 'cltbld', 12:15:26 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', 12:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:26 INFO - '_': '/tools/buildbot/bin/python'} 12:15:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:26 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 12:15:26 INFO - Cleaning up... 12:15:26 INFO - Return code: 0 12:15:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:15: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')]} 12:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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')]} 12:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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', '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 0x2289030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547570>, '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 0x2548470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', '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 12:15: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:15: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 psutil>=3.1.1 12:15:26 INFO - Using env: {'DISPLAY': ':0', 12:15:26 INFO - 'HOME': '/home/cltbld', 12:15:26 INFO - 'LANG': 'en_US.UTF-8', 12:15:26 INFO - 'LANGUAGE': 'en_US:en', 12:15:26 INFO - 'LOGNAME': 'cltbld', 12:15:26 INFO - 'MAIL': '/var/mail/cltbld', 12:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:26 INFO - 'MOZ_NO_REMOTE': '1', 12:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:26 INFO - 'NO_EM_RESTART': '1', 12:15:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:26 INFO - 'PWD': '/builds/slave/test', 12:15:26 INFO - 'SHELL': '/bin/bash', 12:15:26 INFO - 'SHLVL': '1', 12:15:26 INFO - 'TERM': 'linux', 12:15:26 INFO - 'TMOUT': '86400', 12:15:26 INFO - 'USER': 'cltbld', 12:15:26 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', 12:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:26 INFO - '_': '/tools/buildbot/bin/python'} 12:15:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:26 INFO - Downloading/unpacking psutil>=3.1.1 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:15:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:28 INFO - Installing collected packages: psutil 12:15:28 INFO - Running setup.py install for psutil 12:15:29 INFO - building 'psutil._psutil_linux' extension 12:15:29 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 12:15:29 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 12:15:29 INFO - building 'psutil._psutil_posix' extension 12:15:29 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 12:15:29 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 12:15:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:29 INFO - Successfully installed psutil 12:15:29 INFO - Cleaning up... 12:15:29 INFO - Return code: 0 12:15:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:15:29 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')]} 12:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:29 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')]} 12:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:29 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 0x2289030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547570>, '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 0x2548470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', '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 12:15:29 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 12:15:29 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 12:15:29 INFO - Using env: {'DISPLAY': ':0', 12:15:29 INFO - 'HOME': '/home/cltbld', 12:15:29 INFO - 'LANG': 'en_US.UTF-8', 12:15:29 INFO - 'LANGUAGE': 'en_US:en', 12:15:29 INFO - 'LOGNAME': 'cltbld', 12:15:29 INFO - 'MAIL': '/var/mail/cltbld', 12:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:29 INFO - 'MOZ_NO_REMOTE': '1', 12:15:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:29 INFO - 'NO_EM_RESTART': '1', 12:15:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:29 INFO - 'PWD': '/builds/slave/test', 12:15:29 INFO - 'SHELL': '/bin/bash', 12:15:29 INFO - 'SHLVL': '1', 12:15:29 INFO - 'TERM': 'linux', 12:15:29 INFO - 'TMOUT': '86400', 12:15:29 INFO - 'USER': 'cltbld', 12:15:29 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', 12:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:29 INFO - '_': '/tools/buildbot/bin/python'} 12:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:15:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:15:31 INFO - Installing collected packages: mozsystemmonitor 12:15:31 INFO - Running setup.py install for mozsystemmonitor 12:15:31 INFO - Successfully installed mozsystemmonitor 12:15:31 INFO - Cleaning up... 12:15:31 INFO - Return code: 0 12:15:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:31 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 0x2289030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547570>, '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 0x2548470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', '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 12:15:31 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 12:15:31 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 12:15:31 INFO - Using env: {'DISPLAY': ':0', 12:15:31 INFO - 'HOME': '/home/cltbld', 12:15:31 INFO - 'LANG': 'en_US.UTF-8', 12:15:31 INFO - 'LANGUAGE': 'en_US:en', 12:15:31 INFO - 'LOGNAME': 'cltbld', 12:15:31 INFO - 'MAIL': '/var/mail/cltbld', 12:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:31 INFO - 'MOZ_NO_REMOTE': '1', 12:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:31 INFO - 'NO_EM_RESTART': '1', 12:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:31 INFO - 'PWD': '/builds/slave/test', 12:15:31 INFO - 'SHELL': '/bin/bash', 12:15:31 INFO - 'SHLVL': '1', 12:15:31 INFO - 'TERM': 'linux', 12:15:31 INFO - 'TMOUT': '86400', 12:15:31 INFO - 'USER': 'cltbld', 12:15:31 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', 12:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:31 INFO - '_': '/tools/buildbot/bin/python'} 12:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:32 INFO - Downloading/unpacking jsonschema==2.5.1 12:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:15:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:34 INFO - Downloading functools32-3.2.3-2.tar.gz 12:15:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:15:34 INFO - warning: no files found matching '*.txt' 12:15:34 INFO - no previously-included directories found matching 'build' 12:15:34 INFO - no previously-included directories found matching 'dist' 12:15:34 INFO - no previously-included directories found matching '.git*' 12:15:34 INFO - Installing collected packages: jsonschema, functools32 12:15:34 INFO - Running setup.py install for functools32 12:15:34 INFO - warning: no files found matching '*.txt' 12:15:34 INFO - no previously-included directories found matching 'build' 12:15:34 INFO - no previously-included directories found matching 'dist' 12:15:34 INFO - no previously-included directories found matching '.git*' 12:15:34 INFO - Successfully installed jsonschema functools32 12:15:34 INFO - Cleaning up... 12:15:34 INFO - Return code: 0 12:15:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:15:34 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')]} 12:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:34 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')]} 12:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:34 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 0x2289030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547570>, '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 0x2548470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', '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 12:15:34 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 12:15:34 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 12:15:34 INFO - Using env: {'DISPLAY': ':0', 12:15:34 INFO - 'HOME': '/home/cltbld', 12:15:34 INFO - 'LANG': 'en_US.UTF-8', 12:15:34 INFO - 'LANGUAGE': 'en_US:en', 12:15:34 INFO - 'LOGNAME': 'cltbld', 12:15:34 INFO - 'MAIL': '/var/mail/cltbld', 12:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:34 INFO - 'MOZ_NO_REMOTE': '1', 12:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:34 INFO - 'NO_EM_RESTART': '1', 12:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:34 INFO - 'PWD': '/builds/slave/test', 12:15:34 INFO - 'SHELL': '/bin/bash', 12:15:34 INFO - 'SHLVL': '1', 12:15:34 INFO - 'TERM': 'linux', 12:15:34 INFO - 'TMOUT': '86400', 12:15:34 INFO - 'USER': 'cltbld', 12:15:34 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', 12:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:34 INFO - '_': '/tools/buildbot/bin/python'} 12:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:34 INFO - Downloading/unpacking blobuploader==1.2.4 12:15:34 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 12:15:34 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 12:15:34 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 12:15:34 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 12:15:34 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 12:15:34 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 12:15:36 INFO - Downloading blobuploader-1.2.4.tar.gz 12:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:15:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:15:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:37 INFO - Downloading docopt-0.6.1.tar.gz 12:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:15:37 INFO - Installing collected packages: blobuploader, requests, docopt 12:15:37 INFO - Running setup.py install for blobuploader 12:15:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:15:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:15:37 INFO - Running setup.py install for requests 12:15:37 INFO - Running setup.py install for docopt 12:15:37 INFO - Successfully installed blobuploader requests docopt 12:15:37 INFO - Cleaning up... 12:15:37 INFO - Return code: 0 12:15:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15: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')]} 12:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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')]} 12:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:37 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 0x2289030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547570>, '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 0x2548470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', '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 12:15:37 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 12:15:37 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 12:15:37 INFO - Using env: {'DISPLAY': ':0', 12:15:37 INFO - 'HOME': '/home/cltbld', 12:15:37 INFO - 'LANG': 'en_US.UTF-8', 12:15:37 INFO - 'LANGUAGE': 'en_US:en', 12:15:37 INFO - 'LOGNAME': 'cltbld', 12:15:37 INFO - 'MAIL': '/var/mail/cltbld', 12:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:37 INFO - 'MOZ_NO_REMOTE': '1', 12:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:37 INFO - 'NO_EM_RESTART': '1', 12:15:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:37 INFO - 'PWD': '/builds/slave/test', 12:15:37 INFO - 'SHELL': '/bin/bash', 12:15:37 INFO - 'SHLVL': '1', 12:15:37 INFO - 'TERM': 'linux', 12:15:37 INFO - 'TMOUT': '86400', 12:15:37 INFO - 'USER': 'cltbld', 12:15:37 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', 12:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:37 INFO - '_': '/tools/buildbot/bin/python'} 12:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:38 INFO - Running setup.py (path:/tmp/pip-aZ6D2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:38 INFO - Running setup.py (path:/tmp/pip-MTEl5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:38 INFO - Running setup.py (path:/tmp/pip-OKdw2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:38 INFO - Running setup.py (path:/tmp/pip-3vEDDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:38 INFO - Running setup.py (path:/tmp/pip-9AQB35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:38 INFO - Running setup.py (path:/tmp/pip-OSGlKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:38 INFO - Running setup.py (path:/tmp/pip-ZFpttX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:38 INFO - Running setup.py (path:/tmp/pip-tS1_sV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:38 INFO - Running setup.py (path:/tmp/pip-NIgfP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:38 INFO - Running setup.py (path:/tmp/pip-IWydtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:38 INFO - Running setup.py (path:/tmp/pip-SEJS74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:38 INFO - Running setup.py (path:/tmp/pip-_Q_3ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:38 INFO - Running setup.py (path:/tmp/pip-ajvXO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:38 INFO - Running setup.py (path:/tmp/pip-9Jsx8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:39 INFO - Running setup.py (path:/tmp/pip-_mg0CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:39 INFO - Running setup.py (path:/tmp/pip-plQ6Zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:39 INFO - Running setup.py (path:/tmp/pip-97MDJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:15:39 INFO - Running setup.py install for manifestparser 12:15:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Running setup.py install for mozcrash 12:15:39 INFO - Running setup.py install for mozdebug 12:15:39 INFO - Running setup.py install for mozdevice 12:15:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Running setup.py install for mozfile 12:15:39 INFO - Running setup.py install for mozhttpd 12:15:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Running setup.py install for mozinfo 12:15:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Running setup.py install for mozInstall 12:15:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:15:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:15:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:15:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:15:40 INFO - Running setup.py install for mozleak 12:15:40 INFO - Running setup.py install for mozlog 12:15:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:15:40 INFO - Running setup.py install for moznetwork 12:15:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:15:40 INFO - Running setup.py install for mozprocess 12:15:40 INFO - Running setup.py install for mozprofile 12:15:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:15:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:15:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:15:40 INFO - Running setup.py install for mozrunner 12:15:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:15:40 INFO - Running setup.py install for mozscreenshot 12:15:40 INFO - Running setup.py install for moztest 12:15:40 INFO - Running setup.py install for mozversion 12:15:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:15:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:15:41 INFO - Cleaning up... 12:15:41 INFO - Return code: 0 12:15:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:41 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 0x2289030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547570>, '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 0x2548470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', '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 12:15:41 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 12:15:41 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 12:15:41 INFO - Using env: {'DISPLAY': ':0', 12:15:41 INFO - 'HOME': '/home/cltbld', 12:15:41 INFO - 'LANG': 'en_US.UTF-8', 12:15:41 INFO - 'LANGUAGE': 'en_US:en', 12:15:41 INFO - 'LOGNAME': 'cltbld', 12:15:41 INFO - 'MAIL': '/var/mail/cltbld', 12:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:41 INFO - 'MOZ_NO_REMOTE': '1', 12:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:41 INFO - 'NO_EM_RESTART': '1', 12:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:41 INFO - 'PWD': '/builds/slave/test', 12:15:41 INFO - 'SHELL': '/bin/bash', 12:15:41 INFO - 'SHLVL': '1', 12:15:41 INFO - 'TERM': 'linux', 12:15:41 INFO - 'TMOUT': '86400', 12:15:41 INFO - 'USER': 'cltbld', 12:15:41 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', 12:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:41 INFO - '_': '/tools/buildbot/bin/python'} 12:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:41 INFO - Running setup.py (path:/tmp/pip-GBRweX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:41 INFO - Running setup.py (path:/tmp/pip-aeoM00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:41 INFO - Running setup.py (path:/tmp/pip-Y11pU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:41 INFO - Running setup.py (path:/tmp/pip-HeYbAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:41 INFO - Running setup.py (path:/tmp/pip-sO2UDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:41 INFO - Running setup.py (path:/tmp/pip-jul0NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:41 INFO - Running setup.py (path:/tmp/pip-2iTueP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:41 INFO - Running setup.py (path:/tmp/pip-OfPYhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:41 INFO - Running setup.py (path:/tmp/pip-4TfzuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:41 INFO - Running setup.py (path:/tmp/pip-MUWViB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:41 INFO - Running setup.py (path:/tmp/pip-IcmRey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:42 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)) 12:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:42 INFO - Running setup.py (path:/tmp/pip-pzvVxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:42 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)) 12:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:42 INFO - Running setup.py (path:/tmp/pip-8yYFXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:42 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)) 12:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:42 INFO - Running setup.py (path:/tmp/pip-etcs6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:42 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)) 12:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:42 INFO - Running setup.py (path:/tmp/pip-pyEp0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:42 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)) 12:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:42 INFO - Running setup.py (path:/tmp/pip-4hvY9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:42 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)) 12:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:42 INFO - Running setup.py (path:/tmp/pip-3YU4Or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:42 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)) 12:15:42 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)) 12:15:42 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)) 12:15:42 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)) 12:15:42 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)) 12:15:42 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)) 12:15:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:15:42 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 12:15:42 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 12:15:42 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 12:15:42 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 12:15:42 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 12:15:42 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 12:15:44 INFO - Downloading blessings-1.6.tar.gz 12:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:15:44 INFO - Installing collected packages: blessings 12:15:44 INFO - Running setup.py install for blessings 12:15:44 INFO - Successfully installed blessings 12:15:44 INFO - Cleaning up... 12:15:44 INFO - Return code: 0 12:15:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:15:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:44 INFO - Reading from file tmpfile_stdout 12:15:44 INFO - Current package versions: 12:15:44 INFO - argparse == 1.2.1 12:15:44 INFO - blessings == 1.6 12:15:44 INFO - blobuploader == 1.2.4 12:15:44 INFO - docopt == 0.6.1 12:15:44 INFO - functools32 == 3.2.3-2 12:15:44 INFO - jsonschema == 2.5.1 12:15:44 INFO - manifestparser == 1.1 12:15:44 INFO - mozInstall == 1.12 12:15:44 INFO - mozcrash == 0.17 12:15:44 INFO - mozdebug == 0.1 12:15:44 INFO - mozdevice == 0.48 12:15:44 INFO - mozfile == 1.2 12:15:44 INFO - mozhttpd == 0.7 12:15:44 INFO - mozinfo == 0.9 12:15:44 INFO - mozleak == 0.1 12:15:44 INFO - mozlog == 3.2 12:15:44 INFO - moznetwork == 0.27 12:15:44 INFO - mozprocess == 0.23 12:15:44 INFO - mozprofile == 0.28 12:15:44 INFO - mozrunner == 6.12 12:15:44 INFO - mozscreenshot == 0.1 12:15:44 INFO - mozsystemmonitor == 0.3 12:15:44 INFO - moztest == 0.7 12:15:44 INFO - mozversion == 1.4 12:15:44 INFO - psutil == 3.1.1 12:15:44 INFO - requests == 1.2.3 12:15:44 INFO - wsgiref == 0.1.2 12:15:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:44 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 0x2289030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547570>, '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 0x2548470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', '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 12:15:44 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 12:15:44 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 12:15:44 INFO - Using env: {'DISPLAY': ':0', 12:15:44 INFO - 'HOME': '/home/cltbld', 12:15:44 INFO - 'LANG': 'en_US.UTF-8', 12:15:44 INFO - 'LANGUAGE': 'en_US:en', 12:15:44 INFO - 'LOGNAME': 'cltbld', 12:15:44 INFO - 'MAIL': '/var/mail/cltbld', 12:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:44 INFO - 'MOZ_NO_REMOTE': '1', 12:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:44 INFO - 'NO_EM_RESTART': '1', 12:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:44 INFO - 'PWD': '/builds/slave/test', 12:15:44 INFO - 'SHELL': '/bin/bash', 12:15:44 INFO - 'SHLVL': '1', 12:15:44 INFO - 'TERM': 'linux', 12:15:44 INFO - 'TMOUT': '86400', 12:15:44 INFO - 'USER': 'cltbld', 12:15:44 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', 12:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:44 INFO - '_': '/tools/buildbot/bin/python'} 12:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:45 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)) 12:15:45 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)) 12:15:45 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)) 12:15:45 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)) 12:15:45 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)) 12:15:45 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)) 12:15:45 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)) 12:15:45 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)) 12:15:45 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)) 12:15:45 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)) 12:15:45 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)) 12:15:45 INFO - Cleaning up... 12:15:45 INFO - Return code: 0 12:15:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:45 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 0x2289030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547570>, '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 0x2548470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', '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 12:15:45 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 12:15:45 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 12:15:45 INFO - Using env: {'DISPLAY': ':0', 12:15:45 INFO - 'HOME': '/home/cltbld', 12:15:45 INFO - 'LANG': 'en_US.UTF-8', 12:15:45 INFO - 'LANGUAGE': 'en_US:en', 12:15:45 INFO - 'LOGNAME': 'cltbld', 12:15:45 INFO - 'MAIL': '/var/mail/cltbld', 12:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:45 INFO - 'MOZ_NO_REMOTE': '1', 12:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:45 INFO - 'NO_EM_RESTART': '1', 12:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:45 INFO - 'PWD': '/builds/slave/test', 12:15:45 INFO - 'SHELL': '/bin/bash', 12:15:45 INFO - 'SHLVL': '1', 12:15:45 INFO - 'TERM': 'linux', 12:15:45 INFO - 'TMOUT': '86400', 12:15:45 INFO - 'USER': 'cltbld', 12:15:45 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', 12:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:45 INFO - '_': '/tools/buildbot/bin/python'} 12:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:15:45 INFO - Cleaning up... 12:15:45 INFO - Return code: 0 12:15:45 INFO - Running post-action listener: _resource_record_post_action 12:15:45 INFO - Running post-action listener: _start_resource_monitoring 12:15:45 INFO - Starting resource monitoring. 12:15:45 INFO - ##### 12:15:45 INFO - ##### Finished create-virtualenv step (success) 12:15:45 INFO - ##### 12:15:45 INFO - ##### 12:15:45 INFO - ##### Running install step. 12:15:45 INFO - ##### 12:15:45 INFO - Running pre-action listener: _resource_record_pre_action 12:15:45 INFO - Running main action method: install 12:15:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:45 INFO - Reading from file tmpfile_stdout 12:15:45 INFO - Detecting whether we're running mozinstall >=1.0... 12:15:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:15:45 INFO - Reading from file tmpfile_stdout 12:15:45 INFO - Output received: 12:15:45 INFO - Usage: mozinstall [options] installer 12:15:45 INFO - Options: 12:15:45 INFO - -h, --help show this help message and exit 12:15:45 INFO - -d DEST, --destination=DEST 12:15:45 INFO - Directory to install application into. [default: 12:15:45 INFO - "/builds/slave/test"] 12:15:45 INFO - --app=APP Application being installed. [default: firefox] 12:15:45 INFO - mkdir: /builds/slave/test/build/application 12:15:45 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'] 12:15:45 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 12:16:01 INFO - Reading from file tmpfile_stdout 12:16:01 INFO - Output received: 12:16:01 INFO - /builds/slave/test/build/application/firefox/firefox 12:16:01 INFO - Running post-action listener: _resource_record_post_action 12:16:01 INFO - ##### 12:16:01 INFO - ##### Finished install step (success) 12:16:01 INFO - ##### 12:16:01 INFO - ##### 12:16:01 INFO - ##### Running run-tests step. 12:16:01 INFO - ##### 12:16:01 INFO - Running pre-action listener: _resource_record_pre_action 12:16:01 INFO - Running main action method: run_tests 12:16:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:16:01 INFO - Python 2.7.3 12:16:01 INFO - Return code: 0 12:16:01 INFO - grabbing minidump binary from tooltool 12:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:16:01 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 0x2547570>, '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 0x2548470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:16:01 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 12:16:01 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 12:16:01 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 12:16:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:16:01 INFO - Return code: 0 12:16:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:16:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:16:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:16:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:16:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:16:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:16:01 INFO - Using env: {'DISPLAY': ':0', 12:16:01 INFO - 'HOME': '/home/cltbld', 12:16:01 INFO - 'LANG': 'en_US.UTF-8', 12:16:01 INFO - 'LANGUAGE': 'en_US:en', 12:16:01 INFO - 'LOGNAME': 'cltbld', 12:16:01 INFO - 'MAIL': '/var/mail/cltbld', 12:16:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:16:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:01 INFO - 'MOZ_NO_REMOTE': '1', 12:16:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:16:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:01 INFO - 'NO_EM_RESTART': '1', 12:16:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:01 INFO - 'PWD': '/builds/slave/test', 12:16:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:16:01 INFO - 'SHELL': '/bin/bash', 12:16:01 INFO - 'SHLVL': '1', 12:16:01 INFO - 'TERM': 'linux', 12:16:01 INFO - 'TMOUT': '86400', 12:16:01 INFO - 'USER': 'cltbld', 12:16:01 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556', 12:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:01 INFO - '_': '/tools/buildbot/bin/python'} 12:16:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:16:02 INFO - mozversion application_buildid: 20160711114525 12:16:02 INFO - mozversion application_changeset: dbe1d746fdff01e041486a83734a1cb677d4e474 12:16:02 INFO - mozversion application_display_name: Nightly 12:16:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:16:02 INFO - mozversion application_name: Firefox 12:16:02 INFO - mozversion application_remotingname: firefox 12:16:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:16:02 INFO - mozversion application_vendor: Mozilla 12:16:02 INFO - mozversion application_version: 50.0a1 12:16:02 INFO - mozversion platform_buildid: 20160711114525 12:16:02 INFO - mozversion platform_changeset: dbe1d746fdff01e041486a83734a1cb677d4e474 12:16:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:16:02 INFO - mozversion platform_version: 50.0a1 12:16:02 INFO - using testdate: 1468264562 12:16:02 INFO - actual date: 1468264562 12:16:02 INFO - starting webserver on 'localhost:54338' 12:16:02 INFO - SUITE-START | Running 2 tests 12:16:02 INFO - TEST-START | dromaeo_css 12:16:02 INFO - operating with platform_type : linux_ 12:16:02 INFO - Initialising browser for dromaeo_css test... 12:16:02 INFO - TEST-INFO | started process 14014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMuDcvR/profile http://localhost:54338/getInfo.html) 12:16:06 INFO - PROCESS | 14014 | __metrics Screen width/height:1600/1200 12:16:06 INFO - PROCESS | 14014 | colorDepth:24 12:16:06 INFO - PROCESS | 14014 | Browser inner width/height: 1024/697 12:16:06 INFO - PROCESS | 14014 | __metrics 12:16:07 ERROR - PROCESS | 14014 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 12:16:08 INFO - TEST-INFO | 14014: exit 0 12:16:08 INFO - Browser initialized. 12:16:08 INFO - Running cycle 1/1 for dromaeo_css test... 12:16:08 INFO - TEST-INFO | started process 14138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMuDcvR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:16:20 INFO - PROCESS | 14138 | RSS: Main: 168816640 12:16:20 INFO - PROCESS | 14138 | 12:17:09 INFO - PROCESS | 14138 | 1468264629976 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] 12:19:22 INFO - PROCESS | 14138 | Cycle 1(1): loaded http://localhost:54338/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54338/tests/dromaeo/cssquery-ext.html) 12:19:23 INFO - PROCESS | 14138 | RSS: Main: 168591360 12:19:23 INFO - PROCESS | 14138 | 12:22:25 INFO - PROCESS | 14138 | Cycle 1(1): loaded http://localhost:54338/tests/dromaeo/cssquery-ext.html (next: http://localhost:54338/tests/dromaeo/cssquery-jquery.html) 12:22:26 INFO - PROCESS | 14138 | RSS: Main: 168460288 12:22:26 INFO - PROCESS | 14138 | 12:25:28 INFO - PROCESS | 14138 | Cycle 1(1): loaded http://localhost:54338/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54338/tests/dromaeo/cssquery-mootools.html) 12:25:29 INFO - PROCESS | 14138 | RSS: Main: 171302912 12:25:29 INFO - PROCESS | 14138 | 12:28:30 INFO - PROCESS | 14138 | Cycle 1(1): loaded http://localhost:54338/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54338/tests/dromaeo/cssquery-prototype.html) 12:28:31 INFO - PROCESS | 14138 | RSS: Main: 167202816 12:28:31 INFO - PROCESS | 14138 | 12:31:34 INFO - PROCESS | 14138 | Cycle 1(1): loaded http://localhost:54338/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54338/tests/dromaeo/cssquery-yui.html) 12:31:34 INFO - PROCESS | 14138 | RSS: Main: 168943616 12:31:34 INFO - PROCESS | 14138 | 12:34:37 INFO - PROCESS | 14138 | Cycle 1(1): loaded http://localhost:54338/tests/dromaeo/cssquery-yui.html (next: http://localhost:54338/tests/dromaeo/cssquery-dojo.html) 12:34:37 INFO - PROCESS | 14138 | RSS: Main: 169799680 12:34:37 INFO - PROCESS | 14138 | 12:34:37 INFO - PROCESS | 14138 | __start_tp_report 12:34:37 INFO - PROCESS | 14138 | _x_x_mozilla_page_load 12:34:37 INFO - PROCESS | 14138 | _x_x_mozilla_page_load_details 12:34:37 INFO - PROCESS | 14138 | |i|pagename|runs| 12:34:37 INFO - PROCESS | 14138 | |0;dojo.html;2632.855192964387;2656.614790855325;2682.691490478595;2689.798265130116;2702.689190743065;4769.117713223056;4805.303231031503;4844.273358996148;4846.684965477241;4868.780904859281;4723.197056500395;4815.133276010317;4873.658843880929;4876.171050921343;4892.87767805805;4383.693141480089;4429.092036132602;4483.865484035484;4493.123840851035;4540.091981603676;4491.034427598066;4526.162659907911;4528.97735511322;4532.0709254602725;4574.0394517151435;4338.501072376685;4363.258246098139;4392.2752745797225;4421.557844215585;4499.505054444025;4413.713108647928;4430.5126436092005;4431.423914891044;4439.689221754478;4476.61948734358;4428;4428.180786554465;4430.977845110754;4459.777011149462;4481.686281960264;4713.198756211452;4725.905481890343;4770.689905156154;4774.594159496447;4789.544993225638;5117;5119.948800511985;5140.254663073871;5151.381834179885;5213.139831927728;5043.36957880265;5165.070287348276;5167.819126330561;5171.198464238049;5171.844844654666;4830.178869592178;4831.9033619327765;4860.829870954571;4861.975690121527;4883.609311255091;5343.7862485500145;5364.114921037985;5367.68865817704;5379.354477462652;5417.052015897281;4957.925631115536;5002.124628190125;5129.589632829365;5140.126178549655;5147.0992576298995;4927.926081108786;5164.664296820694;5198.636095473356;5198.948010519922;5208.869778255498;5142.04872098663;5158.92261616076;5202.791888324425;5208.062548741263;5226.294450249167;5172.948270517322;5176.559992400613;5198.194279886624;5215.6609820361555;5247.7113758743635;4303.440552728125;4336.176126535948;4337.219300525936;4344.066025804404;4396.4284642996845;3827.9043023924623;3838.405047217686;3857.3828187489867;3877.3020856245585;3883.86406475772;4141.8964525887095;4167.8958026049595;4186.434831297796;4203.675842109726;4249.936250956238;4938.111139994764;5056.292119103328;5111.693298402108;5122.871928201825;5156.04613146569;4113.115680128787;4137.958620413758;4146.274401979642;4171.958280417157;4172.269852775752;4499.032707967803;4539.273716205391;4540.977295113504;4564.178447879413;4587.472440669299;4742.217534106834;4757.09615173116;4795.328653988375;4851.757412129379;4885.5847252983895;5082.3138876252715;5098.46466121052;5102.668326558762;5112.36095488064;5152.9742351288005;4796.928046079382;4803.903921921612;4804.783784729765;4829.637777166657;4883.658143929891;5007.499250074963;5018.87452813668;5046.747662616928;5072.898542029213;5153.819616313411;5091.389033316026;5091.414487334004;5097.821576244962;5109.131447653834;5155.200943853709;4956.281339205723;4958.826441074545;4960.131976904099;4963.131451995959;4973.45292017885;4886.242632391985;4891.95108048915;4973.35346404965;4991.051700176955;4994.625403094709;4779.402574678165;4871.585915197248;4888.9755551222015;4895.828645997373;4947.925781113358;5057.14028615129;5082.567981721595;5087.3132127163835;5092.159793634157;5101.7704203310195;4821.662483626113;4846.12769701443;4866.440359358578;4887.095887260868;4918.213085906238 12:34:37 INFO - PROCESS | 14138 | |1;ext.html;547.3896605285106;549.6894254746068;562.9690367029812;565.8076254073615;593.1399470767388;39533.40699889501;40813.38779918304;40853.182936341254;40881.79559102208;40890.18219635613;37407.812960935225;37684.05789855255;37803.62196378035;37818.24363512735;37845.24309513808;7753.767386978386;7879.4484386093;7930;7946.404019698517;7947.324477419426;7742.109657389387;7830.334421574173;7863.68545258189;7876.80307992299;7879.093904201033;7868.685252589889;7892.526448413114;7924.128345881948;7926.048874135112;7933.365330773524;7826.413019023567;7851.489653172554;7883.8423231535335;7896.328812050925;7897.24976127267;7822.765317040498;7833.060032796044;7846.254605812439;7856.489328193649;7865.567393793339;38027.23945521102;38121.61878381236;38530.22939541194;38568.228635427135;38578.421323680166;2885.5960165576835;3001;3029.4546981543313;3093.3503964167553;3105.673904240045;29350;29399.412011759858;29785.553216701766;30124;30400.783968641226;3330.533725278463;3367.601725498777;3422.161570415239;3431.1936694876686;3447.4484082546924;259400;260850;261579;262143;262473;32186.19534511656;33196.33607327888;33449.83275083609;52672.73663631657;52817.7359113202;34102;34190.14524636904;34334.14164645904;34382.14044648904;34390.14024649404;12539.24764514132;12717.236965782082;12729.490820367082;12747;12767.680807979688;10238.078572928473;10298.742531436774;10358.067773900386;10362.637307694195;10372.170226381872;7958.363330933512;8007.399445041528;8049.959750201211;8076.192380761877;8091.1504292048485;3114.8909788157307;3135.843207839599;3144.5283207518596;3169.271067654406;3175.9364812703616;735.6615956659996;772.9806754831062;809.1423091522887;858.9441686290371;904.8914130304406;24811.751882481305;25686.74313256881;25782.48435031289;25947.351316217246;25992.8700356497;847.9660813567389;852.9232369086687;865.6191275838611;871.7689812199773;928.6053427293373;13107.279099649611;13793.724125517434;13853.376598053112;13896.096753710977;13900.721985560232;387810;388025;390013;390646;393236;33127.66872331294;33355.332893342;33435.99692009244;33455;33537.496937545955;1173.4250217393417;1189.52419032386;1219.195331081482;1221.5480272299305;1232.5501192064833;23757.71161056116;25137.87431062833;25918.740812591634;25932;26096.34759131037;43337.566624333354;43389.132217356106;43625.34561981636;43768.562314376446;43819;333139;333568;333977;334412;338248;24977.125800596892;25315.240542783748;25604.35989100213;26002.08992685247;26026.86986565055;42728.35907461453;43028.56971430246;43042;43321;43381.3492797602;36721.63278367182;37209.44185837269;37275.81362093172;37275.81362093172;37964.62035379721;36915.81542092272;37119.25761484701;37450.81274593718;37615.43576846295;37749.4337584942;31266.374672506878;35752.82123589365;36096.27807443889;36645.26709465849;37014;31638.367232654757;33542;33761.49357759685;33805.66194338124;33873.49189762106;24800;24850.875745621157;25007.74992250127;25156;25409.640707859613 12:34:37 INFO - PROCESS | 14138 | |2;jquery.html;357.52270718590694;364.4878945082159;366.57477326301495;370.72751527627173;383.9021049632343;16443;17343;17651.82348176518;17778.82221177788;17803.109844507788;16365.42721004765;17226.913865430688;17290.2219400127;17303.394381196627;17316.567085822862;5116.795328186868;5239.292695486118;5284.2866213061125;5285.127953887623;5287.894242115155;3796.6962642988497;5206.739663016853;5733.827985160431;6035.69821508925;6065.5450841187085;6033.607815491979;6052.485538729214;6066.605670631395;6070.423309785563;6083.695815209244;5029.849104526852;5292.444293349181;5340.91988620171;5379.892402151974;5391.919121213185;5060.392752869642;5207.192885102815;5264.9733302006125;5270.2358158067245;5284.10170271051;12591.496340146383;12741.362931853462;12742.745145097138;18348.90825545877;21806.34580962574;1857.136431559318;1892.6782446984046;1934.7775005874364;1937.5349916020195;1952.2776572668204;9166.175044245983;9354.67258645951;9412.435253884789;9438.103380178873;9473.052694730472;1655.2634077835369;1687.5274923021573;1691.061460889206;1765.7439671247726;1784.4379020608467;72080;74739.87890181597;75072.62463687701;75520.62239688821;77554;9779.755506112404;9870.21038316933;9954.153896918842;10258;10351.275410721328;13774.65563360904;13904.165750055028;13929.442822287197;13955.302234888215;13996.30018499071;6901.206361268519;6955.513114081966;7048.330408611174;7065.116860392451;7236.204017558064;6318.462930650854;6442.9355706443275;6488.708008139645;6550;6560.704768285439;4263.126059157865;4304.978475107667;4349.891252718644;4350.956490435118;4467.24056910326;1632.1920649278684;1713.7343711724702;1816.2099486723318;1836.9448916532258;1841.1186493138196;816.2368185746346;847.1232274595887;852.4331319672473;885.198895000026;911.7766147293955;17637.823621763873;17736.29054837818;17868.374606888698;17887.910560447115;18169.909150454427;773.7794728502349;804.2520455975998;843.4601854812925;874.0647507167397;879.520661239626;8927.33045021626;8994.86507702385;9031.322650801085;9186.816263674822;9335.766605834908;375369;387604;393764;394104;394438;77777;81830;85288.57355713182;85573.58198135164;85647.14352856392;924.7826760711228;930.4882314726873;947.4173383369179;949.6486300069018;951.8096380723883;14548.563543093724;14640.341184646504;14765.557033289018;14796;14811.407543698131;35466.29067418585;35976.280474390886;36916.07709807276;37908.43137352997;38983.610163897996;54463;55346;55733;56000;57441;7377;7893.36853051743;7927.801804954922;7942.404319675932;7997.720079797179;11100.500477478694;11321.377324247245;11383.829242561202;11777.705557360792;11937.283762973902;9855.35940163887;9938.850917236103;10439.895601044196;10479.476026198812;10575.894241057798;9855;10044.347117437635;10044.945280745416;10123.59505619767;10165.542550585093;9839.458829764431;9958.900410995797;10378.06597406237;10540.736481588021;10811.189160813128;7388.7808511594985;7540.472166948261;7573.545587264782;7754.806129846799;7831.138574756658;9504.809903802023;10089.091861945106;10102.595896164365;10120.696379108638;10199.898001019896 12:34:37 INFO - PROCESS | 14138 | |3;mootools.html;1333.1001573937592;1379.7585422551053;1416.3414012484193;1653.1899369309042;1680.7394853797666;6474;7119.786406407803;7221.277872212776;7689.3464055555205;7700.730474433389;7309.744158954438;7518.097828260603;7602.619869006541;7626.351760100384;7647.655855486517;2157.590057889;2196.8352373571965;2205.856619319747;2209.4034610655194;2213.2585583829355;2139.5613899150635;2146.785321467856;2211;2220.955580888381;2223.3107736601705;2083.7707852136255;2177.618916689573;2178.4662757624324;2179.3461961411595;2184.14818220894;2150.827933765295;2152.7309086364203;2171.6416791229426;2176.52116534363;2189.2665956904457;2107.346722516025;2114.4291041418883;2120.936371908845;2123.182574708733;2123.4903623130335;7383.335499805044;7390.556566605967;7411.925880741178;7449.255074492507;7454.701811927516;4534.093181363707;4620.768961551909;4652.395188625491;4680.64895132863;4691.62467002639;2774.4312415954682;2839.7018313077037;2866.226118947893;2873.8504598160694;2881.5389537673873;848.0840692052568;860.7460799064291;882.5851849630664;883.1830556734994;894.9328800339936;10050.597976080948;10096.596136154545;10122;10164.136048435967;10170.338927969658;3894.2406230784727;3919.5296564411883;4029.516458024997;4098.262312783728;4107.568705285902;8003.5197888126895;8012.639431225609;8014.759557213293;8075.757727268191;8083.595820209083;4453.643708503312;4454.153710794939;4454.420925279693;4474.149911516802;4496;3608.9278214435562;3998.8800335989968;4158.438610787565;4196.748195108304;4199.811008504625;3315.61870384904;3346.4980252961764;3374.2239284964594;3395.6774106459848;3429.2455659754814;1008.2287050406445;1044.4673216659407;1054.783769327286;1055.1189756553365;1063.3354153653966;667.8397184675642;702.0206811498034;813.1786895235855;816.155279285948;823.7734622978729;5009.89980200394;5044.646874718735;5058.797648094109;5127.3847138343635;5183.740812959412;395.5787086752599;402.8589993502251;404.33083247225886;405.4107897043596;408.11846411750474;3455.447128459434;3491.773034752733;3517.736169787276;3555.235624340779;3615.9819200903826;8160.877586836202;8440.198181172778;8454.57727113654;8509.489430634181;8552.10202928696;8400.579971001425;8423.326133909273;8425.4944703318;8472.703455379033;8512.616932237941;6679.298673639198;6707.195136583641;6743.7976860695235;6746.527743057939;6772.390484856386;4801.831935882227;4832.299316599003;4916.70499770015;4919.606431485544;4934.506549345037;7915.881261780963;7934.166912474107;8171.79570510742;8192.631331589973;8275.917240827515;8129.227723366271;8312.25189732927;8361.247487726134;8393.706220282262;8492.91507084946;5787.247657804459;6275.466585340298;6513.088167656627;6526.9347306528225;6766.1204043476;7124.3944264736;7151.4278857690215;7164.856702866018;7195.424366050808;7210.098737657793;6036.456718895321;6327.873442531216;6372.808815735535;6420.06908998202;6508;6181.227346581677;6321.431071203429;6373.904391434039;6429.9678501607195;6452.419282264619;5896;5916.112583112567;5959.225300711053;5963.821085367446;5975.521958243417;4218.704690671623;4230.682698797541;4269.87190384289;4313.482382114166;4352.86941391746;4271.5514870938105;4303.096349766459;4311.008468052428;4398.230309695854;4402.9559704402545 12:34:37 INFO - PROCESS | 14138 | |4;prototype.html;300.1296240901386;301.4242796259145;303.7645824486024;307.6047279246169;308.2970826515544;5022.547970682638;5054.646174767768;5068.949310506894;5078.492150784919;5095.898082038357;4987.925181122277;4999.925001124986;5000.624953128521;5009.574186194178;5013.924791128136;3735.533058367711;3842.711796615251;3941.6255455731803;3953.952202666281;3963.6829053675783;3909.6707119579337;3942.7437216580975;3948.4669569608022;3948.822302996358;3958.9010274743073;3937.086555948592;3941.2117576484816;3948.486696729421;3950.822213000422;3953.782541960191;3804.2962052020466;3872.1287710265246;3927.2341893330813;3938.684905207591;3942.6254505821903;3462.2036931505645;3462.5498685170764;3467.930641387183;3470.9587123862993;3500.916954412146;4896.265560165968;4906.950930490685;4920.827771028033;4926.926096108526;4928.901421971541;4322.206284391974;4476.306172543261;4489.393931819195;4495.213337665896;4497.123061003105;5221.973890130563;5244.554212891909;5244.79020839166;5253.52718255355;5273.604479664003;3793.487879136309;3799.7530160539477;3803.2393521295576;3807.219519998421;3811.8284677189317;5346.91979620306;5478.863028424282;5482.273083978574;5510.338759348863;5510.586705997066;3872.6514613684903;3885.2423777363706;3892;3896.5129358830145;3903.2388684206876;3919.3141200289833;3935.2916475034767;3943.408488726714;3945.829793613501;3947.5657677655436;4425.84509542171;4432.202203603318;4441.178381999341;4444.2444784386735;4459.197344478025;5101.438841727407;5169.53474187325;5222.120036786754;5260.263563101169;5263.868403289872;1358.8517702541337;1372.5539199760117;1378.7518246715488;1380.6962468256968;1381.4405165907824;851.4848516647463;872.289084396215;872.5244741615835;883.3242569434387;890.7327801659476;4118.485189351331;4252.170826688766;4258.317964404043;4263.211305908417;4273.188094262143;5325.813596524103;5334.892717376614;5335.226392173113;5339.86650333737;5344.331958505187;4283.892902677458;4284;4284.400183974246;4285.3786201000685;4302.117581220589;2679.812413131062;2833.574963755453;2835.2911772056987;2841.1476557032806;2844.431113777253;5014.974925125351;5035.823746168867;5040.84877453677;5041.873953151201;5051.696898186047;5389.649672771257;5447;5501;5502.449755024466;5529.529989950819;4971.130052240916;5020.297158397827;5028.79884804611;5033.370828646419;5033.590594633509;5257.500537449089;5262.605304602093;5264.868378290574;5266.789328426973;5269.473052694853;5128.435872054146;5237.738113094254;5289.576833853205;5301.867453313698;5318.883034562785;4959.752012399294;4974.303597496281;4980.850574482772;5013.799448022184;5030.496950304941;3906.1992291580727;3913.4325522799604;3920.666743326849;3929.528456585228;3945.6054394560315;5118.872028199325;5320.707361095177;5327.813526526553;5357.785688572413;5394.136938089887;5246.868828279171;5250.97374513125;5268.841934741964;5276.129438642581;5277.366715993951;5246.213068039825;5253.684778913277;5264.15773476242;5277.20841873722;5285;4888.5111488850835;5135.255387968649;5142.562882155059;5143.71709555963;5175.663581867167;5055.393352797688;5147.536721695065;5283.2075188722;5286.889753151881;5304.469553044664;5127.333446651912;5138.871528211825;5164.535191832753;5176.637635365639;5177.715225662625 12:34:37 INFO - PROCESS | 14138 | |5;yui.html;637.9425851673349;732.4945787406692;747.6373958630063;750.6059318857602;763.4083585221456;11166.330020198793;11900.345480998541;11936.880631193686;11937.34344611046;11976.94011529941;11327.603533876316;11349.20555561111;11355.772884542304;11380.658580242605;11413.600523981662;624.4816802054283;758.8861670749391;778.5717855179629;784.525362155896;785.7289235213842;745.9142198647171;770.452978385347;771.3906014248737;774.601080443572;774.7598244544181;822.6051495282238;822.9958850205741;824.5794644731201;831.5966756123275;834.1366685480529;816.346922462031;817.2032268538187;825.0759149752256;825.9256666899978;827.606886728805;601.491739480143;603.0532064658488;604.8639056212317;606.3027518353884;606.3784620763709;12029.879701202963;12087.818682719766;12123.696907577292;12143.149979501439;12150.45322960469;13092.410841512059;13489.662758431019;13605.931970340183;13692.246926419042;13705.45178192871;9815.705528834147;9934.701958941243;9988.800223995551;10002.099811016971;10087.394756314645;3275.410426123297;3312.867485300609;3321.8837340693203;3352.0614228016193;3367.107716455141;59769.7011514944;60132.69933650347;60678.999999999556;60904;61615;10009.499525023719;10154.898451015542;10343.896561034293;10385.792284154275;10677;19437.125329360213;19572.119254633577;19603.215871364984;19624.90187549053;19914.60170796576;6896.655167241618;6944.826379340456;7072.186698529632;7078.433725301964;7203.603801790951;3778.6977041836585;3800.201957588882;3824.8852534424013;3830.885073447801;3833.9424908626393;2680.195941217627;2763.765079968185;2778.5554311310093;2778.7356752677483;2782.2070709847594;471.4719514144112;473.56432082484196;473.8510853280357;474.9501302363202;476.6139427064089;549.9505044546011;584.3134317177385;631.2551189596229;635.088647790413;646.1664452855763;8162.836743265101;8273.875891861628;8392.20274073962;8449.493030418194;8451.873221901677;574.115861573181;586.4047991288845;598.5421152818097;610.1823556434399;611.4894063456974;3830.636089571486;3972.106276087857;4025.355943049157;4086.6117718816663;4222.641075508616;84284.57857710795;91324.5433772827;93783.53108234552;93808;94418.52790736002;80679.19320806835;81215.5939220312;81756.59121704353;81874.59062704648;83150.58424707838;44702;61939.690301549104;72621.6368918152;74025;75697;7828.608569571385;7950.801229969297;7960.124386317616;8092.028956525254;8100.230478104806;30663.2334191647;32888;41179.38230926599;41281.1743765117;42592.5740742601;38262.80868595639;61963.6901815488;63029.36970630418;63238.367616325086;63476.365236348895;9636.42181469114;10003.849942251018;10151.492425378554;10341.4312212829;10342.896571034193;10837.67486975392;11030;11146.665600032013;11281.21031527785;11377.374244416636;10068.496575171359;10489.52797124116;10644.254902156774;10705.464726763787;10922.344659320466;9755.073268039809;9757.512124393894;10397.220208484545;10824.350538967687;10828.5127169276;10729.248952573556;10843.589973946548;10868;10965.780684386427;11113.722156946142;9318.15455962909;9360.251179905727;9389.43663380172;9464.053594640482;9736.464494452874;9390;9844.9015509844;9881.950590247003;9896.455694936847;9999.450030248116 12:34:37 INFO - PROCESS | 14138 | __end_tp_report 12:34:37 INFO - PROCESS | 14138 | __start_cc_report 12:34:37 INFO - PROCESS | 14138 | _x_x_mozilla_cycle_collect,391 12:34:37 INFO - PROCESS | 14138 | __end_cc_report 12:34:37 INFO - PROCESS | 14138 | __startTimestamp1468265677757__endTimestamp 12:34:37 INFO - PROCESS | 14138 | 12:34:37 INFO - PROCESS | 14138 | ------- Summary: start ------- 12:34:37 INFO - PROCESS | 14138 | Number of tests: 6 12:34:37 INFO - PROCESS | 14138 | 12:34:37 INFO - PROCESS | 14138 | [#0] dojo.html Cycles:165 Average:4736.64 Median:4868.78 stddev:511.08 (10.5%) stddev-sans-first:485.27 12:34:37 INFO - PROCESS | 14138 | Values: 2632.9 2656.6 2682.7 2689.8 2702.7 4769.1 4805.3 4844.3 4846.7 4868.8 4723.2 4815.1 4873.7 4876.2 4892.9 4383.7 4429.1 4483.9 4493.1 4540.1 4491.0 4526.2 4529.0 4532.1 4574.0 4338.5 4363.3 4392.3 4421.6 4499.5 4413.7 4430.5 4431.4 4439.7 4476.6 4428.0 4428.2 4431.0 4459.8 4481.7 4713.2 4725.9 4770.7 4774.6 4789.5 5117.0 5119.9 5140.3 5151.4 5213.1 5043.4 5165.1 5167.8 5171.2 5171.8 4830.2 4831.9 4860.8 4862.0 4883.6 5343.8 5364.1 5367.7 5379.4 5417.1 4957.9 5002.1 5129.6 5140.1 5147.1 4927.9 5164.7 5198.6 5198.9 5208.9 5142.0 5158.9 5202.8 5208.1 5226.3 5172.9 5176.6 5198.2 5215.7 5247.7 4303.4 4336.2 4337.2 4344.1 4396.4 3827.9 3838.4 3857.4 3877.3 3883.9 4141.9 4167.9 4186.4 4203.7 4249.9 4938.1 5056.3 5111.7 5122.9 5156.0 4113.1 4138.0 4146.3 4172.0 4172.3 4499.0 4539.3 4541.0 4564.2 4587.5 4742.2 4757.1 4795.3 4851.8 4885.6 5082.3 5098.5 5102.7 5112.4 5153.0 4796.9 4803.9 4804.8 4829.6 4883.7 5007.5 5018.9 5046.7 5072.9 5153.8 5091.4 5091.4 5097.8 5109.1 5155.2 4956.3 4958.8 4960.1 4963.1 4973.5 4886.2 4892.0 4973.4 4991.1 4994.6 4779.4 4871.6 4889.0 4895.8 4947.9 5057.1 5082.6 5087.3 5092.2 5101.8 4821.7 4846.1 4866.4 4887.1 4918.2 12:34:37 INFO - PROCESS | 14138 | 12:34:37 INFO - PROCESS | 14138 | [#1] ext.html Cycles:180 Average:46381.74 Median:36370.77 stddev:87921.33 (241.7%) stddev-sans-first:88100.63 12:34:37 INFO - PROCESS | 14138 | Values: 547.4 549.7 563.0 565.8 593.1 39533.4 40813.4 40853.2 40881.8 40890.2 37407.8 37684.1 37803.6 37818.2 37845.2 7753.8 7879.4 7930.0 7946.4 7947.3 7742.1 7830.3 7863.7 7876.8 7879.1 7868.7 7892.5 7924.1 7926.0 7933.4 7826.4 7851.5 7883.8 7896.3 7897.2 7822.8 7833.1 7846.3 7856.5 7865.6 38027.2 38121.6 38530.2 38568.2 38578.4 2885.6 3001.0 3029.5 3093.4 3105.7 29350.0 29399.4 29785.6 30124.0 30400.8 3330.5 3367.6 3422.2 3431.2 3447.4 259400.0 260850.0 261579.0 262143.0 262473.0 32186.2 33196.3 33449.8 52672.7 52817.7 34102.0 34190.1 34334.1 34382.1 34390.1 12539.2 12717.2 12729.5 12747.0 12767.7 10238.1 10298.7 10358.1 10362.6 10372.2 7958.4 8007.4 8050.0 8076.2 8091.2 3114.9 3135.8 3144.5 3169.3 3175.9 735.7 773.0 809.1 858.9 904.9 24811.8 25686.7 25782.5 25947.4 25992.9 848.0 852.9 865.6 871.8 928.6 13107.3 13793.7 13853.4 13896.1 13900.7 387810.0 388025.0 390013.0 390646.0 393236.0 33127.7 33355.3 33436.0 33455.0 33537.5 1173.4 1189.5 1219.2 1221.5 1232.6 23757.7 25137.9 25918.7 25932.0 26096.3 43337.6 43389.1 43625.3 43768.6 43819.0 333139.0 333568.0 333977.0 334412.0 338248.0 24977.1 25315.2 25604.4 26002.1 26026.9 42728.4 43028.6 43042.0 43321.0 43381.3 36721.6 37209.4 37275.8 37275.8 37964.6 36915.8 37119.3 37450.8 37615.4 37749.4 31266.4 35752.8 36096.3 36645.3 37014.0 31638.4 33542.0 33761.5 33805.7 33873.5 24800.0 24850.9 25007.7 25156.0 25409.6 12:34:37 INFO - PROCESS | 14138 | 12:34:37 INFO - PROCESS | 14138 | [#2] jquery.html Cycles:180 Average:24618.55 Median:5206.97 stddev:64609.18 (1240.8%) stddev-sans-first:64764.75 12:34:37 INFO - PROCESS | 14138 | Values: 357.5 364.5 366.6 370.7 383.9 16443.0 17343.0 17651.8 17778.8 17803.1 16365.4 17226.9 17290.2 17303.4 17316.6 5116.8 5239.3 5284.3 5285.1 5287.9 3796.7 5206.7 5733.8 6035.7 6065.5 6033.6 6052.5 6066.6 6070.4 6083.7 5029.8 5292.4 5340.9 5379.9 5391.9 5060.4 5207.2 5265.0 5270.2 5284.1 12591.5 12741.4 12742.7 18348.9 21806.3 1857.1 1892.7 1934.8 1937.5 1952.3 9166.2 9354.7 9412.4 9438.1 9473.1 1655.3 1687.5 1691.1 1765.7 1784.4 72080.0 74739.9 75072.6 75520.6 77554.0 9779.8 9870.2 9954.2 10258.0 10351.3 13774.7 13904.2 13929.4 13955.3 13996.3 6901.2 6955.5 7048.3 7065.1 7236.2 6318.5 6442.9 6488.7 6550.0 6560.7 4263.1 4305.0 4349.9 4351.0 4467.2 1632.2 1713.7 1816.2 1836.9 1841.1 816.2 847.1 852.4 885.2 911.8 17637.8 17736.3 17868.4 17887.9 18169.9 773.8 804.3 843.5 874.1 879.5 8927.3 8994.9 9031.3 9186.8 9335.8 375369.0 387604.0 393764.0 394104.0 394438.0 77777.0 81830.0 85288.6 85573.6 85647.1 924.8 930.5 947.4 949.6 951.8 14548.6 14640.3 14765.6 14796.0 14811.4 35466.3 35976.3 36916.1 37908.4 38983.6 54463.0 55346.0 55733.0 56000.0 57441.0 7377.0 7893.4 7927.8 7942.4 7997.7 11100.5 11321.4 11383.8 11777.7 11937.3 9855.4 9938.9 10439.9 10479.5 10575.9 9855.0 10044.3 10044.9 10123.6 10165.5 9839.5 9958.9 10378.1 10540.7 10811.2 7388.8 7540.5 7573.5 7754.8 7831.1 9504.8 10089.1 10102.6 10120.7 10199.9 12:34:37 INFO - PROCESS | 14138 | 12:34:37 INFO - PROCESS | 14138 | [#3] mootools.html Cycles:180 Average:4818.00 Median:4817.07 stddev:2629.31 (54.6%) stddev-sans-first:2623.65 12:34:37 INFO - PROCESS | 14138 | Values: 1333.1 1379.8 1416.3 1653.2 1680.7 6474.0 7119.8 7221.3 7689.3 7700.7 7309.7 7518.1 7602.6 7626.4 7647.7 2157.6 2196.8 2205.9 2209.4 2213.3 2139.6 2146.8 2211.0 2221.0 2223.3 2083.8 2177.6 2178.5 2179.3 2184.1 2150.8 2152.7 2171.6 2176.5 2189.3 2107.3 2114.4 2120.9 2123.2 2123.5 7383.3 7390.6 7411.9 7449.3 7454.7 4534.1 4620.8 4652.4 4680.6 4691.6 2774.4 2839.7 2866.2 2873.9 2881.5 848.1 860.7 882.6 883.2 894.9 10050.6 10096.6 10122.0 10164.1 10170.3 3894.2 3919.5 4029.5 4098.3 4107.6 8003.5 8012.6 8014.8 8075.8 8083.6 4453.6 4454.2 4454.4 4474.1 4496.0 3608.9 3998.9 4158.4 4196.7 4199.8 3315.6 3346.5 3374.2 3395.7 3429.2 1008.2 1044.5 1054.8 1055.1 1063.3 667.8 702.0 813.2 816.2 823.8 5009.9 5044.6 5058.8 5127.4 5183.7 395.6 402.9 404.3 405.4 408.1 3455.4 3491.8 3517.7 3555.2 3616.0 8160.9 8440.2 8454.6 8509.5 8552.1 8400.6 8423.3 8425.5 8472.7 8512.6 6679.3 6707.2 6743.8 6746.5 6772.4 4801.8 4832.3 4916.7 4919.6 4934.5 7915.9 7934.2 8171.8 8192.6 8275.9 8129.2 8312.3 8361.2 8393.7 8492.9 5787.2 6275.5 6513.1 6526.9 6766.1 7124.4 7151.4 7164.9 7195.4 7210.1 6036.5 6327.9 6372.8 6420.1 6508.0 6181.2 6321.4 6373.9 6430.0 6452.4 5896.0 5916.1 5959.2 5963.8 5975.5 4218.7 4230.7 4269.9 4313.5 4352.9 4271.6 4303.1 4311.0 4398.2 4403.0 12:34:37 INFO - PROCESS | 14138 | 12:34:37 INFO - PROCESS | 14138 | [#4] prototype.html Cycles:180 Average:4334.86 Median:4993.93 stddev:1250.29 (25.0%) stddev-sans-first:1216.57 12:34:37 INFO - PROCESS | 14138 | Values: 300.1 301.4 303.8 307.6 308.3 5022.5 5054.6 5068.9 5078.5 5095.9 4987.9 4999.9 5000.6 5009.6 5013.9 3735.5 3842.7 3941.6 3954.0 3963.7 3909.7 3942.7 3948.5 3948.8 3958.9 3937.1 3941.2 3948.5 3950.8 3953.8 3804.3 3872.1 3927.2 3938.7 3942.6 3462.2 3462.5 3467.9 3471.0 3500.9 4896.3 4907.0 4920.8 4926.9 4928.9 4322.2 4476.3 4489.4 4495.2 4497.1 5222.0 5244.6 5244.8 5253.5 5273.6 3793.5 3799.8 3803.2 3807.2 3811.8 5346.9 5478.9 5482.3 5510.3 5510.6 3872.7 3885.2 3892.0 3896.5 3903.2 3919.3 3935.3 3943.4 3945.8 3947.6 4425.8 4432.2 4441.2 4444.2 4459.2 5101.4 5169.5 5222.1 5260.3 5263.9 1358.9 1372.6 1378.8 1380.7 1381.4 851.5 872.3 872.5 883.3 890.7 4118.5 4252.2 4258.3 4263.2 4273.2 5325.8 5334.9 5335.2 5339.9 5344.3 4283.9 4284.0 4284.4 4285.4 4302.1 2679.8 2833.6 2835.3 2841.1 2844.4 5015.0 5035.8 5040.8 5041.9 5051.7 5389.6 5447.0 5501.0 5502.4 5529.5 4971.1 5020.3 5028.8 5033.4 5033.6 5257.5 5262.6 5264.9 5266.8 5269.5 5128.4 5237.7 5289.6 5301.9 5318.9 4959.8 4974.3 4980.9 5013.8 5030.5 3906.2 3913.4 3920.7 3929.5 3945.6 5118.9 5320.7 5327.8 5357.8 5394.1 5246.9 5251.0 5268.8 5276.1 5277.4 5246.2 5253.7 5264.2 5277.2 5285.0 4888.5 5135.3 5142.6 5143.7 5175.7 5055.4 5147.5 5283.2 5286.9 5304.5 5127.3 5138.9 5164.5 5176.6 5177.7 12:34:37 INFO - PROCESS | 14138 | 12:34:37 INFO - PROCESS | 14138 | [#5] yui.html Cycles:180 Average:16661.46 Median:30184.12 stddev:23812.34 (78.9%) stddev-sans-first:23848.74 12:34:37 INFO - PROCESS | 14138 | Values: 637.9 732.5 747.6 750.6 763.4 11166.3 11900.3 11936.9 11937.3 11976.9 11327.6 11349.2 11355.8 11380.7 11413.6 624.5 758.9 778.6 784.5 785.7 745.9 770.5 771.4 774.6 774.8 822.6 823.0 824.6 831.6 834.1 816.3 817.2 825.1 825.9 827.6 601.5 603.1 604.9 606.3 606.4 12029.9 12087.8 12123.7 12143.1 12150.5 13092.4 13489.7 13605.9 13692.2 13705.5 9815.7 9934.7 9988.8 10002.1 10087.4 3275.4 3312.9 3321.9 3352.1 3367.1 59769.7 60132.7 60679.0 60904.0 61615.0 10009.5 10154.9 10343.9 10385.8 10677.0 19437.1 19572.1 19603.2 19624.9 19914.6 6896.7 6944.8 7072.2 7078.4 7203.6 3778.7 3800.2 3824.9 3830.9 3833.9 2680.2 2763.8 2778.6 2778.7 2782.2 471.5 473.6 473.9 475.0 476.6 550.0 584.3 631.3 635.1 646.2 8162.8 8273.9 8392.2 8449.5 8451.9 574.1 586.4 598.5 610.2 611.5 3830.6 3972.1 4025.4 4086.6 4222.6 84284.6 91324.5 93783.5 93808.0 94418.5 80679.2 81215.6 81756.6 81874.6 83150.6 44702.0 61939.7 72621.6 74025.0 75697.0 7828.6 7950.8 7960.1 8092.0 8100.2 30663.2 32888.0 41179.4 41281.2 42592.6 38262.8 61963.7 63029.4 63238.4 63476.4 9636.4 10003.8 10151.5 10341.4 10342.9 10837.7 11030.0 11146.7 11281.2 11377.4 10068.5 10489.5 10644.3 10705.5 10922.3 9755.1 9757.5 10397.2 10824.4 10828.5 10729.2 10843.6 10868.0 10965.8 11113.7 9318.2 9360.3 9389.4 9464.1 9736.5 9390.0 9844.9 9882.0 9896.5 9999.5 12:34:37 INFO - PROCESS | 14138 | -------- Summary: end -------- 12:34:37 INFO - PROCESS | 14138 | 12:34:38 INFO - TEST-INFO | 14138: exit 0 12:34:38 INFO - TEST-OK | dromaeo_css | took 1116413ms 12:34:38 INFO - TEST-START | kraken 12:34:38 INFO - operating with platform_type : linux_ 12:34:38 INFO - Initialising browser for kraken test... 12:34:38 INFO - TEST-INFO | started process 14383 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSMdiAa/profile http://localhost:54338/getInfo.html) 12:34:43 INFO - PROCESS | 14383 | __metrics Screen width/height:1600/1200 12:34:43 INFO - PROCESS | 14383 | colorDepth:24 12:34:43 INFO - PROCESS | 14383 | Browser inner width/height: 1024/697 12:34:43 INFO - PROCESS | 14383 | __metrics 12:34:43 ERROR - PROCESS | 14383 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 12:34:44 INFO - TEST-INFO | 14383: exit 0 12:34:44 INFO - Browser initialized. 12:34:44 INFO - Running cycle 1/1 for kraken test... 12:34:44 INFO - TEST-INFO | started process 14500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSMdiAa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:34:56 INFO - PROCESS | 14500 | RSS: Main: 168714240 12:34:56 INFO - PROCESS | 14500 | 12:34:59 INFO - PROCESS | 14500 | Cycle 1(1): loaded http://localhost:54338/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54338/tests/kraken/driver.html?testName=audio-beat-detection) 12:35:00 INFO - PROCESS | 14500 | RSS: Main: 173629440 12:35:00 INFO - PROCESS | 14500 | 12:35:03 INFO - PROCESS | 14500 | Cycle 1(1): loaded http://localhost:54338/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54338/tests/kraken/driver.html?testName=audio-dft) 12:35:03 INFO - PROCESS | 14500 | RSS: Main: 173289472 12:35:03 INFO - PROCESS | 14500 | 12:35:06 INFO - PROCESS | 14500 | Cycle 1(1): loaded http://localhost:54338/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54338/tests/kraken/driver.html?testName=audio-fft) 12:35:07 INFO - PROCESS | 14500 | RSS: Main: 168267776 12:35:07 INFO - PROCESS | 14500 | 12:35:09 INFO - PROCESS | 14500 | Cycle 1(1): loaded http://localhost:54338/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54338/tests/kraken/driver.html?testName=audio-oscillator) 12:35:10 INFO - PROCESS | 14500 | RSS: Main: 168673280 12:35:10 INFO - PROCESS | 14500 | 12:35:12 INFO - PROCESS | 14500 | Cycle 1(1): loaded http://localhost:54338/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54338/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:35:12 INFO - PROCESS | 14500 | RSS: Main: 169148416 12:35:12 INFO - PROCESS | 14500 | 12:35:16 INFO - PROCESS | 14500 | Cycle 1(1): loaded http://localhost:54338/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54338/tests/kraken/driver.html?testName=imaging-darkroom) 12:35:16 INFO - PROCESS | 14500 | RSS: Main: 169267200 12:35:16 INFO - PROCESS | 14500 | 12:35:20 INFO - PROCESS | 14500 | Cycle 1(1): loaded http://localhost:54338/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54338/tests/kraken/driver.html?testName=imaging-desaturate) 12:35:20 INFO - PROCESS | 14500 | RSS: Main: 166834176 12:35:20 INFO - PROCESS | 14500 | 12:35:23 INFO - PROCESS | 14500 | Cycle 1(1): loaded http://localhost:54338/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54338/tests/kraken/driver.html?testName=json-parse-financial) 12:35:24 INFO - PROCESS | 14500 | RSS: Main: 168124416 12:35:24 INFO - PROCESS | 14500 | 12:35:26 INFO - PROCESS | 14500 | Cycle 1(1): loaded http://localhost:54338/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54338/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:35:26 INFO - PROCESS | 14500 | RSS: Main: 168570880 12:35:26 INFO - PROCESS | 14500 | 12:35:28 INFO - PROCESS | 14500 | Cycle 1(1): loaded http://localhost:54338/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54338/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:35:29 INFO - PROCESS | 14500 | RSS: Main: 169373696 12:35:29 INFO - PROCESS | 14500 | 12:35:31 INFO - PROCESS | 14500 | Cycle 1(1): loaded http://localhost:54338/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54338/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:35:32 INFO - PROCESS | 14500 | RSS: Main: 169746432 12:35:32 INFO - PROCESS | 14500 | 12:35:35 INFO - PROCESS | 14500 | Cycle 1(1): loaded http://localhost:54338/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:35:35 INFO - PROCESS | 14500 | RSS: Main: 169664512 12:35:35 INFO - PROCESS | 14500 | 12:35:38 INFO - PROCESS | 14500 | Cycle 1(1): loaded http://localhost:54338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:35:39 INFO - PROCESS | 14500 | RSS: Main: 169353216 12:35:39 INFO - PROCESS | 14500 | 12:35:41 INFO - PROCESS | 14500 | Cycle 1(1): loaded http://localhost:54338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54338/tests/kraken/driver.html?testName=ai-astar) 12:35:41 INFO - PROCESS | 14500 | RSS: Main: 170311680 12:35:41 INFO - PROCESS | 14500 | 12:35:41 INFO - PROCESS | 14500 | __start_tp_report 12:35:41 INFO - PROCESS | 14500 | _x_x_mozilla_page_load 12:35:41 INFO - PROCESS | 14500 | _x_x_mozilla_page_load_details 12:35:41 INFO - PROCESS | 14500 | |i|pagename|runs| 12:35:41 INFO - PROCESS | 14500 | |0;ai-astar;108;114;107;115;114;118;115;116;113;114 12:35:41 INFO - PROCESS | 14500 | |1;audio-beat-detection;150;125;152;178;129;156;147;124;191;126 12:35:41 INFO - PROCESS | 14500 | |2;audio-dft;162;162;163;165;174;163;162;163;162;162 12:35:41 INFO - PROCESS | 14500 | |3;audio-fft;75;75;75;148;77;78;76;76;172;76 12:35:41 INFO - PROCESS | 14500 | |4;audio-oscillator;87;86;148;87;87;85;136;86;87;140 12:35:41 INFO - PROCESS | 14500 | |5;imaging-gaussian-blur;118;118;118;117;118;117;119;118;117;118 12:35:41 INFO - PROCESS | 14500 | |6;imaging-darkroom;147;147;148;148;148;149;148;148;149;148 12:35:41 INFO - PROCESS | 14500 | |7;imaging-desaturate;96;96;96;96;96;97;96;96;102;96 12:35:41 INFO - PROCESS | 14500 | |8;json-parse-financial;63;64;64;65;65;65;64;67;64;64 12:35:41 INFO - PROCESS | 14500 | |9;json-stringify-tinderbox;65;64;65;64;64;64;64;64;64;64 12:35:41 INFO - PROCESS | 14500 | |10;stanford-crypto-aes;80;81;90;80;81;81;83;83;84;85 12:35:41 INFO - PROCESS | 14500 | |11;stanford-crypto-ccm;137;130;146;130;132;129;133;146;178;136 12:35:41 INFO - PROCESS | 14500 | |12;stanford-crypto-pbkdf2;176;177;173;171;174;172;177;176;172;171 12:35:41 INFO - PROCESS | 14500 | |13;stanford-crypto-sha256-iterative;71;69;77;67;68;68;71;68;69;67 12:35:41 INFO - PROCESS | 14500 | __end_tp_report 12:35:41 INFO - PROCESS | 14500 | __start_cc_report 12:35:41 INFO - PROCESS | 14500 | _x_x_mozilla_cycle_collect,992 12:35:41 INFO - PROCESS | 14500 | __end_cc_report 12:35:41 INFO - PROCESS | 14500 | __startTimestamp1468265741286__endTimestamp 12:35:41 INFO - PROCESS | 14500 | 12:35:41 INFO - PROCESS | 14500 | ------- Summary: start ------- 12:35:41 INFO - PROCESS | 14500 | Number of tests: 14 12:35:41 INFO - PROCESS | 14500 | 12:35:41 INFO - PROCESS | 14500 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.50 stddev:3.41 (3.0%) stddev-sans-first:3.00 12:35:41 INFO - PROCESS | 14500 | Values: 108.0 114.0 107.0 115.0 114.0 118.0 115.0 116.0 113.0 114.0 12:35:41 INFO - PROCESS | 14500 | 12:35:41 INFO - PROCESS | 14500 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:151.00 stddev:23.05 (15.3%) stddev-sans-first:24.44 12:35:41 INFO - PROCESS | 14500 | Values: 150.0 125.0 152.0 178.0 129.0 156.0 147.0 124.0 191.0 126.0 12:35:41 INFO - PROCESS | 14500 | 12:35:41 INFO - PROCESS | 14500 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:3.71 (2.3%) stddev-sans-first:3.87 12:35:41 INFO - PROCESS | 14500 | Values: 162.0 162.0 163.0 165.0 174.0 163.0 162.0 163.0 162.0 162.0 12:35:41 INFO - PROCESS | 14500 | 12:35:41 INFO - PROCESS | 14500 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:35.88 (47.2%) stddev-sans-first:37.47 12:35:41 INFO - PROCESS | 14500 | Values: 75.0 75.0 75.0 148.0 77.0 78.0 76.0 76.0 172.0 76.0 12:35:41 INFO - PROCESS | 14500 | 12:35:41 INFO - PROCESS | 14500 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:86.50 stddev:26.69 (30.8%) stddev-sans-first:27.68 12:35:41 INFO - PROCESS | 14500 | Values: 87.0 86.0 148.0 87.0 87.0 85.0 136.0 86.0 87.0 140.0 12:35:41 INFO - PROCESS | 14500 | 12:35:41 INFO - PROCESS | 14500 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 12:35:41 INFO - PROCESS | 14500 | Values: 118.0 118.0 118.0 117.0 118.0 117.0 119.0 118.0 117.0 118.0 12:35:41 INFO - PROCESS | 14500 | 12:35:41 INFO - PROCESS | 14500 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 12:35:41 INFO - PROCESS | 14500 | Values: 147.0 147.0 148.0 148.0 148.0 149.0 148.0 148.0 149.0 148.0 12:35:41 INFO - PROCESS | 14500 | 12:35:41 INFO - PROCESS | 14500 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:1.89 (2.0%) stddev-sans-first:1.99 12:35:41 INFO - PROCESS | 14500 | Values: 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 102.0 96.0 12:35:41 INFO - PROCESS | 14500 | 12:35:41 INFO - PROCESS | 14500 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.50 stddev:1.08 (1.7%) stddev-sans-first:1.00 12:35:41 INFO - PROCESS | 14500 | Values: 63.0 64.0 64.0 65.0 65.0 65.0 64.0 67.0 64.0 64.0 12:35:41 INFO - PROCESS | 14500 | 12:35:41 INFO - PROCESS | 14500 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 12:35:41 INFO - PROCESS | 14500 | Values: 65.0 64.0 65.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 12:35:41 INFO - PROCESS | 14500 | 12:35:41 INFO - PROCESS | 14500 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:3.05 (3.7%) stddev-sans-first:3.06 12:35:41 INFO - PROCESS | 14500 | Values: 80.0 81.0 90.0 80.0 81.0 81.0 83.0 83.0 84.0 85.0 12:35:41 INFO - PROCESS | 14500 | 12:35:41 INFO - PROCESS | 14500 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:136.50 stddev:14.81 (10.9%) stddev-sans-first:15.68 12:35:41 INFO - PROCESS | 14500 | Values: 137.0 130.0 146.0 130.0 132.0 129.0 133.0 146.0 178.0 136.0 12:35:41 INFO - PROCESS | 14500 | 12:35:41 INFO - PROCESS | 14500 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:175.00 stddev:2.42 (1.4%) stddev-sans-first:2.45 12:35:41 INFO - PROCESS | 14500 | Values: 176.0 177.0 173.0 171.0 174.0 172.0 177.0 176.0 172.0 171.0 12:35:41 INFO - PROCESS | 14500 | 12:35:41 INFO - PROCESS | 14500 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.00 stddev:2.99 (4.3%) stddev-sans-first:3.12 12:35:41 INFO - PROCESS | 14500 | Values: 71.0 69.0 77.0 67.0 68.0 68.0 71.0 68.0 69.0 67.0 12:35:41 INFO - PROCESS | 14500 | -------- Summary: end -------- 12:35:41 INFO - PROCESS | 14500 | 12:35:42 INFO - TEST-INFO | 14500: exit 0 12:35:42 INFO - TEST-OK | kraken | took 63779ms 12:35:42 INFO - SUITE-END | took 1180s 12:35:42 INFO - Completed test suite (00:19:40) 12:35:42 INFO - javascript benchmark 12:35:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6243.9179379682355, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2632.855192964387, 2656.614790855325, 2682.691490478595, 2689.798265130116, 2702.689190743065, 4769.117713223056, 4805.303231031503, 4844.273358996148, 4846.684965477241, 4868.780904859281, 4723.197056500395, 4815.133276010317, 4873.658843880929, 4876.171050921343, 4892.87767805805, 4383.693141480089, 4429.092036132602, 4483.865484035484, 4493.123840851035, 4540.091981603676, 4491.034427598066, 4526.162659907911, 4528.97735511322, 4532.0709254602725, 4574.0394517151435, 4338.501072376685, 4363.258246098139, 4392.2752745797225, 4421.557844215585, 4499.505054444025, 4413.713108647928, 4430.5126436092005, 4431.423914891044, 4439.689221754478, 4476.61948734358, 4428.0, 4428.180786554465, 4430.977845110754, 4459.777011149462, 4481.686281960264, 4713.198756211452, 4725.905481890343, 4770.689905156154, 4774.594159496447, 4789.544993225638, 5117.0, 5119.948800511985, 5140.254663073871, 5151.381834179885, 5213.139831927728, 5043.36957880265, 5165.070287348276, 5167.819126330561, 5171.198464238049, 5171.844844654666, 4830.178869592178, 4831.9033619327765, 4860.829870954571, 4861.975690121527, 4883.609311255091, 5343.7862485500145, 5364.114921037985, 5367.68865817704, 5379.354477462652, 5417.052015897281, 4957.925631115536, 5002.124628190125, 5129.589632829365, 5140.126178549655, 5147.0992576298995, 4927.926081108786, 5164.664296820694, 5198.636095473356, 5198.948010519922, 5208.869778255498, 5142.04872098663, 5158.92261616076, 5202.791888324425, 5208.062548741263, 5226.294450249167, 5172.948270517322, 5176.559992400613, 5198.194279886624, 5215.6609820361555, 5247.7113758743635, 4303.440552728125, 4336.176126535948, 4337.219300525936, 4344.066025804404, 4396.4284642996845, 3827.9043023924623, 3838.405047217686, 3857.3828187489867, 3877.3020856245585, 3883.86406475772, 4141.8964525887095, 4167.8958026049595, 4186.434831297796, 4203.675842109726, 4249.936250956238, 4938.111139994764, 5056.292119103328, 5111.693298402108, 5122.871928201825, 5156.04613146569, 4113.115680128787, 4137.958620413758, 4146.274401979642, 4171.958280417157, 4172.269852775752, 4499.032707967803, 4539.273716205391, 4540.977295113504, 4564.178447879413, 4587.472440669299, 4742.217534106834, 4757.09615173116, 4795.328653988375, 4851.757412129379, 4885.5847252983895, 5082.3138876252715, 5098.46466121052, 5102.668326558762, 5112.36095488064, 5152.9742351288005, 4796.928046079382, 4803.903921921612, 4804.783784729765, 4829.637777166657, 4883.658143929891, 5007.499250074963, 5018.87452813668, 5046.747662616928, 5072.898542029213, 5153.819616313411, 5091.389033316026, 5091.414487334004, 5097.821576244962, 5109.131447653834, 5155.200943853709, 4956.281339205723, 4958.826441074545, 4960.131976904099, 4963.131451995959, 4973.45292017885, 4886.242632391985, 4891.95108048915, 4973.35346404965, 4991.051700176955, 4994.625403094709, 4779.402574678165, 4871.585915197248, 4888.9755551222015, 4895.828645997373, 4947.925781113358, 5057.14028615129, 5082.567981721595, 5087.3132127163835, 5092.159793634157, 5101.7704203310195, 4821.662483626113, 4846.12769701443, 4866.440359358578, 4887.095887260868, 4918.213085906238], "value": 4703.36794026819, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.3896605285106, 549.6894254746068, 562.9690367029812, 565.8076254073615, 593.1399470767388, 39533.40699889501, 40813.38779918304, 40853.182936341254, 40881.79559102208, 40890.18219635613, 37407.812960935225, 37684.05789855255, 37803.62196378035, 37818.24363512735, 37845.24309513808, 7753.767386978386, 7879.4484386093, 7930.0, 7946.404019698517, 7947.324477419426, 7742.109657389387, 7830.334421574173, 7863.68545258189, 7876.80307992299, 7879.093904201033, 7868.685252589889, 7892.526448413114, 7924.128345881948, 7926.048874135112, 7933.365330773524, 7826.413019023567, 7851.489653172554, 7883.8423231535335, 7896.328812050925, 7897.24976127267, 7822.765317040498, 7833.060032796044, 7846.254605812439, 7856.489328193649, 7865.567393793339, 38027.23945521102, 38121.61878381236, 38530.22939541194, 38568.228635427135, 38578.421323680166, 2885.5960165576835, 3001.0, 3029.4546981543313, 3093.3503964167553, 3105.673904240045, 29350.0, 29399.412011759858, 29785.553216701766, 30124.0, 30400.783968641226, 3330.533725278463, 3367.601725498777, 3422.161570415239, 3431.1936694876686, 3447.4484082546924, 259400.0, 260850.0, 261579.0, 262143.0, 262473.0, 32186.19534511656, 33196.33607327888, 33449.83275083609, 52672.73663631657, 52817.7359113202, 34102.0, 34190.14524636904, 34334.14164645904, 34382.14044648904, 34390.14024649404, 12539.24764514132, 12717.236965782082, 12729.490820367082, 12747.0, 12767.680807979688, 10238.078572928473, 10298.742531436774, 10358.067773900386, 10362.637307694195, 10372.170226381872, 7958.363330933512, 8007.399445041528, 8049.959750201211, 8076.192380761877, 8091.1504292048485, 3114.8909788157307, 3135.843207839599, 3144.5283207518596, 3169.271067654406, 3175.9364812703616, 735.6615956659996, 772.9806754831062, 809.1423091522887, 858.9441686290371, 904.8914130304406, 24811.751882481305, 25686.74313256881, 25782.48435031289, 25947.351316217246, 25992.8700356497, 847.9660813567389, 852.9232369086687, 865.6191275838611, 871.7689812199773, 928.6053427293373, 13107.279099649611, 13793.724125517434, 13853.376598053112, 13896.096753710977, 13900.721985560232, 387810.0, 388025.0, 390013.0, 390646.0, 393236.0, 33127.66872331294, 33355.332893342, 33435.99692009244, 33455.0, 33537.496937545955, 1173.4250217393417, 1189.52419032386, 1219.195331081482, 1221.5480272299305, 1232.5501192064833, 23757.71161056116, 25137.87431062833, 25918.740812591634, 25932.0, 26096.34759131037, 43337.566624333354, 43389.132217356106, 43625.34561981636, 43768.562314376446, 43819.0, 333139.0, 333568.0, 333977.0, 334412.0, 338248.0, 24977.125800596892, 25315.240542783748, 25604.35989100213, 26002.08992685247, 26026.86986565055, 42728.35907461453, 43028.56971430246, 43042.0, 43321.0, 43381.3492797602, 36721.63278367182, 37209.44185837269, 37275.81362093172, 37275.81362093172, 37964.62035379721, 36915.81542092272, 37119.25761484701, 37450.81274593718, 37615.43576846295, 37749.4337584942, 31266.374672506878, 35752.82123589365, 36096.27807443889, 36645.26709465849, 37014.0, 31638.367232654757, 33542.0, 33761.49357759685, 33805.66194338124, 33873.49189762106, 24800.0, 24850.875745621157, 25007.74992250127, 25156.0, 25409.640707859613], "value": 16046.020205502406, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.52270718590694, 364.4878945082159, 366.57477326301495, 370.72751527627173, 383.9021049632343, 16443.0, 17343.0, 17651.82348176518, 17778.82221177788, 17803.109844507788, 16365.42721004765, 17226.913865430688, 17290.2219400127, 17303.394381196627, 17316.567085822862, 5116.795328186868, 5239.292695486118, 5284.2866213061125, 5285.127953887623, 5287.894242115155, 3796.6962642988497, 5206.739663016853, 5733.827985160431, 6035.69821508925, 6065.5450841187085, 6033.607815491979, 6052.485538729214, 6066.605670631395, 6070.423309785563, 6083.695815209244, 5029.849104526852, 5292.444293349181, 5340.91988620171, 5379.892402151974, 5391.919121213185, 5060.392752869642, 5207.192885102815, 5264.9733302006125, 5270.2358158067245, 5284.10170271051, 12591.496340146383, 12741.362931853462, 12742.745145097138, 18348.90825545877, 21806.34580962574, 1857.136431559318, 1892.6782446984046, 1934.7775005874364, 1937.5349916020195, 1952.2776572668204, 9166.175044245983, 9354.67258645951, 9412.435253884789, 9438.103380178873, 9473.052694730472, 1655.2634077835369, 1687.5274923021573, 1691.061460889206, 1765.7439671247726, 1784.4379020608467, 72080.0, 74739.87890181597, 75072.62463687701, 75520.62239688821, 77554.0, 9779.755506112404, 9870.21038316933, 9954.153896918842, 10258.0, 10351.275410721328, 13774.65563360904, 13904.165750055028, 13929.442822287197, 13955.302234888215, 13996.30018499071, 6901.206361268519, 6955.513114081966, 7048.330408611174, 7065.116860392451, 7236.204017558064, 6318.462930650854, 6442.9355706443275, 6488.708008139645, 6550.0, 6560.704768285439, 4263.126059157865, 4304.978475107667, 4349.891252718644, 4350.956490435118, 4467.24056910326, 1632.1920649278684, 1713.7343711724702, 1816.2099486723318, 1836.9448916532258, 1841.1186493138196, 816.2368185746346, 847.1232274595887, 852.4331319672473, 885.198895000026, 911.7766147293955, 17637.823621763873, 17736.29054837818, 17868.374606888698, 17887.910560447115, 18169.909150454427, 773.7794728502349, 804.2520455975998, 843.4601854812925, 874.0647507167397, 879.520661239626, 8927.33045021626, 8994.86507702385, 9031.322650801085, 9186.816263674822, 9335.766605834908, 375369.0, 387604.0, 393764.0, 394104.0, 394438.0, 77777.0, 81830.0, 85288.57355713182, 85573.58198135164, 85647.14352856392, 924.7826760711228, 930.4882314726873, 947.4173383369179, 949.6486300069018, 951.8096380723883, 14548.563543093724, 14640.341184646504, 14765.557033289018, 14796.0, 14811.407543698131, 35466.29067418585, 35976.280474390886, 36916.07709807276, 37908.43137352997, 38983.610163897996, 54463.0, 55346.0, 55733.0, 56000.0, 57441.0, 7377.0, 7893.36853051743, 7927.801804954922, 7942.404319675932, 7997.720079797179, 11100.500477478694, 11321.377324247245, 11383.829242561202, 11777.705557360792, 11937.283762973902, 9855.35940163887, 9938.850917236103, 10439.895601044196, 10479.476026198812, 10575.894241057798, 9855.0, 10044.347117437635, 10044.945280745416, 10123.59505619767, 10165.542550585093, 9839.458829764431, 9958.900410995797, 10378.06597406237, 10540.736481588021, 10811.189160813128, 7388.7808511594985, 7540.472166948261, 7573.545587264782, 7754.806129846799, 7831.138574756658, 9504.809903802023, 10089.091861945106, 10102.595896164365, 10120.696379108638, 10199.898001019896], "value": 8180.913556997989, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.1001573937592, 1379.7585422551053, 1416.3414012484193, 1653.1899369309042, 1680.7394853797666, 6474.0, 7119.786406407803, 7221.277872212776, 7689.3464055555205, 7700.730474433389, 7309.744158954438, 7518.097828260603, 7602.619869006541, 7626.351760100384, 7647.655855486517, 2157.590057889, 2196.8352373571965, 2205.856619319747, 2209.4034610655194, 2213.2585583829355, 2139.5613899150635, 2146.785321467856, 2211.0, 2220.955580888381, 2223.3107736601705, 2083.7707852136255, 2177.618916689573, 2178.4662757624324, 2179.3461961411595, 2184.14818220894, 2150.827933765295, 2152.7309086364203, 2171.6416791229426, 2176.52116534363, 2189.2665956904457, 2107.346722516025, 2114.4291041418883, 2120.936371908845, 2123.182574708733, 2123.4903623130335, 7383.335499805044, 7390.556566605967, 7411.925880741178, 7449.255074492507, 7454.701811927516, 4534.093181363707, 4620.768961551909, 4652.395188625491, 4680.64895132863, 4691.62467002639, 2774.4312415954682, 2839.7018313077037, 2866.226118947893, 2873.8504598160694, 2881.5389537673873, 848.0840692052568, 860.7460799064291, 882.5851849630664, 883.1830556734994, 894.9328800339936, 10050.597976080948, 10096.596136154545, 10122.0, 10164.136048435967, 10170.338927969658, 3894.2406230784727, 3919.5296564411883, 4029.516458024997, 4098.262312783728, 4107.568705285902, 8003.5197888126895, 8012.639431225609, 8014.759557213293, 8075.757727268191, 8083.595820209083, 4453.643708503312, 4454.153710794939, 4454.420925279693, 4474.149911516802, 4496.0, 3608.9278214435562, 3998.8800335989968, 4158.438610787565, 4196.748195108304, 4199.811008504625, 3315.61870384904, 3346.4980252961764, 3374.2239284964594, 3395.6774106459848, 3429.2455659754814, 1008.2287050406445, 1044.4673216659407, 1054.783769327286, 1055.1189756553365, 1063.3354153653966, 667.8397184675642, 702.0206811498034, 813.1786895235855, 816.155279285948, 823.7734622978729, 5009.89980200394, 5044.646874718735, 5058.797648094109, 5127.3847138343635, 5183.740812959412, 395.5787086752599, 402.8589993502251, 404.33083247225886, 405.4107897043596, 408.11846411750474, 3455.447128459434, 3491.773034752733, 3517.736169787276, 3555.235624340779, 3615.9819200903826, 8160.877586836202, 8440.198181172778, 8454.57727113654, 8509.489430634181, 8552.10202928696, 8400.579971001425, 8423.326133909273, 8425.4944703318, 8472.703455379033, 8512.616932237941, 6679.298673639198, 6707.195136583641, 6743.7976860695235, 6746.527743057939, 6772.390484856386, 4801.831935882227, 4832.299316599003, 4916.70499770015, 4919.606431485544, 4934.506549345037, 7915.881261780963, 7934.166912474107, 8171.79570510742, 8192.631331589973, 8275.917240827515, 8129.227723366271, 8312.25189732927, 8361.247487726134, 8393.706220282262, 8492.91507084946, 5787.247657804459, 6275.466585340298, 6513.088167656627, 6526.9347306528225, 6766.1204043476, 7124.3944264736, 7151.4278857690215, 7164.856702866018, 7195.424366050808, 7210.098737657793, 6036.456718895321, 6327.873442531216, 6372.808815735535, 6420.06908998202, 6508.0, 6181.227346581677, 6321.431071203429, 6373.904391434039, 6429.9678501607195, 6452.419282264619, 5896.0, 5916.112583112567, 5959.225300711053, 5963.821085367446, 5975.521958243417, 4218.704690671623, 4230.682698797541, 4269.87190384289, 4313.482382114166, 4352.86941391746, 4271.5514870938105, 4303.096349766459, 4311.008468052428, 4398.230309695854, 4402.9559704402545], "value": 3852.6876871105983, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.1296240901386, 301.4242796259145, 303.7645824486024, 307.6047279246169, 308.2970826515544, 5022.547970682638, 5054.646174767768, 5068.949310506894, 5078.492150784919, 5095.898082038357, 4987.925181122277, 4999.925001124986, 5000.624953128521, 5009.574186194178, 5013.924791128136, 3735.533058367711, 3842.711796615251, 3941.6255455731803, 3953.952202666281, 3963.6829053675783, 3909.6707119579337, 3942.7437216580975, 3948.4669569608022, 3948.822302996358, 3958.9010274743073, 3937.086555948592, 3941.2117576484816, 3948.486696729421, 3950.822213000422, 3953.782541960191, 3804.2962052020466, 3872.1287710265246, 3927.2341893330813, 3938.684905207591, 3942.6254505821903, 3462.2036931505645, 3462.5498685170764, 3467.930641387183, 3470.9587123862993, 3500.916954412146, 4896.265560165968, 4906.950930490685, 4920.827771028033, 4926.926096108526, 4928.901421971541, 4322.206284391974, 4476.306172543261, 4489.393931819195, 4495.213337665896, 4497.123061003105, 5221.973890130563, 5244.554212891909, 5244.79020839166, 5253.52718255355, 5273.604479664003, 3793.487879136309, 3799.7530160539477, 3803.2393521295576, 3807.219519998421, 3811.8284677189317, 5346.91979620306, 5478.863028424282, 5482.273083978574, 5510.338759348863, 5510.586705997066, 3872.6514613684903, 3885.2423777363706, 3892.0, 3896.5129358830145, 3903.2388684206876, 3919.3141200289833, 3935.2916475034767, 3943.408488726714, 3945.829793613501, 3947.5657677655436, 4425.84509542171, 4432.202203603318, 4441.178381999341, 4444.2444784386735, 4459.197344478025, 5101.438841727407, 5169.53474187325, 5222.120036786754, 5260.263563101169, 5263.868403289872, 1358.8517702541337, 1372.5539199760117, 1378.7518246715488, 1380.6962468256968, 1381.4405165907824, 851.4848516647463, 872.289084396215, 872.5244741615835, 883.3242569434387, 890.7327801659476, 4118.485189351331, 4252.170826688766, 4258.317964404043, 4263.211305908417, 4273.188094262143, 5325.813596524103, 5334.892717376614, 5335.226392173113, 5339.86650333737, 5344.331958505187, 4283.892902677458, 4284.0, 4284.400183974246, 4285.3786201000685, 4302.117581220589, 2679.812413131062, 2833.574963755453, 2835.2911772056987, 2841.1476557032806, 2844.431113777253, 5014.974925125351, 5035.823746168867, 5040.84877453677, 5041.873953151201, 5051.696898186047, 5389.649672771257, 5447.0, 5501.0, 5502.449755024466, 5529.529989950819, 4971.130052240916, 5020.297158397827, 5028.79884804611, 5033.370828646419, 5033.590594633509, 5257.500537449089, 5262.605304602093, 5264.868378290574, 5266.789328426973, 5269.473052694853, 5128.435872054146, 5237.738113094254, 5289.576833853205, 5301.867453313698, 5318.883034562785, 4959.752012399294, 4974.303597496281, 4980.850574482772, 5013.799448022184, 5030.496950304941, 3906.1992291580727, 3913.4325522799604, 3920.666743326849, 3929.528456585228, 3945.6054394560315, 5118.872028199325, 5320.707361095177, 5327.813526526553, 5357.785688572413, 5394.136938089887, 5246.868828279171, 5250.97374513125, 5268.841934741964, 5276.129438642581, 5277.366715993951, 5246.213068039825, 5253.684778913277, 5264.15773476242, 5277.20841873722, 5285.0, 4888.5111488850835, 5135.255387968649, 5142.562882155059, 5143.71709555963, 5175.663581867167, 5055.393352797688, 5147.536721695065, 5283.2075188722, 5286.889753151881, 5304.469553044664, 5127.333446651912, 5138.871528211825, 5164.535191832753, 5176.637635365639, 5177.715225662625], "value": 3935.939789253209, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.9425851673349, 732.4945787406692, 747.6373958630063, 750.6059318857602, 763.4083585221456, 11166.330020198793, 11900.345480998541, 11936.880631193686, 11937.34344611046, 11976.94011529941, 11327.603533876316, 11349.20555561111, 11355.772884542304, 11380.658580242605, 11413.600523981662, 624.4816802054283, 758.8861670749391, 778.5717855179629, 784.525362155896, 785.7289235213842, 745.9142198647171, 770.452978385347, 771.3906014248737, 774.601080443572, 774.7598244544181, 822.6051495282238, 822.9958850205741, 824.5794644731201, 831.5966756123275, 834.1366685480529, 816.346922462031, 817.2032268538187, 825.0759149752256, 825.9256666899978, 827.606886728805, 601.491739480143, 603.0532064658488, 604.8639056212317, 606.3027518353884, 606.3784620763709, 12029.879701202963, 12087.818682719766, 12123.696907577292, 12143.149979501439, 12150.45322960469, 13092.410841512059, 13489.662758431019, 13605.931970340183, 13692.246926419042, 13705.45178192871, 9815.705528834147, 9934.701958941243, 9988.800223995551, 10002.099811016971, 10087.394756314645, 3275.410426123297, 3312.867485300609, 3321.8837340693203, 3352.0614228016193, 3367.107716455141, 59769.7011514944, 60132.69933650347, 60678.999999999556, 60904.0, 61615.0, 10009.499525023719, 10154.898451015542, 10343.896561034293, 10385.792284154275, 10677.0, 19437.125329360213, 19572.119254633577, 19603.215871364984, 19624.90187549053, 19914.60170796576, 6896.655167241618, 6944.826379340456, 7072.186698529632, 7078.433725301964, 7203.603801790951, 3778.6977041836585, 3800.201957588882, 3824.8852534424013, 3830.885073447801, 3833.9424908626393, 2680.195941217627, 2763.765079968185, 2778.5554311310093, 2778.7356752677483, 2782.2070709847594, 471.4719514144112, 473.56432082484196, 473.8510853280357, 474.9501302363202, 476.6139427064089, 549.9505044546011, 584.3134317177385, 631.2551189596229, 635.088647790413, 646.1664452855763, 8162.836743265101, 8273.875891861628, 8392.20274073962, 8449.493030418194, 8451.873221901677, 574.115861573181, 586.4047991288845, 598.5421152818097, 610.1823556434399, 611.4894063456974, 3830.636089571486, 3972.106276087857, 4025.355943049157, 4086.6117718816663, 4222.641075508616, 84284.57857710795, 91324.5433772827, 93783.53108234552, 93808.0, 94418.52790736002, 80679.19320806835, 81215.5939220312, 81756.59121704353, 81874.59062704648, 83150.58424707838, 44702.0, 61939.690301549104, 72621.6368918152, 74025.0, 75697.0, 7828.608569571385, 7950.801229969297, 7960.124386317616, 8092.028956525254, 8100.230478104806, 30663.2334191647, 32888.0, 41179.38230926599, 41281.1743765117, 42592.5740742601, 38262.80868595639, 61963.6901815488, 63029.36970630418, 63238.367616325086, 63476.365236348895, 9636.42181469114, 10003.849942251018, 10151.492425378554, 10341.4312212829, 10342.896571034193, 10837.67486975392, 11030.0, 11146.665600032013, 11281.21031527785, 11377.374244416636, 10068.496575171359, 10489.52797124116, 10644.254902156774, 10705.464726763787, 10922.344659320466, 9755.073268039809, 9757.512124393894, 10397.220208484545, 10824.350538967687, 10828.5127169276, 10729.248952573556, 10843.589973946548, 10868.0, 10965.780684386427, 11113.722156946142, 9318.15455962909, 9360.251179905727, 9389.43663380172, 9464.053594640482, 9736.464494452874, 9390.0, 9844.9015509844, 9881.950590247003, 9896.455694936847, 9999.450030248116], "value": 6328.575127489459, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 107.0, 115.0, 114.0, 118.0, 115.0, 116.0, 113.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 152.0, 178.0, 129.0, 156.0, 147.0, 124.0, 191.0, 126.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 165.0, 174.0, 163.0, 162.0, 163.0, 162.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 148.0, 77.0, 78.0, 76.0, 76.0, 172.0, 76.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 148.0, 87.0, 87.0, 85.0, 136.0, 86.0, 87.0, 140.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 119.0, 118.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 149.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 102.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 67.0, 64.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 90.0, 80.0, 81.0, 81.0, 83.0, 83.0, 84.0, 85.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 130.0, 146.0, 130.0, 132.0, 129.0, 133.0, 146.0, 178.0, 136.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 177.0, 173.0, 171.0, 174.0, 172.0, 177.0, 176.0, 172.0, 171.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 77.0, 67.0, 68.0, 68.0, 71.0, 68.0, 69.0, 67.0], "value": 69.5, "unit": "score"}]}]} 12:35:42 INFO - Return code: 0 12:35:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:35:42 ERROR - # TBPL SUCCESS # 12:35:42 INFO - Running post-action listener: _resource_record_post_action 12:35:42 INFO - ##### 12:35:42 INFO - ##### Finished run-tests step (success) 12:35:42 INFO - ##### 12:35:42 INFO - Running post-run listener: _resource_record_post_run 12:35:42 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 535568384; Read time: 0; Write time: 354280 12:35:42 INFO - TinderboxPrint: CPU usage
13.3% 12:35:42 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:35:42 INFO - TinderboxPrint: I/O write bytes / time
535,568,384 / 354,280 12:35:42 INFO - TinderboxPrint: CPU idle
8,281.4 (86.7%) 12:35:42 INFO - TinderboxPrint: CPU user
1,218.4 (12.8%) 12:35:42 INFO - TinderboxPrint: Swap in / out
0 / 0 12:35:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 245780480; Read time: 0; Write time: 195640 12:35:42 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 289173504; Read time: 0; Write time: 158640 12:35:43 INFO - Running post-run listener: _upload_blobber_files 12:35:43 INFO - Blob upload gear active. 12:35:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:35:43 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 12:35:43 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'] 12:35:43 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 12:35:43 INFO - (blobuploader) - INFO - Open directory for files ... 12:35:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:35:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:35:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:44 INFO - (blobuploader) - INFO - Done attempting. 12:35:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:35:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:35:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:48 INFO - (blobuploader) - INFO - Done attempting. 12:35:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:35:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:35:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:49 INFO - (blobuploader) - INFO - Done attempting. 12:35:49 INFO - (blobuploader) - INFO - Iteration through files over. 12:35:49 INFO - Return code: 0 12:35:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:35:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:35:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a8afa744c1923690013cfc132489a6c7162809a1a0ac1688146208d1cb8743953521b058ac4442f7aee8abf1cfd2695ab47c52602501471d0313ea830db86b0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83386f9b756218734341bd7b9f9ad70a18ddc8d00a32fd5db27db81d43761488147a7a0b212e471ee24567eef4d1638c2be4602dda0be093d68e2b80773f7045", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/776fe740c4e0c4c57a3df98b5e5fdedec2fcc8b77fb2b860270403d0412497615b24f80861dff6ee7dc46d806b570cfcae2d912260e0bbd79ea87a3bfce721a3"} 12:35:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:35:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:35:49 INFO - Contents: 12:35:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a8afa744c1923690013cfc132489a6c7162809a1a0ac1688146208d1cb8743953521b058ac4442f7aee8abf1cfd2695ab47c52602501471d0313ea830db86b0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83386f9b756218734341bd7b9f9ad70a18ddc8d00a32fd5db27db81d43761488147a7a0b212e471ee24567eef4d1638c2be4602dda0be093d68e2b80773f7045", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/776fe740c4e0c4c57a3df98b5e5fdedec2fcc8b77fb2b860270403d0412497615b24f80861dff6ee7dc46d806b570cfcae2d912260e0bbd79ea87a3bfce721a3"} 12:35:49 INFO - Running post-run listener: copy_logs_to_upload_dir 12:35:49 INFO - Copying logs to upload dir... 12:35:49 INFO - mkdir: /builds/slave/test/build/upload/logs 12:35:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.579255 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-11 12:35:49.103288) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 12:35:49.107097) ========= 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=bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a8afa744c1923690013cfc132489a6c7162809a1a0ac1688146208d1cb8743953521b058ac4442f7aee8abf1cfd2695ab47c52602501471d0313ea830db86b0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83386f9b756218734341bd7b9f9ad70a18ddc8d00a32fd5db27db81d43761488147a7a0b212e471ee24567eef4d1638c2be4602dda0be093d68e2b80773f7045", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/776fe740c4e0c4c57a3df98b5e5fdedec2fcc8b77fb2b860270403d0412497615b24f80861dff6ee7dc46d806b570cfcae2d912260e0bbd79ea87a3bfce721a3"} build_url:https://queue.taskcluster.net/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/TFfILNi-TF2zbXT7BnW9Vg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a8afa744c1923690013cfc132489a6c7162809a1a0ac1688146208d1cb8743953521b058ac4442f7aee8abf1cfd2695ab47c52602501471d0313ea830db86b0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83386f9b756218734341bd7b9f9ad70a18ddc8d00a32fd5db27db81d43761488147a7a0b212e471ee24567eef4d1638c2be4602dda0be093d68e2b80773f7045", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/776fe740c4e0c4c57a3df98b5e5fdedec2fcc8b77fb2b860270403d0412497615b24f80861dff6ee7dc46d806b570cfcae2d912260e0bbd79ea87a3bfce721a3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 12:35:49.136985) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 12:35:49.137365) ========= 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=bb9b54edd4a927dc735d112f000001d9-1468263903.987330-686642556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 12:35:49.223113) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 12:35:49.223459) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 12:35:49.223849) ========= ========= Total master_lag: 0.21 =========