builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1468238277.05 results: success (0) buildid: 20160711013024 builduid: 6327f578ab42483ca0c66528f1504f89 revision: 035505ea31497d0e07d51cda4711cebb385ca987 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 04:57:57.054480) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 04:57:57.054976) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 04:57:57.055310) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 04:57:57.071139) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:57:57.071806) ========= 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=6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 04:57:57-- 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% 50.0M=0s 2016-07-11 04:57:57 (50.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076057 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:57:57.163373) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:57:57.163716) ========= 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=6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018606 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:57:57.214076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:57:57.214456) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 035505ea31497d0e07d51cda4711cebb385ca987 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 035505ea31497d0e07d51cda4711cebb385ca987 --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=6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 04:57:57,593 truncating revision to first 12 chars 2016-07-11 04:57:57,593 Setting DEBUG logging. 2016-07-11 04:57:57,593 attempt 1/10 2016-07-11 04:57:57,593 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/035505ea3149?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 04:57:58,189 unpacking tar archive at: mozilla-inbound-035505ea3149/testing/mozharness/ program finished with exit code 0 elapsedTime=0.915514 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:57:58.143978) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 04:57:58.144371) ========= script_repo_revision: 035505ea31497d0e07d51cda4711cebb385ca987 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 04:57:58.144828) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 04:57:58.145134) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 04:57:58.154370) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-11 04:57:58.154689) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:57:58 INFO - MultiFileLogger online at 20160711 04:57:58 in /builds/slave/test 04:57:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:57:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:57:58 INFO - {'append_to_log': False, 04:57:58 INFO - 'base_work_dir': '/builds/slave/test', 04:57:58 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:57:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:57:58 INFO - 'branch': 'Mozilla-Inbound', 04:57:58 INFO - 'buildbot_json_path': 'buildprops.json', 04:57:58 INFO - 'config_files': ('talos/linux_config.py',), 04:57:58 INFO - 'default_actions': ('clobber', 04:57:58 INFO - 'read-buildbot-config', 04:57:58 INFO - 'download-and-extract', 04:57:58 INFO - 'populate-webroot', 04:57:58 INFO - 'create-virtualenv', 04:57:58 INFO - 'install', 04:57:58 INFO - 'run-tests'), 04:57:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:57:58 INFO - 'download_minidump_stackwalk': True, 04:57:58 INFO - 'download_symbols': 'ondemand', 04:57:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:57:58 INFO - 'tooltool.py': '/tools/tooltool.py', 04:57:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:57:58 INFO - '/tools/misc-python/virtualenv.py')}, 04:57:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:57:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:57:58 INFO - 'installer_path': 'installer.exe', 04:57:58 INFO - 'log_level': 'info', 04:57:58 INFO - 'log_name': 'talos', 04:57:58 INFO - 'log_to_console': True, 04:57:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:57:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:57:58 INFO - 'opt_config_files': (), 04:57:58 INFO - 'pip_index': False, 04:57:58 INFO - 'sps_profile': False, 04:57:58 INFO - 'sps_profile_interval': 0, 04:57:58 INFO - 'suite': 'dromaeojs-e10s', 04:57:58 INFO - 'system_bits': '32', 04:57:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:57:58 INFO - 'title': 'talos-linux64-ix-050', 04:57:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:57:58 INFO - 'use_talos_json': True, 04:57:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:57:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:57:58 INFO - 'work_dir': 'build'} 04:57:58 INFO - ##### 04:57:58 INFO - ##### Running clobber step. 04:57:58 INFO - ##### 04:57:58 INFO - Running pre-action listener: _resource_record_pre_action 04:57:58 INFO - Running main action method: clobber 04:57:58 INFO - rmtree: /builds/slave/test/build 04:57:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:57:59 INFO - Running post-action listener: _resource_record_post_action 04:57:59 INFO - ##### 04:57:59 INFO - ##### Finished clobber step (success) 04:57:59 INFO - ##### 04:57:59 INFO - ##### 04:57:59 INFO - ##### Running read-buildbot-config step. 04:57:59 INFO - ##### 04:57:59 INFO - Running pre-action listener: _resource_record_pre_action 04:57:59 INFO - Running main action method: read_buildbot_config 04:57:59 INFO - Using buildbot properties: 04:57:59 INFO - { 04:57:59 INFO - "project": "", 04:57:59 INFO - "product": "firefox", 04:57:59 INFO - "script_repo_revision": "production", 04:57:59 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:57:59 INFO - "repository": "", 04:57:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:57:59 INFO - "buildid": "20160711013024", 04:57:59 INFO - "pgo_build": "True", 04:57:59 INFO - "basedir": "/builds/slave/test", 04:57:59 INFO - "buildnumber": 1007, 04:57:59 INFO - "slavename": "talos-linux64-ix-050", 04:57:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:57:59 INFO - "platform": "ubuntu64_hw", 04:57:59 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:57:59 INFO - "branch": "mozilla-inbound", 04:57:59 INFO - "repo_path": "integration/mozilla-inbound", 04:57:59 INFO - "revision": "035505ea31497d0e07d51cda4711cebb385ca987", 04:57:59 INFO - "stage_platform": "linux64-pgo", 04:57:59 INFO - "builduid": "6327f578ab42483ca0c66528f1504f89", 04:57:59 INFO - "slavebuilddir": "test" 04:57:59 INFO - } 04:57:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:57:59 INFO - Running post-action listener: _resource_record_post_action 04:57:59 INFO - ##### 04:57:59 INFO - ##### Finished read-buildbot-config step (success) 04:57:59 INFO - ##### 04:57:59 INFO - ##### 04:57:59 INFO - ##### Running download-and-extract step. 04:57:59 INFO - ##### 04:57:59 INFO - Running pre-action listener: _resource_record_pre_action 04:57:59 INFO - Running main action method: download_and_extract 04:57:59 INFO - mkdir: /builds/slave/test/build/tests 04:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:57:59 INFO - https://queue.taskcluster.net/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:57:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:57:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:57:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/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 04:57:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/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 04:57:59 INFO - Downloaded 1361 bytes. 04:57:59 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:57:59 INFO - Using the following test package requirements: 04:57:59 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:57:59 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:57:59 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:57:59 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:59 INFO - u'jsshell-linux-x86_64.zip'], 04:57:59 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:57:59 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:57:59 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:57:59 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:57:59 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:57:59 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:57:59 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:57:59 INFO - https://queue.taskcluster.net/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:57:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:57:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:57:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/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 04:57:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/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 04:58:00 INFO - Downloaded 24307074 bytes. 04:58:00 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'] 04:58:00 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 04:58:02 INFO - Return code: 0 04:58:02 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 04:58: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')]} 04:58:02 INFO - https://queue.taskcluster.net/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:58:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:58:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:58:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/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 04:58:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/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 04:58:03 INFO - Downloaded 24307074 bytes. 04:58:03 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'] 04:58:03 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 04:58:04 INFO - Return code: 0 04:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:04 INFO - https://queue.taskcluster.net/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:58:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:58:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:58:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/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 04:58:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/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 04:58:07 INFO - Downloaded 14403333 bytes. 04:58:07 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'] 04:58:07 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 04:58:07 INFO - Return code: 0 04:58: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')]} 04:58:07 INFO - https://queue.taskcluster.net/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:58:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:58:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:58:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/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 04:58:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TuqzabmBS5aoEmH40tNn3Q/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 04:58:08 INFO - Downloaded 60485389 bytes. 04:58:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:58:08 INFO - mkdir: /builds/slave/test/properties 04:58:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:58:08 INFO - Writing to file /builds/slave/test/properties/build_url 04:58:08 INFO - Contents: 04:58:08 INFO - build_url:https://queue.taskcluster.net/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:58:09 INFO - Running post-action listener: _resource_record_post_action 04:58:09 INFO - Running post-action listener: set_extra_try_arguments 04:58:09 INFO - ##### 04:58:09 INFO - ##### Finished download-and-extract step (success) 04:58:09 INFO - ##### 04:58:09 INFO - ##### 04:58:09 INFO - ##### Running populate-webroot step. 04:58:09 INFO - ##### 04:58:09 INFO - Running pre-action listener: _resource_record_pre_action 04:58:09 INFO - Running main action method: populate_webroot 04:58:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:58:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:58:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:58:09 INFO - '--tppagecycles', 04:58:09 INFO - '7'], 04:58:09 INFO - 'tests': ['tsvgm']}}, 04:58:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:58:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:58:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:58:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:58:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:58:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:58:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:09 INFO - 'talos_options': ['--disable-e10s'], 04:58:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:58:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:58:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:09 INFO - 'talos_options': ['--disable-e10s'], 04:58:09 INFO - 'tests': ['damp', 'tps']}, 04:58:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:09 INFO - 'tests': ['damp', 'tps']}, 04:58:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:58:09 INFO - 'tests': ['dromaeo_dom']}, 04:58:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:58:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:58:09 INFO - 'tests': ['basic_compositor_video']}, 04:58:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:58:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:58:09 INFO - 'tests': ['a11yr', 04:58:09 INFO - 'ts_paint', 04:58:09 INFO - 'tpaint', 04:58:09 INFO - 'sessionrestore', 04:58:09 INFO - 'sessionrestore_no_auto_restore', 04:58:09 INFO - 'tabpaint']}, 04:58:09 INFO - 'other-e10s': {'tests': ['a11yr', 04:58:09 INFO - 'ts_paint', 04:58:09 INFO - 'tpaint', 04:58:09 INFO - 'sessionrestore', 04:58:09 INFO - 'sessionrestore_no_auto_restore', 04:58:09 INFO - 'tabpaint']}, 04:58:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:58:09 INFO - 'ts_paint', 04:58:09 INFO - 'tpaint', 04:58:09 INFO - 'sessionrestore', 04:58:09 INFO - 'sessionrestore_no_auto_restore', 04:58:09 INFO - 'tabpaint']}, 04:58:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:58:09 INFO - 'ts_paint', 04:58:09 INFO - 'tpaint', 04:58:09 INFO - 'sessionrestore', 04:58:09 INFO - 'sessionrestore_no_auto_restore', 04:58:09 INFO - 'tabpaint']}, 04:58:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:58:09 INFO - 'tests': ['a11yr', 04:58:09 INFO - 'ts_paint', 04:58:09 INFO - 'tpaint', 04:58:09 INFO - 'sessionrestore', 04:58:09 INFO - 'sessionrestore_no_auto_restore', 04:58:09 INFO - 'tabpaint']}, 04:58:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:58:09 INFO - 'tests': ['a11yr', 04:58:09 INFO - 'ts_paint', 04:58:09 INFO - 'tpaint', 04:58:09 INFO - 'sessionrestore', 04:58:09 INFO - 'sessionrestore_no_auto_restore', 04:58:09 INFO - 'tabpaint']}, 04:58:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:58:09 INFO - 'tests': ['tsvgx', 04:58:09 INFO - 'tsvgr_opacity', 04:58:09 INFO - 'tart', 04:58:09 INFO - 'tscrollx', 04:58:09 INFO - 'cart']}, 04:58:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:58:09 INFO - 'tsvgr_opacity', 04:58:09 INFO - 'tart', 04:58:09 INFO - 'tscrollx', 04:58:09 INFO - 'cart']}, 04:58:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:09 INFO - 'talos_options': ['--disable-e10s'], 04:58:09 INFO - 'tests': ['tp5o']}, 04:58:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:09 INFO - 'tests': ['tp5o']}, 04:58:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:09 INFO - 'talos_options': ['--disable-e10s', 04:58:09 INFO - '--xperf_path', 04:58:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:58:09 INFO - 'tests': ['tp5n']}, 04:58:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:09 INFO - 'talos_options': ['--xperf_path', 04:58:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:58:09 INFO - 'tests': ['tp5n']}}, 04:58:09 INFO - 'talos.zip': {'path': '', 04:58:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:58:09 INFO - Running post-action listener: _resource_record_post_action 04:58:09 INFO - ##### 04:58:09 INFO - ##### Finished populate-webroot step (success) 04:58:09 INFO - ##### 04:58:09 INFO - ##### 04:58:09 INFO - ##### Running create-virtualenv step. 04:58:09 INFO - ##### 04:58:09 INFO - Running pre-action listener: _resource_record_pre_action 04:58:09 INFO - Running main action method: create_virtualenv 04:58:09 INFO - Creating virtualenv /builds/slave/test/build/venv 04:58:09 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 04:58:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:58:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:58:09 INFO - Using real prefix '/usr' 04:58:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:58:10 INFO - Installing distribute.............................................................................................................................................................................................done. 04:58:12 INFO - Installing pip.................done. 04:58:12 INFO - Return code: 0 04:58:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d60030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e570>, '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 0x201f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201f900>, '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': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', '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 04:58:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:58:12 INFO - Using env: {'DISPLAY': ':0', 04:58:12 INFO - 'HOME': '/home/cltbld', 04:58:12 INFO - 'LANG': 'en_US.UTF-8', 04:58:12 INFO - 'LANGUAGE': 'en_US:en', 04:58:12 INFO - 'LOGNAME': 'cltbld', 04:58:12 INFO - 'MAIL': '/var/mail/cltbld', 04:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:12 INFO - 'MOZ_NO_REMOTE': '1', 04:58:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:12 INFO - 'NO_EM_RESTART': '1', 04:58:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:12 INFO - 'PWD': '/builds/slave/test', 04:58:12 INFO - 'SHELL': '/bin/bash', 04:58:12 INFO - 'SHLVL': '1', 04:58:12 INFO - 'TERM': 'linux', 04:58:12 INFO - 'TMOUT': '86400', 04:58:12 INFO - 'USER': 'cltbld', 04:58:12 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', 04:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:12 INFO - '_': '/tools/buildbot/bin/python'} 04:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:12 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 04:58:12 INFO - Cleaning up... 04:58:12 INFO - Return code: 0 04:58:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d60030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e570>, '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 0x201f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201f900>, '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': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', '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 04:58:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:58:12 INFO - Using env: {'DISPLAY': ':0', 04:58:12 INFO - 'HOME': '/home/cltbld', 04:58:12 INFO - 'LANG': 'en_US.UTF-8', 04:58:12 INFO - 'LANGUAGE': 'en_US:en', 04:58:12 INFO - 'LOGNAME': 'cltbld', 04:58:12 INFO - 'MAIL': '/var/mail/cltbld', 04:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:12 INFO - 'MOZ_NO_REMOTE': '1', 04:58:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:12 INFO - 'NO_EM_RESTART': '1', 04:58:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:12 INFO - 'PWD': '/builds/slave/test', 04:58:12 INFO - 'SHELL': '/bin/bash', 04:58:12 INFO - 'SHLVL': '1', 04:58:12 INFO - 'TERM': 'linux', 04:58:12 INFO - 'TMOUT': '86400', 04:58:12 INFO - 'USER': 'cltbld', 04:58:12 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', 04:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:12 INFO - '_': '/tools/buildbot/bin/python'} 04:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:12 INFO - Downloading/unpacking psutil>=3.1.1 04:58:12 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 04:58:12 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 04:58:12 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 04:58:12 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 04:58:12 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 04:58:12 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 04:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:58:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:58:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:14 INFO - Installing collected packages: psutil 04:58:14 INFO - Running setup.py install for psutil 04:58:14 INFO - building 'psutil._psutil_linux' extension 04:58:14 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 04:58:14 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 04:58:14 INFO - building 'psutil._psutil_posix' extension 04:58:14 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 04:58:15 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 04:58:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:58:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:15 INFO - Successfully installed psutil 04:58:15 INFO - Cleaning up... 04:58:15 INFO - Return code: 0 04:58:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:58:15 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')]} 04:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:15 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')]} 04:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:15 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 0x1d60030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e570>, '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 0x201f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201f900>, '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': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', '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 04:58:15 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 04:58:15 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 04:58:15 INFO - Using env: {'DISPLAY': ':0', 04:58:15 INFO - 'HOME': '/home/cltbld', 04:58:15 INFO - 'LANG': 'en_US.UTF-8', 04:58:15 INFO - 'LANGUAGE': 'en_US:en', 04:58:15 INFO - 'LOGNAME': 'cltbld', 04:58:15 INFO - 'MAIL': '/var/mail/cltbld', 04:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:15 INFO - 'MOZ_NO_REMOTE': '1', 04:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:15 INFO - 'NO_EM_RESTART': '1', 04:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:15 INFO - 'PWD': '/builds/slave/test', 04:58:15 INFO - 'SHELL': '/bin/bash', 04:58:15 INFO - 'SHLVL': '1', 04:58:15 INFO - 'TERM': 'linux', 04:58:15 INFO - 'TMOUT': '86400', 04:58:15 INFO - 'USER': 'cltbld', 04:58:15 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', 04:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:15 INFO - '_': '/tools/buildbot/bin/python'} 04:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:58:15 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 04:58:15 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 04:58:15 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 04:58:15 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 04:58:15 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 04:58:15 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 04:58:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:58:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:58:17 INFO - Installing collected packages: mozsystemmonitor 04:58:17 INFO - Running setup.py install for mozsystemmonitor 04:58:17 INFO - Successfully installed mozsystemmonitor 04:58:17 INFO - Cleaning up... 04:58:17 INFO - Return code: 0 04:58:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:58:17 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')]} 04:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:17 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')]} 04:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:17 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 0x1d60030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e570>, '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 0x201f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201f900>, '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': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', '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 04:58:17 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 04:58:17 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 04:58:17 INFO - Using env: {'DISPLAY': ':0', 04:58:17 INFO - 'HOME': '/home/cltbld', 04:58:17 INFO - 'LANG': 'en_US.UTF-8', 04:58:17 INFO - 'LANGUAGE': 'en_US:en', 04:58:17 INFO - 'LOGNAME': 'cltbld', 04:58:17 INFO - 'MAIL': '/var/mail/cltbld', 04:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:17 INFO - 'MOZ_NO_REMOTE': '1', 04:58:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:17 INFO - 'NO_EM_RESTART': '1', 04:58:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:17 INFO - 'PWD': '/builds/slave/test', 04:58:17 INFO - 'SHELL': '/bin/bash', 04:58:17 INFO - 'SHLVL': '1', 04:58:17 INFO - 'TERM': 'linux', 04:58:17 INFO - 'TMOUT': '86400', 04:58:17 INFO - 'USER': 'cltbld', 04:58:17 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', 04:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:17 INFO - '_': '/tools/buildbot/bin/python'} 04:58:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:17 INFO - Downloading/unpacking jsonschema==2.5.1 04:58:17 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 04:58:17 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 04:58:17 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 04:58:17 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 04:58:17 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 04:58:17 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 04:58:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:58:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:19 INFO - Downloading functools32-3.2.3-2.tar.gz 04:58:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:58:19 INFO - warning: no files found matching '*.txt' 04:58:19 INFO - no previously-included directories found matching 'build' 04:58:19 INFO - no previously-included directories found matching 'dist' 04:58:19 INFO - no previously-included directories found matching '.git*' 04:58:19 INFO - Installing collected packages: jsonschema, functools32 04:58:20 INFO - Running setup.py install for functools32 04:58:20 INFO - warning: no files found matching '*.txt' 04:58:20 INFO - no previously-included directories found matching 'build' 04:58:20 INFO - no previously-included directories found matching 'dist' 04:58:20 INFO - no previously-included directories found matching '.git*' 04:58:20 INFO - Successfully installed jsonschema functools32 04:58:20 INFO - Cleaning up... 04:58:20 INFO - Return code: 0 04:58:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:58: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')]} 04:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58: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')]} 04:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:20 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 0x1d60030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e570>, '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 0x201f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201f900>, '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': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', '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 04:58:20 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 04:58:20 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 04:58:20 INFO - Using env: {'DISPLAY': ':0', 04:58:20 INFO - 'HOME': '/home/cltbld', 04:58:20 INFO - 'LANG': 'en_US.UTF-8', 04:58:20 INFO - 'LANGUAGE': 'en_US:en', 04:58:20 INFO - 'LOGNAME': 'cltbld', 04:58:20 INFO - 'MAIL': '/var/mail/cltbld', 04:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:20 INFO - 'MOZ_NO_REMOTE': '1', 04:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:20 INFO - 'NO_EM_RESTART': '1', 04:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:20 INFO - 'PWD': '/builds/slave/test', 04:58:20 INFO - 'SHELL': '/bin/bash', 04:58:20 INFO - 'SHLVL': '1', 04:58:20 INFO - 'TERM': 'linux', 04:58:20 INFO - 'TMOUT': '86400', 04:58:20 INFO - 'USER': 'cltbld', 04:58:20 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', 04:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:20 INFO - '_': '/tools/buildbot/bin/python'} 04:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:20 INFO - Downloading/unpacking blobuploader==1.2.4 04:58:20 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 04:58:20 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 04:58:20 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 04:58:20 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 04:58:20 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 04:58:20 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 04:58:22 INFO - Downloading blobuploader-1.2.4.tar.gz 04:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:58:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:58:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:22 INFO - Downloading docopt-0.6.1.tar.gz 04:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:58:23 INFO - Installing collected packages: blobuploader, requests, docopt 04:58:23 INFO - Running setup.py install for blobuploader 04:58:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:58:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:58:23 INFO - Running setup.py install for requests 04:58:23 INFO - Running setup.py install for docopt 04:58:23 INFO - Successfully installed blobuploader requests docopt 04:58:23 INFO - Cleaning up... 04:58:23 INFO - Return code: 0 04:58:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:23 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 0x1d60030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e570>, '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 0x201f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201f900>, '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': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', '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 04:58:23 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 04:58:23 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 04:58:23 INFO - Using env: {'DISPLAY': ':0', 04:58:23 INFO - 'HOME': '/home/cltbld', 04:58:23 INFO - 'LANG': 'en_US.UTF-8', 04:58:23 INFO - 'LANGUAGE': 'en_US:en', 04:58:23 INFO - 'LOGNAME': 'cltbld', 04:58:23 INFO - 'MAIL': '/var/mail/cltbld', 04:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:23 INFO - 'MOZ_NO_REMOTE': '1', 04:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:23 INFO - 'NO_EM_RESTART': '1', 04:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:23 INFO - 'PWD': '/builds/slave/test', 04:58:23 INFO - 'SHELL': '/bin/bash', 04:58:23 INFO - 'SHLVL': '1', 04:58:23 INFO - 'TERM': 'linux', 04:58:23 INFO - 'TMOUT': '86400', 04:58:23 INFO - 'USER': 'cltbld', 04:58:23 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', 04:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:23 INFO - '_': '/tools/buildbot/bin/python'} 04:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:58:23 INFO - Running setup.py (path:/tmp/pip-FaI2Hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:58:23 INFO - Running setup.py (path:/tmp/pip-HnpxJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:58:24 INFO - Running setup.py (path:/tmp/pip-p8fQ5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:58:24 INFO - Running setup.py (path:/tmp/pip-0ldPe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:58:24 INFO - Running setup.py (path:/tmp/pip-sb6BL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:58:24 INFO - Running setup.py (path:/tmp/pip-KOlnKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:58:24 INFO - Running setup.py (path:/tmp/pip-EbwerC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:58:24 INFO - Running setup.py (path:/tmp/pip-egvqHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:58:24 INFO - Running setup.py (path:/tmp/pip-W_2Ar1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:58:24 INFO - Running setup.py (path:/tmp/pip-YBbtVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:58:24 INFO - Running setup.py (path:/tmp/pip-Y16MuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:58:24 INFO - Running setup.py (path:/tmp/pip-bFqfGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:58:24 INFO - Running setup.py (path:/tmp/pip-JNvyb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:58:24 INFO - Running setup.py (path:/tmp/pip-2t4_8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:24 INFO - Running setup.py (path:/tmp/pip-SbdCGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:58:24 INFO - Running setup.py (path:/tmp/pip-CALaHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:58:25 INFO - Running setup.py (path:/tmp/pip-cDALM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:58:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:58:25 INFO - Running setup.py install for manifestparser 04:58:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:58:25 INFO - Running setup.py install for mozcrash 04:58:25 INFO - Running setup.py install for mozdebug 04:58:25 INFO - Running setup.py install for mozdevice 04:58:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:58:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:58:25 INFO - Running setup.py install for mozfile 04:58:25 INFO - Running setup.py install for mozhttpd 04:58:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:58:25 INFO - Running setup.py install for mozinfo 04:58:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:58:25 INFO - Running setup.py install for mozInstall 04:58:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:58:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:58:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:58:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:58:25 INFO - Running setup.py install for mozleak 04:58:25 INFO - Running setup.py install for mozlog 04:58:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:58:26 INFO - Running setup.py install for moznetwork 04:58:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:58:26 INFO - Running setup.py install for mozprocess 04:58:26 INFO - Running setup.py install for mozprofile 04:58:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:58:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:58:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:58:26 INFO - Running setup.py install for mozrunner 04:58:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:58:26 INFO - Running setup.py install for mozscreenshot 04:58:26 INFO - Running setup.py install for moztest 04:58:26 INFO - Running setup.py install for mozversion 04:58:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:58:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:58:26 INFO - Cleaning up... 04:58:26 INFO - Return code: 0 04:58:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58: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')]} 04:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58: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')]} 04:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:26 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 0x1d60030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e570>, '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 0x201f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201f900>, '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': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', '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 04:58:26 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 04:58:26 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 04:58:26 INFO - Using env: {'DISPLAY': ':0', 04:58:26 INFO - 'HOME': '/home/cltbld', 04:58:26 INFO - 'LANG': 'en_US.UTF-8', 04:58:26 INFO - 'LANGUAGE': 'en_US:en', 04:58:26 INFO - 'LOGNAME': 'cltbld', 04:58:26 INFO - 'MAIL': '/var/mail/cltbld', 04:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:26 INFO - 'MOZ_NO_REMOTE': '1', 04:58:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:26 INFO - 'NO_EM_RESTART': '1', 04:58:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:26 INFO - 'PWD': '/builds/slave/test', 04:58:26 INFO - 'SHELL': '/bin/bash', 04:58:26 INFO - 'SHLVL': '1', 04:58:26 INFO - 'TERM': 'linux', 04:58:26 INFO - 'TMOUT': '86400', 04:58:26 INFO - 'USER': 'cltbld', 04:58:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', 04:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:26 INFO - '_': '/tools/buildbot/bin/python'} 04:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:58:27 INFO - Running setup.py (path:/tmp/pip-sis4nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:58:27 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)) 04:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:58:27 INFO - Running setup.py (path:/tmp/pip-VwA0bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:58:27 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)) 04:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:58:27 INFO - Running setup.py (path:/tmp/pip-8KENgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:58:27 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)) 04:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:58:27 INFO - Running setup.py (path:/tmp/pip-64tsXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:58:27 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)) 04:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:58:27 INFO - Running setup.py (path:/tmp/pip-niwq2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:58:27 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)) 04:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:58:27 INFO - Running setup.py (path:/tmp/pip-0Ey1hY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:58:27 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)) 04:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:58:27 INFO - Running setup.py (path:/tmp/pip-zprbPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:58:27 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)) 04:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:58:27 INFO - Running setup.py (path:/tmp/pip-wdQatV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:58:27 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)) 04:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:58:27 INFO - Running setup.py (path:/tmp/pip-zgevDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:58:27 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)) 04:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:58:27 INFO - Running setup.py (path:/tmp/pip-aTBP2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:58:27 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)) 04:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:58:27 INFO - Running setup.py (path:/tmp/pip-Vi43Hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:58:27 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)) 04:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:58:27 INFO - Running setup.py (path:/tmp/pip-UyAd6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:58:27 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)) 04:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:58:27 INFO - Running setup.py (path:/tmp/pip-yPE9w4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:58:28 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)) 04:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:58:28 INFO - Running setup.py (path:/tmp/pip-bL5T_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:58:28 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)) 04:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:28 INFO - Running setup.py (path:/tmp/pip-PIhWnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:28 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)) 04:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:58:28 INFO - Running setup.py (path:/tmp/pip-Ytswhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:58:28 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)) 04:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:58:28 INFO - Running setup.py (path:/tmp/pip-HLKtBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:58:28 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)) 04:58:28 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)) 04:58:28 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)) 04:58:28 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)) 04:58:28 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)) 04:58:28 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)) 04:58:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:58:28 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 04:58:28 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 04:58:28 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 04:58:28 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 04:58:28 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 04:58:28 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 04:58:30 INFO - Downloading blessings-1.6.tar.gz 04:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:58:30 INFO - Installing collected packages: blessings 04:58:30 INFO - Running setup.py install for blessings 04:58:30 INFO - Successfully installed blessings 04:58:30 INFO - Cleaning up... 04:58:30 INFO - Return code: 0 04:58:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:58:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:58:30 INFO - Reading from file tmpfile_stdout 04:58:30 INFO - Current package versions: 04:58:30 INFO - argparse == 1.2.1 04:58:30 INFO - blessings == 1.6 04:58:30 INFO - blobuploader == 1.2.4 04:58:30 INFO - docopt == 0.6.1 04:58:30 INFO - functools32 == 3.2.3-2 04:58:30 INFO - jsonschema == 2.5.1 04:58:30 INFO - manifestparser == 1.1 04:58:30 INFO - mozInstall == 1.12 04:58:30 INFO - mozcrash == 0.17 04:58:30 INFO - mozdebug == 0.1 04:58:30 INFO - mozdevice == 0.48 04:58:30 INFO - mozfile == 1.2 04:58:30 INFO - mozhttpd == 0.7 04:58:30 INFO - mozinfo == 0.9 04:58:30 INFO - mozleak == 0.1 04:58:30 INFO - mozlog == 3.2 04:58:30 INFO - moznetwork == 0.27 04:58:30 INFO - mozprocess == 0.23 04:58:30 INFO - mozprofile == 0.28 04:58:30 INFO - mozrunner == 6.12 04:58:30 INFO - mozscreenshot == 0.1 04:58:30 INFO - mozsystemmonitor == 0.3 04:58:30 INFO - moztest == 0.7 04:58:30 INFO - mozversion == 1.4 04:58:30 INFO - psutil == 3.1.1 04:58:30 INFO - requests == 1.2.3 04:58:30 INFO - wsgiref == 0.1.2 04:58:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:30 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 0x1d60030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e570>, '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 0x201f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201f900>, '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': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', '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 04:58:30 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 04:58:30 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 04:58:30 INFO - Using env: {'DISPLAY': ':0', 04:58:30 INFO - 'HOME': '/home/cltbld', 04:58:30 INFO - 'LANG': 'en_US.UTF-8', 04:58:30 INFO - 'LANGUAGE': 'en_US:en', 04:58:30 INFO - 'LOGNAME': 'cltbld', 04:58:30 INFO - 'MAIL': '/var/mail/cltbld', 04:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:30 INFO - 'MOZ_NO_REMOTE': '1', 04:58:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:30 INFO - 'NO_EM_RESTART': '1', 04:58:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:30 INFO - 'PWD': '/builds/slave/test', 04:58:30 INFO - 'SHELL': '/bin/bash', 04:58:30 INFO - 'SHLVL': '1', 04:58:30 INFO - 'TERM': 'linux', 04:58:30 INFO - 'TMOUT': '86400', 04:58:30 INFO - 'USER': 'cltbld', 04:58:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', 04:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:30 INFO - '_': '/tools/buildbot/bin/python'} 04:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:30 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)) 04:58:30 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)) 04:58:30 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)) 04:58:30 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)) 04:58:30 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)) 04:58:30 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)) 04:58:30 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)) 04:58:30 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)) 04:58:30 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)) 04:58:30 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)) 04:58:30 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)) 04:58:30 INFO - Cleaning up... 04:58:30 INFO - Return code: 0 04:58:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d60030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e570>, '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 0x201f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201f900>, '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': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', '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 04:58:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:58:30 INFO - Using env: {'DISPLAY': ':0', 04:58:30 INFO - 'HOME': '/home/cltbld', 04:58:30 INFO - 'LANG': 'en_US.UTF-8', 04:58:30 INFO - 'LANGUAGE': 'en_US:en', 04:58:30 INFO - 'LOGNAME': 'cltbld', 04:58:30 INFO - 'MAIL': '/var/mail/cltbld', 04:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:30 INFO - 'MOZ_NO_REMOTE': '1', 04:58:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:30 INFO - 'NO_EM_RESTART': '1', 04:58:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:30 INFO - 'PWD': '/builds/slave/test', 04:58:30 INFO - 'SHELL': '/bin/bash', 04:58:30 INFO - 'SHLVL': '1', 04:58:30 INFO - 'TERM': 'linux', 04:58:30 INFO - 'TMOUT': '86400', 04:58:30 INFO - 'USER': 'cltbld', 04:58:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', 04:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:30 INFO - '_': '/tools/buildbot/bin/python'} 04:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:58:31 INFO - Cleaning up... 04:58:31 INFO - Return code: 0 04:58:31 INFO - Running post-action listener: _resource_record_post_action 04:58:31 INFO - Running post-action listener: _start_resource_monitoring 04:58:31 INFO - Starting resource monitoring. 04:58:31 INFO - ##### 04:58:31 INFO - ##### Finished create-virtualenv step (success) 04:58:31 INFO - ##### 04:58:31 INFO - ##### 04:58:31 INFO - ##### Running install step. 04:58:31 INFO - ##### 04:58:31 INFO - Running pre-action listener: _resource_record_pre_action 04:58:31 INFO - Running main action method: install 04:58:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:58:31 INFO - Reading from file tmpfile_stdout 04:58:31 INFO - Detecting whether we're running mozinstall >=1.0... 04:58:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:58:31 INFO - Reading from file tmpfile_stdout 04:58:31 INFO - Output received: 04:58:31 INFO - Usage: mozinstall [options] installer 04:58:31 INFO - Options: 04:58:31 INFO - -h, --help show this help message and exit 04:58:31 INFO - -d DEST, --destination=DEST 04:58:31 INFO - Directory to install application into. [default: 04:58:31 INFO - "/builds/slave/test"] 04:58:31 INFO - --app=APP Application being installed. [default: firefox] 04:58:31 INFO - mkdir: /builds/slave/test/build/application 04:58:31 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'] 04:58:31 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 04:58:48 INFO - Reading from file tmpfile_stdout 04:58:48 INFO - Output received: 04:58:48 INFO - /builds/slave/test/build/application/firefox/firefox 04:58:48 INFO - Running post-action listener: _resource_record_post_action 04:58:48 INFO - ##### 04:58:48 INFO - ##### Finished install step (success) 04:58:48 INFO - ##### 04:58:48 INFO - ##### 04:58:48 INFO - ##### Running run-tests step. 04:58:48 INFO - ##### 04:58:48 INFO - Running pre-action listener: _resource_record_pre_action 04:58:48 INFO - Running main action method: run_tests 04:58:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:58:48 INFO - Python 2.7.3 04:58:48 INFO - Return code: 0 04:58:48 INFO - grabbing minidump binary from tooltool 04:58:48 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')]} 04:58:48 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 0x201e570>, '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 0x201f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201f900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:58:48 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 04:58:48 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 04:58:48 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 04:58:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:58:48 INFO - Return code: 0 04:58:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:58:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:58:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:58:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:58:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:58:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 04:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 04:58:48 INFO - Using env: {'DISPLAY': ':0', 04:58:48 INFO - 'HOME': '/home/cltbld', 04:58:48 INFO - 'LANG': 'en_US.UTF-8', 04:58:48 INFO - 'LANGUAGE': 'en_US:en', 04:58:48 INFO - 'LOGNAME': 'cltbld', 04:58:48 INFO - 'MAIL': '/var/mail/cltbld', 04:58:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:58:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:48 INFO - 'MOZ_NO_REMOTE': '1', 04:58:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:48 INFO - 'NO_EM_RESTART': '1', 04:58:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:48 INFO - 'PWD': '/builds/slave/test', 04:58:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:58:48 INFO - 'SHELL': '/bin/bash', 04:58:48 INFO - 'SHLVL': '1', 04:58:48 INFO - 'TERM': 'linux', 04:58:48 INFO - 'TMOUT': '86400', 04:58:48 INFO - 'USER': 'cltbld', 04:58:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285', 04:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:48 INFO - '_': '/tools/buildbot/bin/python'} 04:58:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 04:58:48 INFO - mozversion application_buildid: 20160711013024 04:58:48 INFO - mozversion application_changeset: 035505ea31497d0e07d51cda4711cebb385ca987 04:58:48 INFO - mozversion application_display_name: Nightly 04:58:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:58:48 INFO - mozversion application_name: Firefox 04:58:48 INFO - mozversion application_remotingname: firefox 04:58:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:58:48 INFO - mozversion application_vendor: Mozilla 04:58:48 INFO - mozversion application_version: 50.0a1 04:58:48 INFO - mozversion platform_buildid: 20160711013024 04:58:48 INFO - mozversion platform_changeset: 035505ea31497d0e07d51cda4711cebb385ca987 04:58:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:58:48 INFO - mozversion platform_version: 50.0a1 04:58:48 INFO - using testdate: 1468238328 04:58:48 INFO - actual date: 1468238328 04:58:48 INFO - starting webserver on 'localhost:60972' 04:58:48 INFO - SUITE-START | Running 2 tests 04:58:48 INFO - TEST-START | dromaeo_css 04:58:48 INFO - operating with platform_type : linux_ 04:58:48 INFO - Initialising browser for dromaeo_css test... 04:58:48 INFO - TEST-INFO | started process 10573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCQlrVq/profile http://localhost:60972/getInfo.html) 04:58:53 INFO - PROCESS | 10573 | __metrics Screen width/height:1600/1200 04:58:53 INFO - PROCESS | 10573 | colorDepth:24 04:58:53 INFO - PROCESS | 10573 | Browser inner width/height: 1024/697 04:58:53 INFO - PROCESS | 10573 | __metrics 04:58:53 ERROR - PROCESS | 10573 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 04:58:54 INFO - TEST-INFO | 10573: exit 0 04:58:54 INFO - Browser initialized. 04:58:54 INFO - Running cycle 1/1 for dromaeo_css test... 04:58:54 INFO - TEST-INFO | started process 10692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCQlrVq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:59:06 INFO - PROCESS | 10692 | RSS: Main: 167833600 04:59:06 INFO - PROCESS | 10692 | 04:59:55 INFO - PROCESS | 10692 | 1468238395956 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] 05:02:03 INFO - PROCESS | 10692 | Cycle 1(1): loaded http://localhost:60972/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60972/tests/dromaeo/cssquery-ext.html) 05:02:04 INFO - PROCESS | 10692 | RSS: Main: 172072960 05:02:04 INFO - PROCESS | 10692 | 05:05:07 INFO - PROCESS | 10692 | Cycle 1(1): loaded http://localhost:60972/tests/dromaeo/cssquery-ext.html (next: http://localhost:60972/tests/dromaeo/cssquery-jquery.html) 05:05:07 INFO - PROCESS | 10692 | RSS: Main: 168366080 05:05:07 INFO - PROCESS | 10692 | 05:08:09 INFO - PROCESS | 10692 | Cycle 1(1): loaded http://localhost:60972/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60972/tests/dromaeo/cssquery-mootools.html) 05:08:10 INFO - PROCESS | 10692 | RSS: Main: 170967040 05:08:10 INFO - PROCESS | 10692 | 05:11:12 INFO - PROCESS | 10692 | Cycle 1(1): loaded http://localhost:60972/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60972/tests/dromaeo/cssquery-prototype.html) 05:11:12 INFO - PROCESS | 10692 | RSS: Main: 167022592 05:11:12 INFO - PROCESS | 10692 | 05:14:15 INFO - PROCESS | 10692 | Cycle 1(1): loaded http://localhost:60972/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60972/tests/dromaeo/cssquery-yui.html) 05:14:15 INFO - PROCESS | 10692 | RSS: Main: 168611840 05:14:15 INFO - PROCESS | 10692 | 05:17:18 INFO - PROCESS | 10692 | Cycle 1(1): loaded http://localhost:60972/tests/dromaeo/cssquery-yui.html (next: http://localhost:60972/tests/dromaeo/cssquery-dojo.html) 05:17:18 INFO - PROCESS | 10692 | RSS: Main: 170188800 05:17:18 INFO - PROCESS | 10692 | 05:17:18 INFO - PROCESS | 10692 | __start_tp_report 05:17:18 INFO - PROCESS | 10692 | _x_x_mozilla_page_load 05:17:18 INFO - PROCESS | 10692 | _x_x_mozilla_page_load_details 05:17:18 INFO - PROCESS | 10692 | |i|pagename|runs| 05:17:18 INFO - PROCESS | 10692 | |0;dojo.html;3100.1784527100317;3134.1537784798106;3152.464081106212;3158.857851396687;3169.6671849455806;5506.559475241981;5549.58378121641;5561.833145005651;5658.660480371171;5661.0376236039865;5467.726613669311;5581.49766521013;5604.41153678864;5627.634203776752;5640.5487560995125;5016.046951079302;5072.163093089635;5184.429712731597;5217.530422261995;5218.1650935850275;616.7115851099269;5056.064628043805;5072.0870243356185;5193.091209038422;5202.843914682547;5067.138586440314;5069.771860266297;5097.2608971699265;5120.02719483297;5161.329027226455;5099;5100.336956195671;5105.489451054902;5138.922916156261;5145.511176438233;4953.2074868020945;4998.925016124761;5050.974745126251;5078.593712503028;5084.161113416282;5551.361593416728;5551.3893471718075;5590.049691552445;5603.60774745768;5605.271314729059;5962.582619216657;5990.490808281302;5996.5202783777195;6003.369646187175;6006;5889.057750759858;5996.2504686914135;6001.4298641628975;6045.425684559959;6062.757489700407;5621.409751976065;5626.746796394172;5639.2668953035845;5653.519450846683;5654.095344744862;5990.251218597676;6176.969115154396;6186.566940314225;6195.411435913581;6202.658853762996;5876.794312199053;5925.081612350093;5929.762809487572;5972.044472884318;5975.103734439869;5989.940100599026;6024.006039003603;6036.698165091816;6049.637021778707;6062.969685151635;5690.971545142248;5891.057430811135;5972.163897054415;6029.125776762345;6034.849128771728;5904.5571582131515;5987.970060149672;6001.729922153426;6009.819705408845;6066;4507.977460112678;4521.638268938477;4527.162474942146;4541.6593755468475;4573.451185857718;3977.54258260298;3991.1818077294665;4018.537868145142;4027.597240275949;4093.2018256440306;5573.052581061229;5607.943920560824;5681.857953551194;5776.393478684761;5804.984127777622;6046.455818976313;6054.122152287893;6059.818205453844;6078.787242446493;6088.178095956989;5594.384617692051;5601.439856014447;5697.658140511582;5744.339400968858;5765.1640512125505;5148.871278218;5151.716655583904;5171.948280517222;5203.297554830126;5222.242774797709;6201;6241.34465881085;6241.563090583615;6242.1261023456755;6253.37466253371;5851.356350801323;5921.111833225051;5976.462118409364;6031.457168854824;6032.39676032402;6185;6187.597806142587;6194.938050619617;6206.596571222856;6211.192544969306;5881.117832325185;5891.410858914074;5912.46787789101;5940.435658612425;5940.821775346746;5911.645301281937;6006.309274433496;6023.427774361428;6048.939510604838;6066.423689749467;5880.8235752927485;5925.318588362221;5925.585209035326;5939.851503712442;5943.197668314722;5847.853803654943;5891.617044892068;5892.499137573354;5895.115732639967;5917.467427931507;5779.971100144472;5809.0415081512765;5905.379935106752;5931.673757943182;5960.731767070405;5829.446202610745;5981.581289309706;5997.490213331741;5998.98017337045;6015.368386319548;5682.176084467812;5854.824355269348;5872.618279811799;5880.588358814842;5887.264091988502 05:17:18 INFO - PROCESS | 10692 | |1;ext.html;552.7035546517635;570.1618620627676;582.877595704902;604.4348534120597;611.4619135161057;39049.414258786106;43730.562694373046;44114.55885441144;44262.11475770487;44352.556474435245;44515;44861;45122.32316515255;45338.31992520115;45357;8897.377183597151;9019.503927283997;9028.413153145057;9031.232345250628;9046.683366082189;9002.549872506348;9107.316951228684;9122.817543649124;9124.270058395346;9134.17792398684;9003.279737621007;9046.954765226164;9083.727488175333;9101.726948191565;9126.996030436647;9006.729798106067;9029.367944243906;9080.77298067547;9082.500462474562;9129.497877616728;8894.11058894112;8922.955385223097;8974.28205743539;8999.460032398078;9017.909820901772;42160;42174;42207;42529.149417011795;42655.786721066506;3280.934381312384;3327.5674162358982;3975.8012099394914;4079.3269110596716;4171.10321280923;32834.34331313384;33273.833630831934;33305.6669433305;33397.83301083479;35251.82374088139;4330.891727706801;4396.252637051709;4400.4939431965095;4461.330800379937;4512.368268442421;379976;380581;381315;381655;382590;60484.395156048755;61679.38320616737;61681.38318616846;61749.382506175265;61807.690961545806;35521;35954.28091438157;36351.81824090863;38357.232855342736;63065.684671576346;16903;17013.659726805396;17015.91492042532;17084.231209595597;17202;12420.75158496825;12448.62654120378;12492.750144997231;12501.24992500453;12510.874891251153;19858.304959326353;19945.800541994686;19981.20075197005;20041.799582003994;20122.19511219564;7093.574385536885;7374.926250737424;7379.963100184572;7400.925990740131;7429.62851857405;925.643627203518;1039.542601255445;1060.6977011551671;1108.844761733358;1111.921436206878;34261.82869085639;34480.48279275813;34569.48145777815;34758.65241347605;34804.65195348014;1091.170710260208;1091.8143915534379;1098.549594666183;1114.6656003199007;1123.9550417983353;17688.380906668204;18059.819401805813;18090.547736306697;18203.45389638313;18283.08584570766;609009;613761;615270;615617;620579;59911.70044149838;60130;60321.396786032456;60594.69702651459;60678.696606517566;1306.5296493262417;1307.5096838685492;1334.7864341705085;1336.8395792504962;1351.5472316773992;32541.511877321387;33617.83191084029;33699.32601348008;33726.66273337235;34048.65951340554;52576.474235257156;53029.204561932376;53051;53088.73455632697;53163;350648;356235;357462;357769;359036;28588.42823143567;29178.270543236587;29189.41621167607;29225.123246302646;29346.853265733534;48726.756366217945;49955;50105.24842127298;50557.49442505528;50785;42925.57074429341;43005.35491967561;43374.34938475862;43466.348004780586;44490.55509444864;42596.57403425926;42876;42938.78530607327;42991.57008429876;43587;36120;41467.58532414637;44714.776426118966;44895.55104448914;45253;43488.34767478427;45748;45998;46024.539754603364;46291.305630416246;35533;35970.4604430939;36316.27367452689;36699.63300367069;36724.265514690094 05:17:18 INFO - PROCESS | 10692 | |2;jquery.html;382.59827181459445;387.9883603491895;388.0084165009747;389.8830350894732;405.14110086616375;18837.246510139594;20386.592268154647;20539.589208215828;20776;20829.583408331862;19706.901465492654;20077.698834517494;20329.59340813183;20339.796602033974;20476.59046819063;5526;5799.072148456248;5804.82585522435;5881.500072493843;5916.704164791765;5812.070068788995;5857.76568937242;6123.418275263865;6510.414062734353;6517.837054073662;6265.06024096387;6440.066190402389;6519.739210431577;6618.635975021371;6642.269350371479;5995.070764031582;6025.0661147522205;6035.909461358083;6037.607555508878;6037.637741735488;5701.914471282934;5806.158107074492;5857.619254748428;5947.375525569796;5979.940200597982;23203.419914502105;23354.64968025481;23986.28041158768;24302.513949721084;24322.391940201458;2286.0969916882736;2287.7369102553253;2318.7913087822176;2342.6486027095903;2815.338395477061;10140.847887281696;10337.173026157889;10691.411972341519;10798.136149108053;10840.241183117185;1937.680282753344;1942.2328180368675;1997.980020199794;2013.1041686449537;2014.9597008059902;71108.28891711068;79609.60195198987;84949;85169.57415212947;94209.5289523548;11153.94423027896;11266.66200014001;11353.53717116271;11458.312501249951;11464.656060318204;15707.921460392625;15744.291506882219;15781.526554203392;15801.288941997638;15802.683946321009;7652.579108148994;7788.727394541163;7920;8085.574327701666;8108;7545.207753185946;7590.620468976529;7657.846843063107;7783.455158138876;7792.454528182972;4735.289706543977;4788.7366194859615;4863.70817750929;4916.164252077156;4955.529224723646;1946.8150525700037;1998.4012789768128;2030.1067530286628;2049.3954283486405;2105.957221495147;929.9023602521773;952.5046975572802;1042.442293373057;1047.61238341814;1058.7247315697973;20131.597368052557;20582;20837.270695525585;21240.681389779165;21338.78661213399;982.2044144243185;999.1557134221571;1025.7948410317965;1043.4834756795435;1068.9144868410508;11101.612298462693;11463.484143213574;11592.710182245342;11615.477303521193;11723.35521546323;459901.10148347804;462883;463371;478160;494501;98465.50767246119;101422.49288753509;103899.480502597;106053;110061;1034.8551202831609;1061.7611037516497;1064.7923654887222;1098.7363032872213;1111.7220694826294;18757.90621046886;19283.325083622567;19663.70504442463;19775.208991640175;19826.801731982494;46810.765946171414;47319.29021064756;47826.760866195444;47984.760076199396;48903.75548122237;65324;65921.34078659344;66211.33788662052;66586.6670666663;67692.661536692;8841.778955526162;8912.643494260416;9011.098890110936;9067.637294508146;9100.59047342858;10166.644167454104;14754.827712041963;14932.477363292233;14933.17867517297;15098.018628789094;12219.755604887674;12681.873181268069;12869.163504372185;12898.613041608767;13159.736805264032;12579.182353147016;12739.108262421541;12858.485660573846;13018.349082546025;13025.413856376295;12951.870481295067;13113.737725245632;13228;13241.668958275735;13332.800007999695;8923.286137108886;8947.776305592412;8981.775455613662;9109.316801240066;9192.678256260999;9416;12796.168249063781;12974;13130.540431084866;13221.405036773176 05:17:18 INFO - PROCESS | 10692 | |3;mootools.html;1469.0598017268942;1499.6850661361113;1630.4456484795176;1768.5578605348662;1778.4575704410158;7833.804154896116;8525.957370213147;8530.957345213264;9148.8627670585;9181.357304988645;8665.176808203227;8991.640334386617;8992.145746154121;9016.413933094344;9066.048064953184;2353.8587684738927;2393.4375421775867;2400.039984006403;2400.627902675088;2401.771831675988;2365.8698771567642;2368.4789346343778;2372.632242002492;2377.3818807110188;2389.7371289158264;2322.071171531384;2322.698049253603;2344.19125401737;2366.1954935321987;2369.9407514812183;2319.188284100568;2329.0683726509365;2333.1717240379676;2341.086976079339;2350.670906073151;2299.586074506588;2303.7045521321556;2317.4322291038634;2317.4438134847683;2319.22306027481;9138;9165.129312715282;9166.404183728037;9177;9223.308251881135;5284.497972692588;5447.128459446509;5466.34403871534;5468.644538105011;5478.123500239983;3336.1326055225572;3344.5819272590925;3371.9157021074425;3398.8300584970652;3450.1374656335915;1102.3055475050667;1121.3272036777948;1123.9494222759995;1135.2961164078242;1142.2917790969568;12558.68603284916;12703.301318427482;12711.046671499582;12736.554220602327;12743.681407964783;4503.279475283939;4640.69835460694;4785.712857228577;4821.879453013633;4828.66199366048;10650.414227217578;10652.414117223627;10660.573577056986;10702;10727.678169654922;5439.3200849893765;5465.289512363447;5486.615936884459;5490.780368785284;5500.889982200413;4396.208682437192;4658.394408726912;4810.230363141881;4828.130936431406;5033.219850923113;4089.161721847014;4116.259073366763;4131.588397238941;4133.23535145999;4149.605787450188;1305.3668970549277;1320.19468124444;1321.1808678619318;1329.6941703408077;1342.6777573382317;928.7724507495707;942.4062840410497;967.0426277984885;968.2544440780559;991.8561808537721;5995.910061349084;6095.969520152371;6144.5084393248435;6200.410960958701;6217.658028808369;412.5400178800676;426.5819496893062;427.52331150766673;446.84360473833897;447.8701176658798;4129.587041295847;4185.267578173868;4204.3693445983345;4213.410122582841;4233.7671428071135;10844.295120817122;11291.604793832177;11339.886601134049;11395.430228488542;11406.486708098155;10912.61805836792;11225.887741122648;11236.269642473377;11304.773904522028;11372.147088968195;8086.070101938352;8087.797805054921;8198.631061602242;8203.466774659628;8204.794880127925;6023.849403764766;6069.2110025696375;6170.660613666291;6225.408586184305;6260.029695397221;10169.135623472088;10419.635312764018;10597.41714205726;10600.734981625521;10627.415492148006;10573.62992295266;10609.310394824312;10695.197860160675;10752.40861752611;10832.295900766425;7088.0785497884945;7400.629968501661;7551.546907185587;7936.206379362248;8006.159353267823;8576.185262400062;8593.44142630727;8601.82796344082;8627.568621569022;8658.134186581292;7290.416766658761;7433.145188303414;7508.136564295176;7521.5111017783665;7654.540727556365;7481.476296659399;7532.43506736986;7541.095068591804;7567.31894129531;7643.503172293783;6916.3429474199875;6926.480513961574;6977.511574189758;6984.231734509099;6988.021676965127;4914.852554423373;5033.899322013613;5145.948540514547;5153.4073581538605;5158.613104017289;5083.771230294719;5098.694078355311;5111.182210846247;5155.149400348901;5195.350581177353 05:17:18 INFO - PROCESS | 10692 | |4;prototype.html;323.41139126789255;324.6023621064196;326.5330428611838;327.6575978102883;335.6693656748104;5532.5573954083675;5612.5229355504725;5709.286339207594;5804.303483581971;5852.561057920657;5656.321241451032;5692.0608099663505;5695.686737229451;5703.857403564903;5728.682403047302;4335.783210839461;4344.78276086196;4411.691181617288;4425.8229670813125;4434.024514606781;4178.268802959486;4416.668749843759;4416.911661766779;4421.872422532266;4438.711483753562;4340.112051257697;4364;4367.388565600819;4376.693631445784;4381;4328.264195086827;4348.282533381972;4353.325234588644;4387.692861499696;4391.934120988188;3800.2969450651717;3851.5185601799776;3866.1881004988986;3881.4177873318945;3884.553276373225;5503.889922201533;5503.9174412383845;5561.499465048165;5572.721363931787;5574.386817450078;4967.155583550805;4984.202527595604;5000.924986125211;5016.548510634024;5030.471800460972;5601.439856014366;5865.237519122529;5911.645301281894;5936.970315148396;5949.553783466257;4141.482314710661;4142.606452387018;4156.833726650931;4182.749035057906;4195.286801243796;6189.288231853305;6193.81418557444;6213.192285002966;6215.72029258689;6217.813465595994;4151.13199060424;4192.748435093904;4202.663786897041;4218.6625069994325;4315.784210789448;4251.659867210616;4258.382534532476;4289.335153051282;4292.484901811803;4293.785310734514;4958.9008219835405;4959.380077490314;4966.279889416014;4975.129352363322;4980.800767969313;5775.249217601685;5954.523638108941;5981.312149102821;5994.610350327215;6030.819075427744;1477.726620575197;1490.7093116842111;1495.8803295736532;1499.71505413971;1500.9118389167766;926.5597732290638;939.8731171291925;947.554649314821;953.547065144051;960.5293406230896;5071.771770270347;5079;5082.720450375191;5099.59203263738;5148.304978827885;5318.521333079964;5390.757415916293;5415.268938693226;5444.482774136451;5447.945520544823;4892.578173803919;5065.940551827459;5125.231215317657;5203.479652034842;5241.397239317527;2861.5549147680704;2883.3656595549364;2895.478813813492;2911.5778212159544;2913.577531257956;5492.011437941129;5524.281843360418;5524.58565607581;5536.640118392292;5594.552435805207;5483.670979741229;5789.421057894261;6175.517875709887;6235.906461403082;6309.968450157719;6280.403361680633;6286.371362863769;6332.461740751995;6361.236651601837;6414.61512309263;6046.818595442144;6115.908261376172;6135.969320153371;6162.582606000556;6181.258249010148;6044.335123136363;6047.909281360695;6058.395254823373;6071;6076.513878889767;6046.395360464095;6290.402411770874;6332.2717887441695;6405.583637063576;6419.293877673359;4373.737575745466;4443.977780111208;4446.844360447369;4455.086707225076;4474.127545128799;6190.628562286277;6191.752329906753;6204.81385558434;6217.507798128326;6231.813045608639;5889.882202356014;5924.259467566554;5930.679208246347;5955.553333500092;5969.970150149222;5964.493018093511;5985.25184351956;6018.729157188025;6033.818985430444;6035.736598775459;5733.541316694738;5869.618474799125;5941.851453713692;5960.3443621202505;6068.21113255274;5978.163057172086;5982.341942386421;5994.3705910878725;5999.88000239984;6041.945738448949;5841.50347220474;5844.996177618345;5911.940880591139;5926;5945.613535120204 05:17:18 INFO - PROCESS | 10692 | |5;yui.html;696.7735485967062;714.6033951157106;722.4653756220397;770.148985371165;771.6604693934672;17244.22400991955;17919.910400447978;17927.910360448197;17938.372156974525;17949.551261218476;16357;16370.590735231624;16390.754138687927;16425.507234782945;16542.669146617092;780.5745868501651;803.2248879830962;803.6222975201661;829.9170082991683;833.3166803221361;823.9958800205991;831.6673330667751;836.4270474724833;838.0655569040506;839.7942504086508;854.3549620036895;858.5535521528833;862.905080441151;869.3783944479695;869.482657818597;866.0343716755835;866.5320726807579;866.5927014303298;866.9046404895456;867.7179916527153;634.536788144657;635.3202073781056;635.9586626869238;636.0173531893236;636.4208570201095;15881.444149454714;15886.36454541817;15908.840911590853;15917.204139792964;15940.521784346489;14614.853851461456;14697.485588004476;14714.117152970855;14733;14778.778318325127;12153.331566763825;12198;12372;12425.565105221274;12978.091533592653;3813.903839343159;3922.4312474691296;3978.423128646359;3981.6416522513114;4034.677225821927;81440.59279703622;87786.5610671949;88736;88754.11245887588;88932.55533722354;11649.76700465986;11893.167478276437;12003.459844307026;12197.51209951592;12424.75150496985;22209.888950555145;22349.32952011442;22408.103675853108;22449.88775056114;22507.88746056292;8567.443116197428;8869.600867960957;8953.33174867278;9031.051739567381;9076.773080673036;4876.414830220397;5002.724850133205;5005.424376196711;5005.499450055038;5046.293518907356;3589.0489020409614;3690.501782259414;3696.667299943018;3698.852045918187;3709.536307961505;631.905214217871;653.5098675993005;656.2846497317851;659.9142111525471;676.6684324680871;638.6327861479575;654.7741029344868;711.526834654959;754.8075240813557;756.5233902641301;9648.95175524132;9737.610495580097;9889.703308900744;9891.802163956681;10032.448215348226;609.6159419565645;707.5577316355891;725.8676464715062;745.3962290544677;776.3090849144266;4481.5070342262325;4488.079943611552;4600.976995115003;4606.760557780783;4615.976920115378;70484.64757676178;78712.60643696744;120238;126402;127218;109565;109565;110566.44716776365;111473;113379.43310283395;94531;96701;96929.5153524228;97529;98387;8461.703840365557;8528.616212270339;8600.526971016403;8716.520591367282;8769.693060742844;53772.73113634407;54653.1802022962;55412.72293638506;55452.16821747596;56101.719491402284;69725.30274697188;76297.23702763123;76891.61554192193;77399;79369;11872.228305160137;11990.640280791591;12044.036477081638;12397.566085186974;12430.316332601793;13384.732305353644;13443.865561344652;13711.794323084961;13740;14401.855981440052;12601.495940162291;12624.242545447303;12676.182157462052;12766.553170638983;13127.540536081191;12870.356482175666;13065.869341306465;13178.275194864374;13248.403821827847;13438.636827359049;11118.888811111785;11507.769844602893;11927.761444770882;12134.635960921187;12139.332336721565;10080.798384032425;10178.829434615114;10274.845877311696;10420.635277765241;10942.890571094187;10402.531886064993;10844.18668599874;10958.28771129874;11003.669889903316;11073.778524429628 05:17:18 INFO - PROCESS | 10692 | __end_tp_report 05:17:18 INFO - PROCESS | 10692 | __start_cc_report 05:17:18 INFO - PROCESS | 10692 | _x_x_mozilla_cycle_collect,369 05:17:18 INFO - PROCESS | 10692 | __end_cc_report 05:17:18 INFO - PROCESS | 10692 | __startTimestamp1468239438908__endTimestamp 05:17:18 INFO - PROCESS | 10692 | 05:17:18 INFO - PROCESS | 10692 | ------- Summary: start ------- 05:17:18 INFO - PROCESS | 10692 | Number of tests: 6 05:17:18 INFO - PROCESS | 10692 | 05:17:18 INFO - PROCESS | 10692 | [#0] dojo.html Cycles:165 Average:5550.47 Median:5872.62 stddev:761.71 (13.0%) stddev-sans-first:739.39 05:17:18 INFO - PROCESS | 10692 | Values: 3100.2 3134.2 3152.5 3158.9 3169.7 5506.6 5549.6 5561.8 5658.7 5661.0 5467.7 5581.5 5604.4 5627.6 5640.5 5016.0 5072.2 5184.4 5217.5 5218.2 616.7 5056.1 5072.1 5193.1 5202.8 5067.1 5069.8 5097.3 5120.0 5161.3 5099.0 5100.3 5105.5 5138.9 5145.5 4953.2 4998.9 5051.0 5078.6 5084.2 5551.4 5551.4 5590.0 5603.6 5605.3 5962.6 5990.5 5996.5 6003.4 6006.0 5889.1 5996.3 6001.4 6045.4 6062.8 5621.4 5626.7 5639.3 5653.5 5654.1 5990.3 6177.0 6186.6 6195.4 6202.7 5876.8 5925.1 5929.8 5972.0 5975.1 5989.9 6024.0 6036.7 6049.6 6063.0 5691.0 5891.1 5972.2 6029.1 6034.8 5904.6 5988.0 6001.7 6009.8 6066.0 4508.0 4521.6 4527.2 4541.7 4573.5 3977.5 3991.2 4018.5 4027.6 4093.2 5573.1 5607.9 5681.9 5776.4 5805.0 6046.5 6054.1 6059.8 6078.8 6088.2 5594.4 5601.4 5697.7 5744.3 5765.2 5148.9 5151.7 5171.9 5203.3 5222.2 6201.0 6241.3 6241.6 6242.1 6253.4 5851.4 5921.1 5976.5 6031.5 6032.4 6185.0 6187.6 6194.9 6206.6 6211.2 5881.1 5891.4 5912.5 5940.4 5940.8 5911.6 6006.3 6023.4 6048.9 6066.4 5880.8 5925.3 5925.6 5939.9 5943.2 5847.9 5891.6 5892.5 5895.1 5917.5 5780.0 5809.0 5905.4 5931.7 5960.7 5829.4 5981.6 5997.5 5999.0 6015.4 5682.2 5854.8 5872.6 5880.6 5887.3 05:17:18 INFO - PROCESS | 10692 | 05:17:18 INFO - PROCESS | 10692 | [#1] ext.html Cycles:180 Average:61759.33 Median:42998.46 stddev:123741.66 (287.8%) stddev-sans-first:124003.46 05:17:18 INFO - PROCESS | 10692 | Values: 552.7 570.2 582.9 604.4 611.5 39049.4 43730.6 44114.6 44262.1 44352.6 44515.0 44861.0 45122.3 45338.3 45357.0 8897.4 9019.5 9028.4 9031.2 9046.7 9002.5 9107.3 9122.8 9124.3 9134.2 9003.3 9047.0 9083.7 9101.7 9127.0 9006.7 9029.4 9080.8 9082.5 9129.5 8894.1 8923.0 8974.3 8999.5 9017.9 42160.0 42174.0 42207.0 42529.1 42655.8 3280.9 3327.6 3975.8 4079.3 4171.1 32834.3 33273.8 33305.7 33397.8 35251.8 4330.9 4396.3 4400.5 4461.3 4512.4 379976.0 380581.0 381315.0 381655.0 382590.0 60484.4 61679.4 61681.4 61749.4 61807.7 35521.0 35954.3 36351.8 38357.2 63065.7 16903.0 17013.7 17015.9 17084.2 17202.0 12420.8 12448.6 12492.8 12501.2 12510.9 19858.3 19945.8 19981.2 20041.8 20122.2 7093.6 7374.9 7380.0 7400.9 7429.6 925.6 1039.5 1060.7 1108.8 1111.9 34261.8 34480.5 34569.5 34758.7 34804.7 1091.2 1091.8 1098.5 1114.7 1124.0 17688.4 18059.8 18090.5 18203.5 18283.1 609009.0 613761.0 615270.0 615617.0 620579.0 59911.7 60130.0 60321.4 60594.7 60678.7 1306.5 1307.5 1334.8 1336.8 1351.5 32541.5 33617.8 33699.3 33726.7 34048.7 52576.5 53029.2 53051.0 53088.7 53163.0 350648.0 356235.0 357462.0 357769.0 359036.0 28588.4 29178.3 29189.4 29225.1 29346.9 48726.8 49955.0 50105.2 50557.5 50785.0 42925.6 43005.4 43374.3 43466.3 44490.6 42596.6 42876.0 42938.8 42991.6 43587.0 36120.0 41467.6 44714.8 44895.6 45253.0 43488.3 45748.0 45998.0 46024.5 46291.3 35533.0 35970.5 36316.3 36699.6 36724.3 05:17:18 INFO - PROCESS | 10692 | 05:17:18 INFO - PROCESS | 10692 | [#2] jquery.html Cycles:180 Average:29732.93 Median:2303.26 stddev:78311.36 (3400.0%) stddev-sans-first:78500.03 05:17:18 INFO - PROCESS | 10692 | Values: 382.6 388.0 388.0 389.9 405.1 18837.2 20386.6 20539.6 20776.0 20829.6 19706.9 20077.7 20329.6 20339.8 20476.6 5526.0 5799.1 5804.8 5881.5 5916.7 5812.1 5857.8 6123.4 6510.4 6517.8 6265.1 6440.1 6519.7 6618.6 6642.3 5995.1 6025.1 6035.9 6037.6 6037.6 5701.9 5806.2 5857.6 5947.4 5979.9 23203.4 23354.6 23986.3 24302.5 24322.4 2286.1 2287.7 2318.8 2342.6 2815.3 10140.8 10337.2 10691.4 10798.1 10840.2 1937.7 1942.2 1998.0 2013.1 2015.0 71108.3 79609.6 84949.0 85169.6 94209.5 11153.9 11266.7 11353.5 11458.3 11464.7 15707.9 15744.3 15781.5 15801.3 15802.7 7652.6 7788.7 7920.0 8085.6 8108.0 7545.2 7590.6 7657.8 7783.5 7792.5 4735.3 4788.7 4863.7 4916.2 4955.5 1946.8 1998.4 2030.1 2049.4 2106.0 929.9 952.5 1042.4 1047.6 1058.7 20131.6 20582.0 20837.3 21240.7 21338.8 982.2 999.2 1025.8 1043.5 1068.9 11101.6 11463.5 11592.7 11615.5 11723.4 459901.1 462883.0 463371.0 478160.0 494501.0 98465.5 101422.5 103899.5 106053.0 110061.0 1034.9 1061.8 1064.8 1098.7 1111.7 18757.9 19283.3 19663.7 19775.2 19826.8 46810.8 47319.3 47826.8 47984.8 48903.8 65324.0 65921.3 66211.3 66586.7 67692.7 8841.8 8912.6 9011.1 9067.6 9100.6 10166.6 14754.8 14932.5 14933.2 15098.0 12219.8 12681.9 12869.2 12898.6 13159.7 12579.2 12739.1 12858.5 13018.3 13025.4 12951.9 13113.7 13228.0 13241.7 13332.8 8923.3 8947.8 8981.8 9109.3 9192.7 9416.0 12796.2 12974.0 13130.5 13221.4 05:17:18 INFO - PROCESS | 10692 | 05:17:18 INFO - PROCESS | 10692 | [#3] mootools.html Cycles:180 Average:5886.49 Median:2475.57 stddev:3408.10 (137.7%) stddev-sans-first:3401.50 05:17:18 INFO - PROCESS | 10692 | Values: 1469.1 1499.7 1630.4 1768.6 1778.5 7833.8 8526.0 8531.0 9148.9 9181.4 8665.2 8991.6 8992.1 9016.4 9066.0 2353.9 2393.4 2400.0 2400.6 2401.8 2365.9 2368.5 2372.6 2377.4 2389.7 2322.1 2322.7 2344.2 2366.2 2369.9 2319.2 2329.1 2333.2 2341.1 2350.7 2299.6 2303.7 2317.4 2317.4 2319.2 9138.0 9165.1 9166.4 9177.0 9223.3 5284.5 5447.1 5466.3 5468.6 5478.1 3336.1 3344.6 3371.9 3398.8 3450.1 1102.3 1121.3 1123.9 1135.3 1142.3 12558.7 12703.3 12711.0 12736.6 12743.7 4503.3 4640.7 4785.7 4821.9 4828.7 10650.4 10652.4 10660.6 10702.0 10727.7 5439.3 5465.3 5486.6 5490.8 5500.9 4396.2 4658.4 4810.2 4828.1 5033.2 4089.2 4116.3 4131.6 4133.2 4149.6 1305.4 1320.2 1321.2 1329.7 1342.7 928.8 942.4 967.0 968.3 991.9 5995.9 6096.0 6144.5 6200.4 6217.7 412.5 426.6 427.5 446.8 447.9 4129.6 4185.3 4204.4 4213.4 4233.8 10844.3 11291.6 11339.9 11395.4 11406.5 10912.6 11225.9 11236.3 11304.8 11372.1 8086.1 8087.8 8198.6 8203.5 8204.8 6023.8 6069.2 6170.7 6225.4 6260.0 10169.1 10419.6 10597.4 10600.7 10627.4 10573.6 10609.3 10695.2 10752.4 10832.3 7088.1 7400.6 7551.5 7936.2 8006.2 8576.2 8593.4 8601.8 8627.6 8658.1 7290.4 7433.1 7508.1 7521.5 7654.5 7481.5 7532.4 7541.1 7567.3 7643.5 6916.3 6926.5 6977.5 6984.2 6988.0 4914.9 5033.9 5145.9 5153.4 5158.6 5083.8 5098.7 5111.2 5155.1 5195.4 05:17:18 INFO - PROCESS | 10692 | 05:17:18 INFO - PROCESS | 10692 | [#4] prototype.html Cycles:180 Average:4914.93 Median:5528.57 stddev:1472.83 (26.6%) stddev-sans-first:1436.08 05:17:18 INFO - PROCESS | 10692 | Values: 323.4 324.6 326.5 327.7 335.7 5532.6 5612.5 5709.3 5804.3 5852.6 5656.3 5692.1 5695.7 5703.9 5728.7 4335.8 4344.8 4411.7 4425.8 4434.0 4178.3 4416.7 4416.9 4421.9 4438.7 4340.1 4364.0 4367.4 4376.7 4381.0 4328.3 4348.3 4353.3 4387.7 4391.9 3800.3 3851.5 3866.2 3881.4 3884.6 5503.9 5503.9 5561.5 5572.7 5574.4 4967.2 4984.2 5000.9 5016.5 5030.5 5601.4 5865.2 5911.6 5937.0 5949.6 4141.5 4142.6 4156.8 4182.7 4195.3 6189.3 6193.8 6213.2 6215.7 6217.8 4151.1 4192.7 4202.7 4218.7 4315.8 4251.7 4258.4 4289.3 4292.5 4293.8 4958.9 4959.4 4966.3 4975.1 4980.8 5775.2 5954.5 5981.3 5994.6 6030.8 1477.7 1490.7 1495.9 1499.7 1500.9 926.6 939.9 947.6 953.5 960.5 5071.8 5079.0 5082.7 5099.6 5148.3 5318.5 5390.8 5415.3 5444.5 5447.9 4892.6 5065.9 5125.2 5203.5 5241.4 2861.6 2883.4 2895.5 2911.6 2913.6 5492.0 5524.3 5524.6 5536.6 5594.6 5483.7 5789.4 6175.5 6235.9 6310.0 6280.4 6286.4 6332.5 6361.2 6414.6 6046.8 6115.9 6136.0 6162.6 6181.3 6044.3 6047.9 6058.4 6071.0 6076.5 6046.4 6290.4 6332.3 6405.6 6419.3 4373.7 4444.0 4446.8 4455.1 4474.1 6190.6 6191.8 6204.8 6217.5 6231.8 5889.9 5924.3 5930.7 5955.6 5970.0 5964.5 5985.3 6018.7 6033.8 6035.7 5733.5 5869.6 5941.9 5960.3 6068.2 5978.2 5982.3 5994.4 5999.9 6041.9 5841.5 5845.0 5911.9 5926.0 5945.6 05:17:18 INFO - PROCESS | 10692 | 05:17:18 INFO - PROCESS | 10692 | [#5] yui.html Cycles:180 Average:21619.40 Median:4544.53 stddev:31729.73 (698.2%) stddev-sans-first:31779.84 05:17:18 INFO - PROCESS | 10692 | Values: 696.8 714.6 722.5 770.1 771.7 17244.2 17919.9 17927.9 17938.4 17949.6 16357.0 16370.6 16390.8 16425.5 16542.7 780.6 803.2 803.6 829.9 833.3 824.0 831.7 836.4 838.1 839.8 854.4 858.6 862.9 869.4 869.5 866.0 866.5 866.6 866.9 867.7 634.5 635.3 636.0 636.0 636.4 15881.4 15886.4 15908.8 15917.2 15940.5 14614.9 14697.5 14714.1 14733.0 14778.8 12153.3 12198.0 12372.0 12425.6 12978.1 3813.9 3922.4 3978.4 3981.6 4034.7 81440.6 87786.6 88736.0 88754.1 88932.6 11649.8 11893.2 12003.5 12197.5 12424.8 22209.9 22349.3 22408.1 22449.9 22507.9 8567.4 8869.6 8953.3 9031.1 9076.8 4876.4 5002.7 5005.4 5005.5 5046.3 3589.0 3690.5 3696.7 3698.9 3709.5 631.9 653.5 656.3 659.9 676.7 638.6 654.8 711.5 754.8 756.5 9649.0 9737.6 9889.7 9891.8 10032.4 609.6 707.6 725.9 745.4 776.3 4481.5 4488.1 4601.0 4606.8 4616.0 70484.6 78712.6 120238.0 126402.0 127218.0 109565.0 109565.0 110566.4 111473.0 113379.4 94531.0 96701.0 96929.5 97529.0 98387.0 8461.7 8528.6 8600.5 8716.5 8769.7 53772.7 54653.2 55412.7 55452.2 56101.7 69725.3 76297.2 76891.6 77399.0 79369.0 11872.2 11990.6 12044.0 12397.6 12430.3 13384.7 13443.9 13711.8 13740.0 14401.9 12601.5 12624.2 12676.2 12766.6 13127.5 12870.4 13065.9 13178.3 13248.4 13438.6 11118.9 11507.8 11927.8 12134.6 12139.3 10080.8 10178.8 10274.8 10420.6 10942.9 10402.5 10844.2 10958.3 11003.7 11073.8 05:17:18 INFO - PROCESS | 10692 | -------- Summary: end -------- 05:17:18 INFO - PROCESS | 10692 | 05:17:19 INFO - TEST-INFO | 10692: exit 0 05:17:19 INFO - TEST-OK | dromaeo_css | took 1110834ms 05:17:19 INFO - TEST-START | kraken 05:17:19 INFO - operating with platform_type : linux_ 05:17:19 INFO - Initialising browser for kraken test... 05:17:19 INFO - TEST-INFO | started process 10940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKTbl31/profile http://localhost:60972/getInfo.html) 05:17:23 INFO - PROCESS | 10940 | __metrics Screen width/height:1600/1200 05:17:23 INFO - PROCESS | 10940 | colorDepth:24 05:17:23 INFO - PROCESS | 10940 | Browser inner width/height: 1024/697 05:17:23 INFO - PROCESS | 10940 | __metrics 05:17:24 ERROR - PROCESS | 10940 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 05:17:25 INFO - TEST-INFO | 10940: exit 0 05:17:25 INFO - Browser initialized. 05:17:25 INFO - Running cycle 1/1 for kraken test... 05:17:25 INFO - TEST-INFO | started process 11060 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKTbl31/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:37 INFO - PROCESS | 11060 | RSS: Main: 167907328 05:17:37 INFO - PROCESS | 11060 | 05:17:39 INFO - PROCESS | 11060 | Cycle 1(1): loaded http://localhost:60972/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60972/tests/kraken/driver.html?testName=audio-beat-detection) 05:17:40 INFO - PROCESS | 11060 | RSS: Main: 172806144 05:17:40 INFO - PROCESS | 11060 | 05:17:42 INFO - PROCESS | 11060 | Cycle 1(1): loaded http://localhost:60972/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60972/tests/kraken/driver.html?testName=audio-dft) 05:17:43 INFO - PROCESS | 11060 | RSS: Main: 172781568 05:17:43 INFO - PROCESS | 11060 | 05:17:46 INFO - PROCESS | 11060 | Cycle 1(1): loaded http://localhost:60972/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60972/tests/kraken/driver.html?testName=audio-fft) 05:17:47 INFO - PROCESS | 11060 | RSS: Main: 167014400 05:17:47 INFO - PROCESS | 11060 | 05:17:49 INFO - PROCESS | 11060 | Cycle 1(1): loaded http://localhost:60972/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60972/tests/kraken/driver.html?testName=audio-oscillator) 05:17:49 INFO - PROCESS | 11060 | RSS: Main: 168153088 05:17:49 INFO - PROCESS | 11060 | 05:17:52 INFO - PROCESS | 11060 | Cycle 1(1): loaded http://localhost:60972/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60972/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:17:52 INFO - PROCESS | 11060 | RSS: Main: 168325120 05:17:52 INFO - PROCESS | 11060 | 05:17:55 INFO - PROCESS | 11060 | Cycle 1(1): loaded http://localhost:60972/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60972/tests/kraken/driver.html?testName=imaging-darkroom) 05:17:56 INFO - PROCESS | 11060 | RSS: Main: 168275968 05:17:56 INFO - PROCESS | 11060 | 05:17:59 INFO - PROCESS | 11060 | Cycle 1(1): loaded http://localhost:60972/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60972/tests/kraken/driver.html?testName=imaging-desaturate) 05:18:00 INFO - PROCESS | 11060 | RSS: Main: 168816640 05:18:00 INFO - PROCESS | 11060 | 05:18:03 INFO - PROCESS | 11060 | Cycle 1(1): loaded http://localhost:60972/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60972/tests/kraken/driver.html?testName=json-parse-financial) 05:18:03 INFO - PROCESS | 11060 | RSS: Main: 168353792 05:18:03 INFO - PROCESS | 11060 | 05:18:05 INFO - PROCESS | 11060 | Cycle 1(1): loaded http://localhost:60972/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60972/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:18:06 INFO - PROCESS | 11060 | RSS: Main: 168513536 05:18:06 INFO - PROCESS | 11060 | 05:18:07 INFO - PROCESS | 11060 | Cycle 1(1): loaded http://localhost:60972/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60972/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:18:08 INFO - PROCESS | 11060 | RSS: Main: 169082880 05:18:08 INFO - PROCESS | 11060 | 05:18:10 INFO - PROCESS | 11060 | Cycle 1(1): loaded http://localhost:60972/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60972/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:18:11 INFO - PROCESS | 11060 | RSS: Main: 169213952 05:18:11 INFO - PROCESS | 11060 | 05:18:13 INFO - PROCESS | 11060 | Cycle 1(1): loaded http://localhost:60972/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:18:14 INFO - PROCESS | 11060 | RSS: Main: 169840640 05:18:14 INFO - PROCESS | 11060 | 05:18:17 INFO - PROCESS | 11060 | Cycle 1(1): loaded http://localhost:60972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:18:17 INFO - PROCESS | 11060 | RSS: Main: 169414656 05:18:17 INFO - PROCESS | 11060 | 05:18:19 INFO - PROCESS | 11060 | Cycle 1(1): loaded http://localhost:60972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60972/tests/kraken/driver.html?testName=ai-astar) 05:18:19 INFO - PROCESS | 11060 | RSS: Main: 170008576 05:18:19 INFO - PROCESS | 11060 | 05:18:19 INFO - PROCESS | 11060 | __start_tp_report 05:18:19 INFO - PROCESS | 11060 | _x_x_mozilla_page_load 05:18:19 INFO - PROCESS | 11060 | _x_x_mozilla_page_load_details 05:18:19 INFO - PROCESS | 11060 | |i|pagename|runs| 05:18:19 INFO - PROCESS | 11060 | |0;ai-astar;103;111;105;109;112;111;112;110;115;112 05:18:19 INFO - PROCESS | 11060 | |1;audio-beat-detection;152;119;150;188;121;148;153;120;180;121 05:18:19 INFO - PROCESS | 11060 | |2;audio-dft;161;164;161;164;169;167;176;163;164;161 05:18:19 INFO - PROCESS | 11060 | |3;audio-fft;76;75;75;160;77;75;76;75;168;76 05:18:19 INFO - PROCESS | 11060 | |4;audio-oscillator;83;87;163;87;84;85;141;84;85;142 05:18:19 INFO - PROCESS | 11060 | |5;imaging-gaussian-blur;118;118;117;117;117;118;117;119;118;118 05:18:19 INFO - PROCESS | 11060 | |6;imaging-darkroom;147;148;147;148;147;147;147;148;147;148 05:18:19 INFO - PROCESS | 11060 | |7;imaging-desaturate;96;96;96;96;96;97;95;96;96;96 05:18:19 INFO - PROCESS | 11060 | |8;json-parse-financial;54;56;55;54;55;56;55;54;55;54 05:18:19 INFO - PROCESS | 11060 | |9;json-stringify-tinderbox;62;62;64;63;62;61;61;63;62;63 05:18:19 INFO - PROCESS | 11060 | |10;stanford-crypto-aes;76;79;88;81;75;75;77;78;79;78 05:18:19 INFO - PROCESS | 11060 | |11;stanford-crypto-ccm;124;131;120;121;147;123;128;126;165;125 05:18:19 INFO - PROCESS | 11060 | |12;stanford-crypto-pbkdf2;160;159;159;163;157;159;164;159;161;157 05:18:19 INFO - PROCESS | 11060 | |13;stanford-crypto-sha256-iterative;64;66;64;65;63;62;63;66;63;61 05:18:19 INFO - PROCESS | 11060 | __end_tp_report 05:18:19 INFO - PROCESS | 11060 | __start_cc_report 05:18:19 INFO - PROCESS | 11060 | _x_x_mozilla_cycle_collect,899 05:18:19 INFO - PROCESS | 11060 | __end_cc_report 05:18:19 INFO - PROCESS | 11060 | __startTimestamp1468239499696__endTimestamp 05:18:19 INFO - PROCESS | 11060 | 05:18:19 INFO - PROCESS | 11060 | ------- Summary: start ------- 05:18:19 INFO - PROCESS | 11060 | Number of tests: 14 05:18:19 INFO - PROCESS | 11060 | 05:18:19 INFO - PROCESS | 11060 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.50 stddev:3.56 (3.2%) stddev-sans-first:2.73 05:18:19 INFO - PROCESS | 11060 | Values: 103.0 111.0 105.0 109.0 112.0 111.0 112.0 110.0 115.0 112.0 05:18:19 INFO - PROCESS | 11060 | 05:18:19 INFO - PROCESS | 11060 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:151.00 stddev:25.11 (16.6%) stddev-sans-first:26.51 05:18:19 INFO - PROCESS | 11060 | Values: 152.0 119.0 150.0 188.0 121.0 148.0 153.0 120.0 180.0 121.0 05:18:19 INFO - PROCESS | 11060 | 05:18:19 INFO - PROCESS | 11060 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:4.67 (2.8%) stddev-sans-first:4.72 05:18:19 INFO - PROCESS | 11060 | Values: 161.0 164.0 161.0 164.0 169.0 167.0 176.0 163.0 164.0 161.0 05:18:19 INFO - PROCESS | 11060 | 05:18:19 INFO - PROCESS | 11060 | [#3] audio-fft Cycles:10 Average:93.30 Median:75.50 stddev:37.32 (49.4%) stddev-sans-first:39.05 05:18:19 INFO - PROCESS | 11060 | Values: 76.0 75.0 75.0 160.0 77.0 75.0 76.0 75.0 168.0 76.0 05:18:19 INFO - PROCESS | 11060 | 05:18:19 INFO - PROCESS | 11060 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:84.50 stddev:31.33 (37.1%) stddev-sans-first:32.29 05:18:19 INFO - PROCESS | 11060 | Values: 83.0 87.0 163.0 87.0 84.0 85.0 141.0 84.0 85.0 142.0 05:18:19 INFO - PROCESS | 11060 | 05:18:19 INFO - PROCESS | 11060 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:18:19 INFO - PROCESS | 11060 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 117.0 119.0 118.0 118.0 05:18:19 INFO - PROCESS | 11060 | 05:18:19 INFO - PROCESS | 11060 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:18:19 INFO - PROCESS | 11060 | Values: 147.0 148.0 147.0 148.0 147.0 147.0 147.0 148.0 147.0 148.0 05:18:19 INFO - PROCESS | 11060 | 05:18:19 INFO - PROCESS | 11060 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 05:18:19 INFO - PROCESS | 11060 | Values: 96.0 96.0 96.0 96.0 96.0 97.0 95.0 96.0 96.0 96.0 05:18:19 INFO - PROCESS | 11060 | 05:18:19 INFO - PROCESS | 11060 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:0.79 (1.4%) stddev-sans-first:0.78 05:18:19 INFO - PROCESS | 11060 | Values: 54.0 56.0 55.0 54.0 55.0 56.0 55.0 54.0 55.0 54.0 05:18:19 INFO - PROCESS | 11060 | 05:18:19 INFO - PROCESS | 11060 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.50 stddev:0.95 (1.5%) stddev-sans-first:1.00 05:18:19 INFO - PROCESS | 11060 | Values: 62.0 62.0 64.0 63.0 62.0 61.0 61.0 63.0 62.0 63.0 05:18:19 INFO - PROCESS | 11060 | 05:18:19 INFO - PROCESS | 11060 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:78.50 stddev:3.81 (4.8%) stddev-sans-first:3.92 05:18:19 INFO - PROCESS | 11060 | Values: 76.0 79.0 88.0 81.0 75.0 75.0 77.0 78.0 79.0 78.0 05:18:19 INFO - PROCESS | 11060 | 05:18:19 INFO - PROCESS | 11060 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:127.00 stddev:14.20 (11.2%) stddev-sans-first:14.84 05:18:19 INFO - PROCESS | 11060 | Values: 124.0 131.0 120.0 121.0 147.0 123.0 128.0 126.0 165.0 125.0 05:18:19 INFO - PROCESS | 11060 | 05:18:19 INFO - PROCESS | 11060 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:159.50 stddev:2.30 (1.4%) stddev-sans-first:2.44 05:18:19 INFO - PROCESS | 11060 | Values: 160.0 159.0 159.0 163.0 157.0 159.0 164.0 159.0 161.0 157.0 05:18:19 INFO - PROCESS | 11060 | 05:18:19 INFO - PROCESS | 11060 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.64 (2.6%) stddev-sans-first:1.73 05:18:19 INFO - PROCESS | 11060 | Values: 64.0 66.0 64.0 65.0 63.0 62.0 63.0 66.0 63.0 61.0 05:18:19 INFO - PROCESS | 11060 | -------- Summary: end -------- 05:18:19 INFO - PROCESS | 11060 | 05:18:20 INFO - TEST-INFO | 11060: exit 0 05:18:20 INFO - TEST-OK | kraken | took 60948ms 05:18:20 INFO - SUITE-END | took 1171s 05:18:20 INFO - Completed test suite (00:19:31) 05:18:20 INFO - javascript benchmark 05:18:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7461.65373366253, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3100.1784527100317, 3134.1537784798106, 3152.464081106212, 3158.857851396687, 3169.6671849455806, 5506.559475241981, 5549.58378121641, 5561.833145005651, 5658.660480371171, 5661.0376236039865, 5467.726613669311, 5581.49766521013, 5604.41153678864, 5627.634203776752, 5640.5487560995125, 5016.046951079302, 5072.163093089635, 5184.429712731597, 5217.530422261995, 5218.1650935850275, 616.7115851099269, 5056.064628043805, 5072.0870243356185, 5193.091209038422, 5202.843914682547, 5067.138586440314, 5069.771860266297, 5097.2608971699265, 5120.02719483297, 5161.329027226455, 5099.0, 5100.336956195671, 5105.489451054902, 5138.922916156261, 5145.511176438233, 4953.2074868020945, 4998.925016124761, 5050.974745126251, 5078.593712503028, 5084.161113416282, 5551.361593416728, 5551.3893471718075, 5590.049691552445, 5603.60774745768, 5605.271314729059, 5962.582619216657, 5990.490808281302, 5996.5202783777195, 6003.369646187175, 6006.0, 5889.057750759858, 5996.2504686914135, 6001.4298641628975, 6045.425684559959, 6062.757489700407, 5621.409751976065, 5626.746796394172, 5639.2668953035845, 5653.519450846683, 5654.095344744862, 5990.251218597676, 6176.969115154396, 6186.566940314225, 6195.411435913581, 6202.658853762996, 5876.794312199053, 5925.081612350093, 5929.762809487572, 5972.044472884318, 5975.103734439869, 5989.940100599026, 6024.006039003603, 6036.698165091816, 6049.637021778707, 6062.969685151635, 5690.971545142248, 5891.057430811135, 5972.163897054415, 6029.125776762345, 6034.849128771728, 5904.5571582131515, 5987.970060149672, 6001.729922153426, 6009.819705408845, 6066.0, 4507.977460112678, 4521.638268938477, 4527.162474942146, 4541.6593755468475, 4573.451185857718, 3977.54258260298, 3991.1818077294665, 4018.537868145142, 4027.597240275949, 4093.2018256440306, 5573.052581061229, 5607.943920560824, 5681.857953551194, 5776.393478684761, 5804.984127777622, 6046.455818976313, 6054.122152287893, 6059.818205453844, 6078.787242446493, 6088.178095956989, 5594.384617692051, 5601.439856014447, 5697.658140511582, 5744.339400968858, 5765.1640512125505, 5148.871278218, 5151.716655583904, 5171.948280517222, 5203.297554830126, 5222.242774797709, 6201.0, 6241.34465881085, 6241.563090583615, 6242.1261023456755, 6253.37466253371, 5851.356350801323, 5921.111833225051, 5976.462118409364, 6031.457168854824, 6032.39676032402, 6185.0, 6187.597806142587, 6194.938050619617, 6206.596571222856, 6211.192544969306, 5881.117832325185, 5891.410858914074, 5912.46787789101, 5940.435658612425, 5940.821775346746, 5911.645301281937, 6006.309274433496, 6023.427774361428, 6048.939510604838, 6066.423689749467, 5880.8235752927485, 5925.318588362221, 5925.585209035326, 5939.851503712442, 5943.197668314722, 5847.853803654943, 5891.617044892068, 5892.499137573354, 5895.115732639967, 5917.467427931507, 5779.971100144472, 5809.0415081512765, 5905.379935106752, 5931.673757943182, 5960.731767070405, 5829.446202610745, 5981.581289309706, 5997.490213331741, 5998.98017337045, 6015.368386319548, 5682.176084467812, 5854.824355269348, 5872.618279811799, 5880.588358814842, 5887.264091988502], "value": 5498.6735335895055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.7035546517635, 570.1618620627676, 582.877595704902, 604.4348534120597, 611.4619135161057, 39049.414258786106, 43730.562694373046, 44114.55885441144, 44262.11475770487, 44352.556474435245, 44515.0, 44861.0, 45122.32316515255, 45338.31992520115, 45357.0, 8897.377183597151, 9019.503927283997, 9028.413153145057, 9031.232345250628, 9046.683366082189, 9002.549872506348, 9107.316951228684, 9122.817543649124, 9124.270058395346, 9134.17792398684, 9003.279737621007, 9046.954765226164, 9083.727488175333, 9101.726948191565, 9126.996030436647, 9006.729798106067, 9029.367944243906, 9080.77298067547, 9082.500462474562, 9129.497877616728, 8894.11058894112, 8922.955385223097, 8974.28205743539, 8999.460032398078, 9017.909820901772, 42160.0, 42174.0, 42207.0, 42529.149417011795, 42655.786721066506, 3280.934381312384, 3327.5674162358982, 3975.8012099394914, 4079.3269110596716, 4171.10321280923, 32834.34331313384, 33273.833630831934, 33305.6669433305, 33397.83301083479, 35251.82374088139, 4330.891727706801, 4396.252637051709, 4400.4939431965095, 4461.330800379937, 4512.368268442421, 379976.0, 380581.0, 381315.0, 381655.0, 382590.0, 60484.395156048755, 61679.38320616737, 61681.38318616846, 61749.382506175265, 61807.690961545806, 35521.0, 35954.28091438157, 36351.81824090863, 38357.232855342736, 63065.684671576346, 16903.0, 17013.659726805396, 17015.91492042532, 17084.231209595597, 17202.0, 12420.75158496825, 12448.62654120378, 12492.750144997231, 12501.24992500453, 12510.874891251153, 19858.304959326353, 19945.800541994686, 19981.20075197005, 20041.799582003994, 20122.19511219564, 7093.574385536885, 7374.926250737424, 7379.963100184572, 7400.925990740131, 7429.62851857405, 925.643627203518, 1039.542601255445, 1060.6977011551671, 1108.844761733358, 1111.921436206878, 34261.82869085639, 34480.48279275813, 34569.48145777815, 34758.65241347605, 34804.65195348014, 1091.170710260208, 1091.8143915534379, 1098.549594666183, 1114.6656003199007, 1123.9550417983353, 17688.380906668204, 18059.819401805813, 18090.547736306697, 18203.45389638313, 18283.08584570766, 609009.0, 613761.0, 615270.0, 615617.0, 620579.0, 59911.70044149838, 60130.0, 60321.396786032456, 60594.69702651459, 60678.696606517566, 1306.5296493262417, 1307.5096838685492, 1334.7864341705085, 1336.8395792504962, 1351.5472316773992, 32541.511877321387, 33617.83191084029, 33699.32601348008, 33726.66273337235, 34048.65951340554, 52576.474235257156, 53029.204561932376, 53051.0, 53088.73455632697, 53163.0, 350648.0, 356235.0, 357462.0, 357769.0, 359036.0, 28588.42823143567, 29178.270543236587, 29189.41621167607, 29225.123246302646, 29346.853265733534, 48726.756366217945, 49955.0, 50105.24842127298, 50557.49442505528, 50785.0, 42925.57074429341, 43005.35491967561, 43374.34938475862, 43466.348004780586, 44490.55509444864, 42596.57403425926, 42876.0, 42938.78530607327, 42991.57008429876, 43587.0, 36120.0, 41467.58532414637, 44714.776426118966, 44895.55104448914, 45253.0, 43488.34767478427, 45748.0, 45998.0, 46024.539754603364, 46291.305630416246, 35533.0, 35970.4604430939, 36316.27367452689, 36699.63300367069, 36724.265514690094], "value": 20642.159151833952, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.59827181459445, 387.9883603491895, 388.0084165009747, 389.8830350894732, 405.14110086616375, 18837.246510139594, 20386.592268154647, 20539.589208215828, 20776.0, 20829.583408331862, 19706.901465492654, 20077.698834517494, 20329.59340813183, 20339.796602033974, 20476.59046819063, 5526.0, 5799.072148456248, 5804.82585522435, 5881.500072493843, 5916.704164791765, 5812.070068788995, 5857.76568937242, 6123.418275263865, 6510.414062734353, 6517.837054073662, 6265.06024096387, 6440.066190402389, 6519.739210431577, 6618.635975021371, 6642.269350371479, 5995.070764031582, 6025.0661147522205, 6035.909461358083, 6037.607555508878, 6037.637741735488, 5701.914471282934, 5806.158107074492, 5857.619254748428, 5947.375525569796, 5979.940200597982, 23203.419914502105, 23354.64968025481, 23986.28041158768, 24302.513949721084, 24322.391940201458, 2286.0969916882736, 2287.7369102553253, 2318.7913087822176, 2342.6486027095903, 2815.338395477061, 10140.847887281696, 10337.173026157889, 10691.411972341519, 10798.136149108053, 10840.241183117185, 1937.680282753344, 1942.2328180368675, 1997.980020199794, 2013.1041686449537, 2014.9597008059902, 71108.28891711068, 79609.60195198987, 84949.0, 85169.57415212947, 94209.5289523548, 11153.94423027896, 11266.66200014001, 11353.53717116271, 11458.312501249951, 11464.656060318204, 15707.921460392625, 15744.291506882219, 15781.526554203392, 15801.288941997638, 15802.683946321009, 7652.579108148994, 7788.727394541163, 7920.0, 8085.574327701666, 8108.0, 7545.207753185946, 7590.620468976529, 7657.846843063107, 7783.455158138876, 7792.454528182972, 4735.289706543977, 4788.7366194859615, 4863.70817750929, 4916.164252077156, 4955.529224723646, 1946.8150525700037, 1998.4012789768128, 2030.1067530286628, 2049.3954283486405, 2105.957221495147, 929.9023602521773, 952.5046975572802, 1042.442293373057, 1047.61238341814, 1058.7247315697973, 20131.597368052557, 20582.0, 20837.270695525585, 21240.681389779165, 21338.78661213399, 982.2044144243185, 999.1557134221571, 1025.7948410317965, 1043.4834756795435, 1068.9144868410508, 11101.612298462693, 11463.484143213574, 11592.710182245342, 11615.477303521193, 11723.35521546323, 459901.10148347804, 462883.0, 463371.0, 478160.0, 494501.0, 98465.50767246119, 101422.49288753509, 103899.480502597, 106053.0, 110061.0, 1034.8551202831609, 1061.7611037516497, 1064.7923654887222, 1098.7363032872213, 1111.7220694826294, 18757.90621046886, 19283.325083622567, 19663.70504442463, 19775.208991640175, 19826.801731982494, 46810.765946171414, 47319.29021064756, 47826.760866195444, 47984.760076199396, 48903.75548122237, 65324.0, 65921.34078659344, 66211.33788662052, 66586.6670666663, 67692.661536692, 8841.778955526162, 8912.643494260416, 9011.098890110936, 9067.637294508146, 9100.59047342858, 10166.644167454104, 14754.827712041963, 14932.477363292233, 14933.17867517297, 15098.018628789094, 12219.755604887674, 12681.873181268069, 12869.163504372185, 12898.613041608767, 13159.736805264032, 12579.182353147016, 12739.108262421541, 12858.485660573846, 13018.349082546025, 13025.413856376295, 12951.870481295067, 13113.737725245632, 13228.0, 13241.668958275735, 13332.800007999695, 8923.286137108886, 8947.776305592412, 8981.775455613662, 9109.316801240066, 9192.678256260999, 9416.0, 12796.168249063781, 12974.0, 13130.540431084866, 13221.405036773176], "value": 9703.809496754251, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.0598017268942, 1499.6850661361113, 1630.4456484795176, 1768.5578605348662, 1778.4575704410158, 7833.804154896116, 8525.957370213147, 8530.957345213264, 9148.8627670585, 9181.357304988645, 8665.176808203227, 8991.640334386617, 8992.145746154121, 9016.413933094344, 9066.048064953184, 2353.8587684738927, 2393.4375421775867, 2400.039984006403, 2400.627902675088, 2401.771831675988, 2365.8698771567642, 2368.4789346343778, 2372.632242002492, 2377.3818807110188, 2389.7371289158264, 2322.071171531384, 2322.698049253603, 2344.19125401737, 2366.1954935321987, 2369.9407514812183, 2319.188284100568, 2329.0683726509365, 2333.1717240379676, 2341.086976079339, 2350.670906073151, 2299.586074506588, 2303.7045521321556, 2317.4322291038634, 2317.4438134847683, 2319.22306027481, 9138.0, 9165.129312715282, 9166.404183728037, 9177.0, 9223.308251881135, 5284.497972692588, 5447.128459446509, 5466.34403871534, 5468.644538105011, 5478.123500239983, 3336.1326055225572, 3344.5819272590925, 3371.9157021074425, 3398.8300584970652, 3450.1374656335915, 1102.3055475050667, 1121.3272036777948, 1123.9494222759995, 1135.2961164078242, 1142.2917790969568, 12558.68603284916, 12703.301318427482, 12711.046671499582, 12736.554220602327, 12743.681407964783, 4503.279475283939, 4640.69835460694, 4785.712857228577, 4821.879453013633, 4828.66199366048, 10650.414227217578, 10652.414117223627, 10660.573577056986, 10702.0, 10727.678169654922, 5439.3200849893765, 5465.289512363447, 5486.615936884459, 5490.780368785284, 5500.889982200413, 4396.208682437192, 4658.394408726912, 4810.230363141881, 4828.130936431406, 5033.219850923113, 4089.161721847014, 4116.259073366763, 4131.588397238941, 4133.23535145999, 4149.605787450188, 1305.3668970549277, 1320.19468124444, 1321.1808678619318, 1329.6941703408077, 1342.6777573382317, 928.7724507495707, 942.4062840410497, 967.0426277984885, 968.2544440780559, 991.8561808537721, 5995.910061349084, 6095.969520152371, 6144.5084393248435, 6200.410960958701, 6217.658028808369, 412.5400178800676, 426.5819496893062, 427.52331150766673, 446.84360473833897, 447.8701176658798, 4129.587041295847, 4185.267578173868, 4204.3693445983345, 4213.410122582841, 4233.7671428071135, 10844.295120817122, 11291.604793832177, 11339.886601134049, 11395.430228488542, 11406.486708098155, 10912.61805836792, 11225.887741122648, 11236.269642473377, 11304.773904522028, 11372.147088968195, 8086.070101938352, 8087.797805054921, 8198.631061602242, 8203.466774659628, 8204.794880127925, 6023.849403764766, 6069.2110025696375, 6170.660613666291, 6225.408586184305, 6260.029695397221, 10169.135623472088, 10419.635312764018, 10597.41714205726, 10600.734981625521, 10627.415492148006, 10573.62992295266, 10609.310394824312, 10695.197860160675, 10752.40861752611, 10832.295900766425, 7088.0785497884945, 7400.629968501661, 7551.546907185587, 7936.206379362248, 8006.159353267823, 8576.185262400062, 8593.44142630727, 8601.82796344082, 8627.568621569022, 8658.134186581292, 7290.416766658761, 7433.145188303414, 7508.136564295176, 7521.5111017783665, 7654.540727556365, 7481.476296659399, 7532.43506736986, 7541.095068591804, 7567.31894129531, 7643.503172293783, 6916.3429474199875, 6926.480513961574, 6977.511574189758, 6984.231734509099, 6988.021676965127, 4914.852554423373, 5033.899322013613, 5145.948540514547, 5153.4073581538605, 5158.613104017289, 5083.771230294719, 5098.694078355311, 5111.182210846247, 5155.149400348901, 5195.350581177353], "value": 4611.514395541865, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.41139126789255, 324.6023621064196, 326.5330428611838, 327.6575978102883, 335.6693656748104, 5532.5573954083675, 5612.5229355504725, 5709.286339207594, 5804.303483581971, 5852.561057920657, 5656.321241451032, 5692.0608099663505, 5695.686737229451, 5703.857403564903, 5728.682403047302, 4335.783210839461, 4344.78276086196, 4411.691181617288, 4425.8229670813125, 4434.024514606781, 4178.268802959486, 4416.668749843759, 4416.911661766779, 4421.872422532266, 4438.711483753562, 4340.112051257697, 4364.0, 4367.388565600819, 4376.693631445784, 4381.0, 4328.264195086827, 4348.282533381972, 4353.325234588644, 4387.692861499696, 4391.934120988188, 3800.2969450651717, 3851.5185601799776, 3866.1881004988986, 3881.4177873318945, 3884.553276373225, 5503.889922201533, 5503.9174412383845, 5561.499465048165, 5572.721363931787, 5574.386817450078, 4967.155583550805, 4984.202527595604, 5000.924986125211, 5016.548510634024, 5030.471800460972, 5601.439856014366, 5865.237519122529, 5911.645301281894, 5936.970315148396, 5949.553783466257, 4141.482314710661, 4142.606452387018, 4156.833726650931, 4182.749035057906, 4195.286801243796, 6189.288231853305, 6193.81418557444, 6213.192285002966, 6215.72029258689, 6217.813465595994, 4151.13199060424, 4192.748435093904, 4202.663786897041, 4218.6625069994325, 4315.784210789448, 4251.659867210616, 4258.382534532476, 4289.335153051282, 4292.484901811803, 4293.785310734514, 4958.9008219835405, 4959.380077490314, 4966.279889416014, 4975.129352363322, 4980.800767969313, 5775.249217601685, 5954.523638108941, 5981.312149102821, 5994.610350327215, 6030.819075427744, 1477.726620575197, 1490.7093116842111, 1495.8803295736532, 1499.71505413971, 1500.9118389167766, 926.5597732290638, 939.8731171291925, 947.554649314821, 953.547065144051, 960.5293406230896, 5071.771770270347, 5079.0, 5082.720450375191, 5099.59203263738, 5148.304978827885, 5318.521333079964, 5390.757415916293, 5415.268938693226, 5444.482774136451, 5447.945520544823, 4892.578173803919, 5065.940551827459, 5125.231215317657, 5203.479652034842, 5241.397239317527, 2861.5549147680704, 2883.3656595549364, 2895.478813813492, 2911.5778212159544, 2913.577531257956, 5492.011437941129, 5524.281843360418, 5524.58565607581, 5536.640118392292, 5594.552435805207, 5483.670979741229, 5789.421057894261, 6175.517875709887, 6235.906461403082, 6309.968450157719, 6280.403361680633, 6286.371362863769, 6332.461740751995, 6361.236651601837, 6414.61512309263, 6046.818595442144, 6115.908261376172, 6135.969320153371, 6162.582606000556, 6181.258249010148, 6044.335123136363, 6047.909281360695, 6058.395254823373, 6071.0, 6076.513878889767, 6046.395360464095, 6290.402411770874, 6332.2717887441695, 6405.583637063576, 6419.293877673359, 4373.737575745466, 4443.977780111208, 4446.844360447369, 4455.086707225076, 4474.127545128799, 6190.628562286277, 6191.752329906753, 6204.81385558434, 6217.507798128326, 6231.813045608639, 5889.882202356014, 5924.259467566554, 5930.679208246347, 5955.553333500092, 5969.970150149222, 5964.493018093511, 5985.25184351956, 6018.729157188025, 6033.818985430444, 6035.736598775459, 5733.541316694738, 5869.618474799125, 5941.851453713692, 5960.3443621202505, 6068.21113255274, 5978.163057172086, 5982.341942386421, 5994.3705910878725, 5999.88000239984, 6041.945738448949, 5841.50347220474, 5844.996177618345, 5911.940880591139, 5926.0, 5945.613535120204], "value": 4435.6162238593915, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.7735485967062, 714.6033951157106, 722.4653756220397, 770.148985371165, 771.6604693934672, 17244.22400991955, 17919.910400447978, 17927.910360448197, 17938.372156974525, 17949.551261218476, 16357.0, 16370.590735231624, 16390.754138687927, 16425.507234782945, 16542.669146617092, 780.5745868501651, 803.2248879830962, 803.6222975201661, 829.9170082991683, 833.3166803221361, 823.9958800205991, 831.6673330667751, 836.4270474724833, 838.0655569040506, 839.7942504086508, 854.3549620036895, 858.5535521528833, 862.905080441151, 869.3783944479695, 869.482657818597, 866.0343716755835, 866.5320726807579, 866.5927014303298, 866.9046404895456, 867.7179916527153, 634.536788144657, 635.3202073781056, 635.9586626869238, 636.0173531893236, 636.4208570201095, 15881.444149454714, 15886.36454541817, 15908.840911590853, 15917.204139792964, 15940.521784346489, 14614.853851461456, 14697.485588004476, 14714.117152970855, 14733.0, 14778.778318325127, 12153.331566763825, 12198.0, 12372.0, 12425.565105221274, 12978.091533592653, 3813.903839343159, 3922.4312474691296, 3978.423128646359, 3981.6416522513114, 4034.677225821927, 81440.59279703622, 87786.5610671949, 88736.0, 88754.11245887588, 88932.55533722354, 11649.76700465986, 11893.167478276437, 12003.459844307026, 12197.51209951592, 12424.75150496985, 22209.888950555145, 22349.32952011442, 22408.103675853108, 22449.88775056114, 22507.88746056292, 8567.443116197428, 8869.600867960957, 8953.33174867278, 9031.051739567381, 9076.773080673036, 4876.414830220397, 5002.724850133205, 5005.424376196711, 5005.499450055038, 5046.293518907356, 3589.0489020409614, 3690.501782259414, 3696.667299943018, 3698.852045918187, 3709.536307961505, 631.905214217871, 653.5098675993005, 656.2846497317851, 659.9142111525471, 676.6684324680871, 638.6327861479575, 654.7741029344868, 711.526834654959, 754.8075240813557, 756.5233902641301, 9648.95175524132, 9737.610495580097, 9889.703308900744, 9891.802163956681, 10032.448215348226, 609.6159419565645, 707.5577316355891, 725.8676464715062, 745.3962290544677, 776.3090849144266, 4481.5070342262325, 4488.079943611552, 4600.976995115003, 4606.760557780783, 4615.976920115378, 70484.64757676178, 78712.60643696744, 120238.0, 126402.0, 127218.0, 109565.0, 109565.0, 110566.44716776365, 111473.0, 113379.43310283395, 94531.0, 96701.0, 96929.5153524228, 97529.0, 98387.0, 8461.703840365557, 8528.616212270339, 8600.526971016403, 8716.520591367282, 8769.693060742844, 53772.73113634407, 54653.1802022962, 55412.72293638506, 55452.16821747596, 56101.719491402284, 69725.30274697188, 76297.23702763123, 76891.61554192193, 77399.0, 79369.0, 11872.228305160137, 11990.640280791591, 12044.036477081638, 12397.566085186974, 12430.316332601793, 13384.732305353644, 13443.865561344652, 13711.794323084961, 13740.0, 14401.855981440052, 12601.495940162291, 12624.242545447303, 12676.182157462052, 12766.553170638983, 13127.540536081191, 12870.356482175666, 13065.869341306465, 13178.275194864374, 13248.403821827847, 13438.636827359049, 11118.888811111785, 11507.769844602893, 11927.761444770882, 12134.635960921187, 12139.332336721565, 10080.798384032425, 10178.829434615114, 10274.845877311696, 10420.635277765241, 10942.890571094187, 10402.531886064993, 10844.18668599874, 10958.28771129874, 11003.669889903316, 11073.778524429628], "value": 7659.72834115884, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 105.0, 109.0, 112.0, 111.0, 112.0, 110.0, 115.0, 112.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 119.0, 150.0, 188.0, 121.0, 148.0, 153.0, 120.0, 180.0, 121.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 161.0, 164.0, 169.0, 167.0, 176.0, 163.0, 164.0, 161.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 160.0, 77.0, 75.0, 76.0, 75.0, 168.0, 76.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 163.0, 87.0, 84.0, 85.0, 141.0, 84.0, 85.0, 142.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 55.0, 54.0, 55.0, 56.0, 55.0, 54.0, 55.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 64.0, 63.0, 62.0, 61.0, 61.0, 63.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 88.0, 81.0, 75.0, 75.0, 77.0, 78.0, 79.0, 78.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 131.0, 120.0, 121.0, 147.0, 123.0, 128.0, 126.0, 165.0, 125.0], "value": 131.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 159.0, 163.0, 157.0, 159.0, 164.0, 159.0, 161.0, 157.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 65.0, 63.0, 62.0, 63.0, 66.0, 63.0, 61.0], "value": 63.7, "unit": "score"}]}]} 05:18:20 INFO - Return code: 0 05:18:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:18:21 ERROR - # TBPL SUCCESS # 05:18:21 INFO - Running post-action listener: _resource_record_post_action 05:18:21 INFO - ##### 05:18:21 INFO - ##### Finished run-tests step (success) 05:18:21 INFO - ##### 05:18:21 INFO - Running post-run listener: _resource_record_post_run 05:18:21 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 562286592; Read time: 8; Write time: 512272 05:18:21 INFO - TinderboxPrint: CPU usage
13.4% 05:18:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:18:21 INFO - TinderboxPrint: I/O write bytes / time
562,286,592 / 512,272 05:18:21 INFO - TinderboxPrint: CPU idle
8,219.9 (86.6%) 05:18:21 INFO - TinderboxPrint: CPU user
1,213.5 (12.8%) 05:18:21 INFO - TinderboxPrint: Swap in / out
0 / 0 05:18:21 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 264994816; Read time: 0; Write time: 235140 05:18:21 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 294084608; Read time: 0; Write time: 276508 05:18:21 INFO - Running post-run listener: _upload_blobber_files 05:18:21 INFO - Blob upload gear active. 05:18:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:18:21 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 05:18:21 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:18:21 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:18:22 INFO - (blobuploader) - INFO - Open directory for files ... 05:18:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:18:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:18:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:22 INFO - (blobuploader) - INFO - Done attempting. 05:18:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:18:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:18:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:27 INFO - (blobuploader) - INFO - Done attempting. 05:18:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:18:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:18:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:27 INFO - (blobuploader) - INFO - Done attempting. 05:18:27 INFO - (blobuploader) - INFO - Iteration through files over. 05:18:27 INFO - Return code: 0 05:18:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:18:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:18:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5df7bcf8a773da32d79310356674d461a19097bb581d5113a59d768a04d960a27ddbc0b266f228bfd904f5b937b70cad8997b67650c0f8f6744eaa96095e4dd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/70e565e731163c458b6b6de2bd36e445780899eb4a36d813d2daad367f1aa95deb9ae3a090b61c1d1e1a867d6c77a93316ee5ed9587a687f5f49eea5e2fe5eee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a8ee9427ef6f68c9937deb70ce50a8f0d5061e27f762ca4720792c6d2973debda050292d462e59c26d4632f541b4cf5b2f41338a10ef5a08fb142eae023f4684"} 05:18:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:18:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:18:27 INFO - Contents: 05:18:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5df7bcf8a773da32d79310356674d461a19097bb581d5113a59d768a04d960a27ddbc0b266f228bfd904f5b937b70cad8997b67650c0f8f6744eaa96095e4dd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/70e565e731163c458b6b6de2bd36e445780899eb4a36d813d2daad367f1aa95deb9ae3a090b61c1d1e1a867d6c77a93316ee5ed9587a687f5f49eea5e2fe5eee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a8ee9427ef6f68c9937deb70ce50a8f0d5061e27f762ca4720792c6d2973debda050292d462e59c26d4632f541b4cf5b2f41338a10ef5a08fb142eae023f4684"} 05:18:27 INFO - Running post-run listener: copy_logs_to_upload_dir 05:18:27 INFO - Copying logs to upload dir... 05:18:27 INFO - mkdir: /builds/slave/test/build/upload/logs 05:18:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.304665 ========= master_lag: 1.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-11 05:18:28.629155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 05:18:28.633725) ========= 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=6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285 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/Mozilla-Inbound/sha512/5df7bcf8a773da32d79310356674d461a19097bb581d5113a59d768a04d960a27ddbc0b266f228bfd904f5b937b70cad8997b67650c0f8f6744eaa96095e4dd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/70e565e731163c458b6b6de2bd36e445780899eb4a36d813d2daad367f1aa95deb9ae3a090b61c1d1e1a867d6c77a93316ee5ed9587a687f5f49eea5e2fe5eee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a8ee9427ef6f68c9937deb70ce50a8f0d5061e27f762ca4720792c6d2973debda050292d462e59c26d4632f541b4cf5b2f41338a10ef5a08fb142eae023f4684"} build_url:https://queue.taskcluster.net/v1/task/TuqzabmBS5aoEmH40tNn3Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/TuqzabmBS5aoEmH40tNn3Q/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/Mozilla-Inbound/sha512/5df7bcf8a773da32d79310356674d461a19097bb581d5113a59d768a04d960a27ddbc0b266f228bfd904f5b937b70cad8997b67650c0f8f6744eaa96095e4dd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/70e565e731163c458b6b6de2bd36e445780899eb4a36d813d2daad367f1aa95deb9ae3a090b61c1d1e1a867d6c77a93316ee5ed9587a687f5f49eea5e2fe5eee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a8ee9427ef6f68c9937deb70ce50a8f0d5061e27f762ca4720792c6d2973debda050292d462e59c26d4632f541b4cf5b2f41338a10ef5a08fb142eae023f4684"}' ========= master_lag: 0.29 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 05:18:28.935425) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:18:28.935763) ========= 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=6dbc10da6d83fee962c624be000001a8-1468238276.537297-1374721285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:18:28.952126) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 05:18:28.952419) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 05:18:28.952682) ========= ========= Total master_lag: 1.53 =========