builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1467942254.08 results: success (0) buildid: 20160707172726 builduid: 19a713d0a57246398ef269edd187de7f revision: 23dc78b7b57e9f91798ea44c242a04e112c37db0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 18:44:14.079155) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 18:44:14.079669) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 18:44:14.079951) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 18:44:14.232470) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:44:14.232763) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 18:44:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 44.8M=0s 2016-07-07 18:44:14 (44.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102581 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:44:14.351379) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:44:14.354736) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019241 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:44:14.404383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 18:44:14.405838) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 23dc78b7b57e9f91798ea44c242a04e112c37db0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 23dc78b7b57e9f91798ea44c242a04e112c37db0 --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=97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 18:44:15,066 truncating revision to first 12 chars 2016-07-07 18:44:15,066 Setting DEBUG logging. 2016-07-07 18:44:15,066 attempt 1/10 2016-07-07 18:44:15,066 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/23dc78b7b57e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 18:44:16,153 unpacking tar archive at: mozilla-central-23dc78b7b57e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.404063 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 18:44:15.834693) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 18:44:15.834998) ========= script_repo_revision: 23dc78b7b57e9f91798ea44c242a04e112c37db0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 18:44:15.835394) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 18:44:15.835676) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 18:44:15.845990) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-07 18:44:15.846342) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:44:16 INFO - MultiFileLogger online at 20160707 18:44:16 in /builds/slave/test 18:44:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:44:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:44:16 INFO - {'append_to_log': False, 18:44:16 INFO - 'base_work_dir': '/builds/slave/test', 18:44:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:44:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:44:16 INFO - 'branch': 'Firefox-Non-PGO', 18:44:16 INFO - 'buildbot_json_path': 'buildprops.json', 18:44:16 INFO - 'config_files': ('talos/linux_config.py',), 18:44:16 INFO - 'default_actions': ('clobber', 18:44:16 INFO - 'read-buildbot-config', 18:44:16 INFO - 'download-and-extract', 18:44:16 INFO - 'populate-webroot', 18:44:16 INFO - 'create-virtualenv', 18:44:16 INFO - 'install', 18:44:16 INFO - 'run-tests'), 18:44:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:44:16 INFO - 'download_minidump_stackwalk': True, 18:44:16 INFO - 'download_symbols': 'ondemand', 18:44:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:44:16 INFO - 'tooltool.py': '/tools/tooltool.py', 18:44:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:44:16 INFO - '/tools/misc-python/virtualenv.py')}, 18:44:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:44:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:44:16 INFO - 'installer_path': 'installer.exe', 18:44:16 INFO - 'log_level': 'info', 18:44:16 INFO - 'log_name': 'talos', 18:44:16 INFO - 'log_to_console': True, 18:44:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:44:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:44:16 INFO - 'opt_config_files': (), 18:44:16 INFO - 'pip_index': False, 18:44:16 INFO - 'sps_profile': False, 18:44:16 INFO - 'sps_profile_interval': 0, 18:44:16 INFO - 'suite': 'dromaeojs-e10s', 18:44:16 INFO - 'system_bits': '32', 18:44:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:44:16 INFO - 'title': 'talos-linux64-ix-068', 18:44:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:44:16 INFO - 'use_talos_json': True, 18:44:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:44:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:44:16 INFO - 'work_dir': 'build'} 18:44:16 INFO - ##### 18:44:16 INFO - ##### Running clobber step. 18:44:16 INFO - ##### 18:44:16 INFO - Running pre-action listener: _resource_record_pre_action 18:44:16 INFO - Running main action method: clobber 18:44:16 INFO - rmtree: /builds/slave/test/build 18:44:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:44:17 INFO - Running post-action listener: _resource_record_post_action 18:44:17 INFO - ##### 18:44:17 INFO - ##### Finished clobber step (success) 18:44:17 INFO - ##### 18:44:17 INFO - ##### 18:44:17 INFO - ##### Running read-buildbot-config step. 18:44:17 INFO - ##### 18:44:17 INFO - Running pre-action listener: _resource_record_pre_action 18:44:17 INFO - Running main action method: read_buildbot_config 18:44:17 INFO - Using buildbot properties: 18:44:17 INFO - { 18:44:17 INFO - "project": "", 18:44:17 INFO - "product": "firefox", 18:44:17 INFO - "script_repo_revision": "production", 18:44:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:44:17 INFO - "repository": "", 18:44:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:44:17 INFO - "buildid": "20160707172726", 18:44:17 INFO - "pgo_build": "False", 18:44:17 INFO - "basedir": "/builds/slave/test", 18:44:17 INFO - "buildnumber": 376, 18:44:17 INFO - "slavename": "talos-linux64-ix-068", 18:44:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:44:17 INFO - "platform": "ubuntu64_hw", 18:44:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:44:17 INFO - "branch": "mozilla-central", 18:44:17 INFO - "repo_path": "mozilla-central", 18:44:17 INFO - "revision": "23dc78b7b57e9f91798ea44c242a04e112c37db0", 18:44:17 INFO - "stage_platform": "linux64", 18:44:17 INFO - "builduid": "19a713d0a57246398ef269edd187de7f", 18:44:17 INFO - "slavebuilddir": "test" 18:44:17 INFO - } 18:44:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:44:17 INFO - Running post-action listener: _resource_record_post_action 18:44:17 INFO - ##### 18:44:17 INFO - ##### Finished read-buildbot-config step (success) 18:44:17 INFO - ##### 18:44:17 INFO - ##### 18:44:17 INFO - ##### Running download-and-extract step. 18:44:17 INFO - ##### 18:44:17 INFO - Running pre-action listener: _resource_record_pre_action 18:44:17 INFO - Running main action method: download_and_extract 18:44:17 INFO - mkdir: /builds/slave/test/build/tests 18:44: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')]} 18:44:17 INFO - https://queue.taskcluster.net/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:44:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:44:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:44:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/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 18:44:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/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 18:44:23 INFO - Downloaded 1361 bytes. 18:44:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:44:23 INFO - Using the following test package requirements: 18:44:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:44:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:44:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:44:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:23 INFO - u'jsshell-linux-x86_64.zip'], 18:44:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:44:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:44:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:44:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:44:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:44:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:44:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:23 INFO - https://queue.taskcluster.net/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:44:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:44:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:44:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/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 18:44:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/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 18:44:24 INFO - Downloaded 22734692 bytes. 18:44:24 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'] 18:44:24 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 18:44:25 INFO - Return code: 0 18:44:25 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 18:44:25 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')]} 18:44:25 INFO - https://queue.taskcluster.net/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:44:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:44:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:44:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/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 18:44:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/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 18:44:30 INFO - Downloaded 22734692 bytes. 18:44:30 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'] 18:44:30 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 18:44:31 INFO - Return code: 0 18:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:31 INFO - https://queue.taskcluster.net/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:44:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:44:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:44:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/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 18:44:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/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 18:44:33 INFO - Downloaded 14403333 bytes. 18:44:33 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'] 18:44:33 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 18:44:33 INFO - Return code: 0 18:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:33 INFO - https://queue.taskcluster.net/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:44:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:44:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:44:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/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 18:44:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/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 18:44:35 INFO - Downloaded 56646878 bytes. 18:44:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:44:35 INFO - mkdir: /builds/slave/test/properties 18:44:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:44:35 INFO - Writing to file /builds/slave/test/properties/build_url 18:44:35 INFO - Contents: 18:44:35 INFO - build_url:https://queue.taskcluster.net/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:44:35 INFO - Running post-action listener: _resource_record_post_action 18:44:35 INFO - Running post-action listener: set_extra_try_arguments 18:44:35 INFO - ##### 18:44:35 INFO - ##### Finished download-and-extract step (success) 18:44:35 INFO - ##### 18:44:35 INFO - ##### 18:44:35 INFO - ##### Running populate-webroot step. 18:44:35 INFO - ##### 18:44:35 INFO - Running pre-action listener: _resource_record_pre_action 18:44:35 INFO - Running main action method: populate_webroot 18:44:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:44:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:44:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:44:35 INFO - '--tppagecycles', 18:44:35 INFO - '7'], 18:44:35 INFO - 'tests': ['tsvgm']}}, 18:44:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:44:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:44:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:44:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:44:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:44:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:44:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:35 INFO - 'talos_options': ['--disable-e10s'], 18:44:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:35 INFO - 'talos_options': ['--disable-e10s'], 18:44:35 INFO - 'tests': ['damp', 'tps']}, 18:44:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:35 INFO - 'tests': ['damp', 'tps']}, 18:44:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:44:35 INFO - 'tests': ['dromaeo_dom']}, 18:44:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:44:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:44:35 INFO - 'tests': ['basic_compositor_video']}, 18:44:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:44:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:44:35 INFO - 'tests': ['a11yr', 18:44:35 INFO - 'ts_paint', 18:44:35 INFO - 'tpaint', 18:44:35 INFO - 'sessionrestore', 18:44:35 INFO - 'sessionrestore_no_auto_restore', 18:44:35 INFO - 'tabpaint']}, 18:44:35 INFO - 'other-e10s': {'tests': ['a11yr', 18:44:35 INFO - 'ts_paint', 18:44:35 INFO - 'tpaint', 18:44:35 INFO - 'sessionrestore', 18:44:35 INFO - 'sessionrestore_no_auto_restore', 18:44:35 INFO - 'tabpaint']}, 18:44:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:44:35 INFO - 'ts_paint', 18:44:35 INFO - 'tpaint', 18:44:35 INFO - 'sessionrestore', 18:44:35 INFO - 'sessionrestore_no_auto_restore', 18:44:35 INFO - 'tabpaint']}, 18:44:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:44:35 INFO - 'ts_paint', 18:44:35 INFO - 'tpaint', 18:44:35 INFO - 'sessionrestore', 18:44:35 INFO - 'sessionrestore_no_auto_restore', 18:44:35 INFO - 'tabpaint']}, 18:44:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:44:35 INFO - 'tests': ['a11yr', 18:44:35 INFO - 'ts_paint', 18:44:35 INFO - 'tpaint', 18:44:35 INFO - 'sessionrestore', 18:44:35 INFO - 'sessionrestore_no_auto_restore', 18:44:35 INFO - 'tabpaint']}, 18:44:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:44:35 INFO - 'tests': ['a11yr', 18:44:35 INFO - 'ts_paint', 18:44:35 INFO - 'tpaint', 18:44:35 INFO - 'sessionrestore', 18:44:35 INFO - 'sessionrestore_no_auto_restore', 18:44:35 INFO - 'tabpaint']}, 18:44:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:44:35 INFO - 'tests': ['tsvgx', 18:44:35 INFO - 'tsvgr_opacity', 18:44:35 INFO - 'tart', 18:44:35 INFO - 'tscrollx', 18:44:35 INFO - 'cart']}, 18:44:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:44:35 INFO - 'tsvgr_opacity', 18:44:35 INFO - 'tart', 18:44:35 INFO - 'tscrollx', 18:44:35 INFO - 'cart']}, 18:44:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:35 INFO - 'talos_options': ['--disable-e10s'], 18:44:35 INFO - 'tests': ['tp5o']}, 18:44:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:35 INFO - 'tests': ['tp5o']}, 18:44:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:35 INFO - 'talos_options': ['--disable-e10s', 18:44:35 INFO - '--xperf_path', 18:44:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:35 INFO - 'tests': ['tp5n']}, 18:44:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:35 INFO - 'talos_options': ['--xperf_path', 18:44:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:35 INFO - 'tests': ['tp5n']}}, 18:44:35 INFO - 'talos.zip': {'path': '', 18:44:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:44:35 INFO - Running post-action listener: _resource_record_post_action 18:44:35 INFO - ##### 18:44:35 INFO - ##### Finished populate-webroot step (success) 18:44:35 INFO - ##### 18:44:35 INFO - ##### 18:44:35 INFO - ##### Running create-virtualenv step. 18:44:35 INFO - ##### 18:44:35 INFO - Running pre-action listener: _resource_record_pre_action 18:44:35 INFO - Running main action method: create_virtualenv 18:44:35 INFO - Creating virtualenv /builds/slave/test/build/venv 18:44:35 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 18:44:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:44:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:44:36 INFO - Using real prefix '/usr' 18:44:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:44:36 INFO - Installing distribute.............................................................................................................................................................................................done. 18:44:38 INFO - Installing pip.................done. 18:44:38 INFO - Return code: 0 18:44:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b7570>, '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 0x28b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', '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 18:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:44:38 INFO - Using env: {'DISPLAY': ':0', 18:44:38 INFO - 'HOME': '/home/cltbld', 18:44:38 INFO - 'LANG': 'en_US.UTF-8', 18:44:38 INFO - 'LANGUAGE': 'en_US:en', 18:44:38 INFO - 'LOGNAME': 'cltbld', 18:44:38 INFO - 'MAIL': '/var/mail/cltbld', 18:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:38 INFO - 'MOZ_NO_REMOTE': '1', 18:44:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:38 INFO - 'NO_EM_RESTART': '1', 18:44:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:38 INFO - 'PWD': '/builds/slave/test', 18:44:38 INFO - 'SHELL': '/bin/bash', 18:44:38 INFO - 'SHLVL': '1', 18:44:38 INFO - 'TERM': 'linux', 18:44:38 INFO - 'TMOUT': '86400', 18:44:38 INFO - 'USER': 'cltbld', 18:44:38 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', 18:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:38 INFO - '_': '/tools/buildbot/bin/python'} 18:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:38 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 18:44:38 INFO - Cleaning up... 18:44:38 INFO - Return code: 0 18:44:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b7570>, '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 0x28b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', '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 18:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:44:38 INFO - Using env: {'DISPLAY': ':0', 18:44:38 INFO - 'HOME': '/home/cltbld', 18:44:38 INFO - 'LANG': 'en_US.UTF-8', 18:44:38 INFO - 'LANGUAGE': 'en_US:en', 18:44:38 INFO - 'LOGNAME': 'cltbld', 18:44:38 INFO - 'MAIL': '/var/mail/cltbld', 18:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:38 INFO - 'MOZ_NO_REMOTE': '1', 18:44:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:38 INFO - 'NO_EM_RESTART': '1', 18:44:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:38 INFO - 'PWD': '/builds/slave/test', 18:44:38 INFO - 'SHELL': '/bin/bash', 18:44:38 INFO - 'SHLVL': '1', 18:44:38 INFO - 'TERM': 'linux', 18:44:38 INFO - 'TMOUT': '86400', 18:44:38 INFO - 'USER': 'cltbld', 18:44:38 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', 18:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:38 INFO - '_': '/tools/buildbot/bin/python'} 18:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:38 INFO - Downloading/unpacking psutil>=3.1.1 18:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:44:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:40 INFO - Installing collected packages: psutil 18:44:40 INFO - Running setup.py install for psutil 18:44:41 INFO - building 'psutil._psutil_linux' extension 18:44:41 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 18:44:41 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 18:44:41 INFO - building 'psutil._psutil_posix' extension 18:44:41 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 18:44:41 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 18:44:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:41 INFO - Successfully installed psutil 18:44:41 INFO - Cleaning up... 18:44:41 INFO - Return code: 0 18:44:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b7570>, '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 0x28b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', '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 18:44:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:44:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:44:41 INFO - Using env: {'DISPLAY': ':0', 18:44:41 INFO - 'HOME': '/home/cltbld', 18:44:41 INFO - 'LANG': 'en_US.UTF-8', 18:44:41 INFO - 'LANGUAGE': 'en_US:en', 18:44:41 INFO - 'LOGNAME': 'cltbld', 18:44:41 INFO - 'MAIL': '/var/mail/cltbld', 18:44:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:41 INFO - 'MOZ_NO_REMOTE': '1', 18:44:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:41 INFO - 'NO_EM_RESTART': '1', 18:44:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:41 INFO - 'PWD': '/builds/slave/test', 18:44:41 INFO - 'SHELL': '/bin/bash', 18:44:41 INFO - 'SHLVL': '1', 18:44:41 INFO - 'TERM': 'linux', 18:44:41 INFO - 'TMOUT': '86400', 18:44:41 INFO - 'USER': 'cltbld', 18:44:41 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', 18:44:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:41 INFO - '_': '/tools/buildbot/bin/python'} 18:44:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:44:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:44:43 INFO - Installing collected packages: mozsystemmonitor 18:44:43 INFO - Running setup.py install for mozsystemmonitor 18:44:43 INFO - Successfully installed mozsystemmonitor 18:44:43 INFO - Cleaning up... 18:44:43 INFO - Return code: 0 18:44:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:44:43 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')]} 18:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:43 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')]} 18:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:43 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 0x25f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b7570>, '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 0x28b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', '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 18:44:43 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 18:44:43 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 18:44:43 INFO - Using env: {'DISPLAY': ':0', 18:44:43 INFO - 'HOME': '/home/cltbld', 18:44:43 INFO - 'LANG': 'en_US.UTF-8', 18:44:43 INFO - 'LANGUAGE': 'en_US:en', 18:44:43 INFO - 'LOGNAME': 'cltbld', 18:44:43 INFO - 'MAIL': '/var/mail/cltbld', 18:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:43 INFO - 'MOZ_NO_REMOTE': '1', 18:44:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:43 INFO - 'NO_EM_RESTART': '1', 18:44:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:43 INFO - 'PWD': '/builds/slave/test', 18:44:43 INFO - 'SHELL': '/bin/bash', 18:44:43 INFO - 'SHLVL': '1', 18:44:43 INFO - 'TERM': 'linux', 18:44:43 INFO - 'TMOUT': '86400', 18:44:43 INFO - 'USER': 'cltbld', 18:44:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', 18:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:43 INFO - '_': '/tools/buildbot/bin/python'} 18:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:44 INFO - Downloading/unpacking jsonschema==2.5.1 18:44:44 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 18:44:44 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 18:44:44 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 18:44:44 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 18:44:44 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 18:44:44 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 18:44:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:44:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:44:45 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 18:44:45 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 18:44:45 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 18:44:45 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 18:44:45 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 18:44:45 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 18:44:46 INFO - Downloading functools32-3.2.3-2.tar.gz 18:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:44:46 INFO - warning: no files found matching '*.txt' 18:44:46 INFO - no previously-included directories found matching 'build' 18:44:46 INFO - no previously-included directories found matching 'dist' 18:44:46 INFO - no previously-included directories found matching '.git*' 18:44:46 INFO - Installing collected packages: jsonschema, functools32 18:44:46 INFO - Running setup.py install for functools32 18:44:46 INFO - warning: no files found matching '*.txt' 18:44:46 INFO - no previously-included directories found matching 'build' 18:44:46 INFO - no previously-included directories found matching 'dist' 18:44:46 INFO - no previously-included directories found matching '.git*' 18:44:46 INFO - Successfully installed jsonschema functools32 18:44:46 INFO - Cleaning up... 18:44:46 INFO - Return code: 0 18:44:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:44:46 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')]} 18:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:46 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')]} 18:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:46 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 0x25f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b7570>, '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 0x28b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', '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 18:44:46 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 18:44:46 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 18:44:46 INFO - Using env: {'DISPLAY': ':0', 18:44:46 INFO - 'HOME': '/home/cltbld', 18:44:46 INFO - 'LANG': 'en_US.UTF-8', 18:44:46 INFO - 'LANGUAGE': 'en_US:en', 18:44:46 INFO - 'LOGNAME': 'cltbld', 18:44:46 INFO - 'MAIL': '/var/mail/cltbld', 18:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:46 INFO - 'MOZ_NO_REMOTE': '1', 18:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:46 INFO - 'NO_EM_RESTART': '1', 18:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:46 INFO - 'PWD': '/builds/slave/test', 18:44:46 INFO - 'SHELL': '/bin/bash', 18:44:46 INFO - 'SHLVL': '1', 18:44:46 INFO - 'TERM': 'linux', 18:44:46 INFO - 'TMOUT': '86400', 18:44:46 INFO - 'USER': 'cltbld', 18:44:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', 18:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:46 INFO - '_': '/tools/buildbot/bin/python'} 18:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:46 INFO - Downloading/unpacking blobuploader==1.2.4 18:44:46 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 18:44:46 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 18:44:46 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 18:44:46 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 18:44:46 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 18:44:46 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 18:44:48 INFO - Downloading blobuploader-1.2.4.tar.gz 18:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:44:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:44:48 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 18:44:48 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 18:44:48 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 18:44:48 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 18:44:48 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 18:44:48 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 18:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:44:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:44:48 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 18:44:48 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 18:44:48 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 18:44:48 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 18:44:48 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 18:44:48 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 18:44:49 INFO - Downloading docopt-0.6.1.tar.gz 18:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:44:49 INFO - Installing collected packages: blobuploader, requests, docopt 18:44:49 INFO - Running setup.py install for blobuploader 18:44:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:44:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:44:49 INFO - Running setup.py install for requests 18:44:49 INFO - Running setup.py install for docopt 18:44:49 INFO - Successfully installed blobuploader requests docopt 18:44:49 INFO - Cleaning up... 18:44:49 INFO - Return code: 0 18:44:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:49 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 0x25f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b7570>, '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 0x28b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', '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 18:44:49 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 18:44:49 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 18:44:49 INFO - Using env: {'DISPLAY': ':0', 18:44:49 INFO - 'HOME': '/home/cltbld', 18:44:49 INFO - 'LANG': 'en_US.UTF-8', 18:44:49 INFO - 'LANGUAGE': 'en_US:en', 18:44:49 INFO - 'LOGNAME': 'cltbld', 18:44:49 INFO - 'MAIL': '/var/mail/cltbld', 18:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:49 INFO - 'MOZ_NO_REMOTE': '1', 18:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:49 INFO - 'NO_EM_RESTART': '1', 18:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:49 INFO - 'PWD': '/builds/slave/test', 18:44:49 INFO - 'SHELL': '/bin/bash', 18:44:49 INFO - 'SHLVL': '1', 18:44:49 INFO - 'TERM': 'linux', 18:44:49 INFO - 'TMOUT': '86400', 18:44:49 INFO - 'USER': 'cltbld', 18:44:49 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', 18:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:49 INFO - '_': '/tools/buildbot/bin/python'} 18:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:44:50 INFO - Running setup.py (path:/tmp/pip-cUBGK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:44:50 INFO - Running setup.py (path:/tmp/pip-9YFA9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:44:50 INFO - Running setup.py (path:/tmp/pip-nZ8jkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:44:50 INFO - Running setup.py (path:/tmp/pip-ISiihB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:44:50 INFO - Running setup.py (path:/tmp/pip-fD712r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:44:50 INFO - Running setup.py (path:/tmp/pip-fzPMHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:44:50 INFO - Running setup.py (path:/tmp/pip-K4gUOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:44:50 INFO - Running setup.py (path:/tmp/pip-hJdyAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:44:50 INFO - Running setup.py (path:/tmp/pip-D63BsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:44:50 INFO - Running setup.py (path:/tmp/pip-L4lv5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:44:50 INFO - Running setup.py (path:/tmp/pip-J7EIt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:44:50 INFO - Running setup.py (path:/tmp/pip-zNW0RF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:44:50 INFO - Running setup.py (path:/tmp/pip-Et_fuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:44:51 INFO - Running setup.py (path:/tmp/pip-_j_IWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:51 INFO - Running setup.py (path:/tmp/pip-XKClkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:44:51 INFO - Running setup.py (path:/tmp/pip-W3BRjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:44:51 INFO - Running setup.py (path:/tmp/pip-dRTN7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:44:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:44:51 INFO - Running setup.py install for manifestparser 18:44:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:44:51 INFO - Running setup.py install for mozcrash 18:44:51 INFO - Running setup.py install for mozdebug 18:44:51 INFO - Running setup.py install for mozdevice 18:44:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:44:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:44:51 INFO - Running setup.py install for mozfile 18:44:51 INFO - Running setup.py install for mozhttpd 18:44:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:44:51 INFO - Running setup.py install for mozinfo 18:44:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Running setup.py install for mozInstall 18:44:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Running setup.py install for mozleak 18:44:52 INFO - Running setup.py install for mozlog 18:44:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Running setup.py install for moznetwork 18:44:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Running setup.py install for mozprocess 18:44:52 INFO - Running setup.py install for mozprofile 18:44:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Running setup.py install for mozrunner 18:44:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Running setup.py install for mozscreenshot 18:44:52 INFO - Running setup.py install for moztest 18:44:53 INFO - Running setup.py install for mozversion 18:44:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:44:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:44:53 INFO - Cleaning up... 18:44:53 INFO - Return code: 0 18:44:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:44:53 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')]} 18:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:53 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')]} 18:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:53 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 0x25f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b7570>, '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 0x28b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', '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 18:44:53 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 18:44:53 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 18:44:53 INFO - Using env: {'DISPLAY': ':0', 18:44:53 INFO - 'HOME': '/home/cltbld', 18:44:53 INFO - 'LANG': 'en_US.UTF-8', 18:44:53 INFO - 'LANGUAGE': 'en_US:en', 18:44:53 INFO - 'LOGNAME': 'cltbld', 18:44:53 INFO - 'MAIL': '/var/mail/cltbld', 18:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:53 INFO - 'MOZ_NO_REMOTE': '1', 18:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:53 INFO - 'NO_EM_RESTART': '1', 18:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:53 INFO - 'PWD': '/builds/slave/test', 18:44:53 INFO - 'SHELL': '/bin/bash', 18:44:53 INFO - 'SHLVL': '1', 18:44:53 INFO - 'TERM': 'linux', 18:44:53 INFO - 'TMOUT': '86400', 18:44:53 INFO - 'USER': 'cltbld', 18:44:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', 18:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:53 INFO - '_': '/tools/buildbot/bin/python'} 18:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:44:53 INFO - Running setup.py (path:/tmp/pip-CM5bzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:44:53 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)) 18:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:44:53 INFO - Running setup.py (path:/tmp/pip-0OpQS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:44:53 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)) 18:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:44:53 INFO - Running setup.py (path:/tmp/pip-HwAy4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:44:53 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)) 18:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:44:53 INFO - Running setup.py (path:/tmp/pip-zhLZj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:44:53 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)) 18:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:44:53 INFO - Running setup.py (path:/tmp/pip-dtICFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:44:53 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)) 18:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:44:53 INFO - Running setup.py (path:/tmp/pip-Yk7eld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:44:53 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)) 18:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:44:53 INFO - Running setup.py (path:/tmp/pip-PxhshJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:44:53 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)) 18:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:44:53 INFO - Running setup.py (path:/tmp/pip-IhVnSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:44:53 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)) 18:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:44:53 INFO - Running setup.py (path:/tmp/pip-tNQv_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:44:54 INFO - Running setup.py (path:/tmp/pip-_is6Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:44:54 INFO - Running setup.py (path:/tmp/pip-J_fVVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:44:54 INFO - Running setup.py (path:/tmp/pip-sZhOA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:44:54 INFO - Running setup.py (path:/tmp/pip-Ywm7AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:44:54 INFO - Running setup.py (path:/tmp/pip-Q59DF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:54 INFO - Running setup.py (path:/tmp/pip-L0bra0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:44:54 INFO - Running setup.py (path:/tmp/pip-hf9JoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:44:54 INFO - Running setup.py (path:/tmp/pip-gH4Yjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:44:54 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)) 18:44:54 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)) 18:44:54 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)) 18:44:54 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)) 18:44:54 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)) 18:44:54 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)) 18:44:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:44:54 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 18:44:54 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 18:44:54 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 18:44:54 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 18:44:54 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 18:44:54 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 18:44:56 INFO - Downloading blessings-1.6.tar.gz 18:44:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:44:56 INFO - Installing collected packages: blessings 18:44:56 INFO - Running setup.py install for blessings 18:44:56 INFO - Successfully installed blessings 18:44:56 INFO - Cleaning up... 18:44:56 INFO - Return code: 0 18:44:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:44:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:44:56 INFO - Reading from file tmpfile_stdout 18:44:56 INFO - Current package versions: 18:44:56 INFO - argparse == 1.2.1 18:44:56 INFO - blessings == 1.6 18:44:56 INFO - blobuploader == 1.2.4 18:44:56 INFO - docopt == 0.6.1 18:44:56 INFO - functools32 == 3.2.3-2 18:44:56 INFO - jsonschema == 2.5.1 18:44:56 INFO - manifestparser == 1.1 18:44:56 INFO - mozInstall == 1.12 18:44:56 INFO - mozcrash == 0.17 18:44:56 INFO - mozdebug == 0.1 18:44:56 INFO - mozdevice == 0.48 18:44:56 INFO - mozfile == 1.2 18:44:56 INFO - mozhttpd == 0.7 18:44:56 INFO - mozinfo == 0.9 18:44:56 INFO - mozleak == 0.1 18:44:56 INFO - mozlog == 3.2 18:44:56 INFO - moznetwork == 0.27 18:44:56 INFO - mozprocess == 0.23 18:44:56 INFO - mozprofile == 0.28 18:44:56 INFO - mozrunner == 6.12 18:44:56 INFO - mozscreenshot == 0.1 18:44:56 INFO - mozsystemmonitor == 0.3 18:44:56 INFO - moztest == 0.7 18:44:56 INFO - mozversion == 1.4 18:44:56 INFO - psutil == 3.1.1 18:44:56 INFO - requests == 1.2.3 18:44:56 INFO - wsgiref == 0.1.2 18:44:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:44:56 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')]} 18:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:56 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')]} 18:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:56 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 0x25f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b7570>, '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 0x28b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', '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 18:44:56 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 18:44:56 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 18:44:56 INFO - Using env: {'DISPLAY': ':0', 18:44:56 INFO - 'HOME': '/home/cltbld', 18:44:56 INFO - 'LANG': 'en_US.UTF-8', 18:44:56 INFO - 'LANGUAGE': 'en_US:en', 18:44:56 INFO - 'LOGNAME': 'cltbld', 18:44:56 INFO - 'MAIL': '/var/mail/cltbld', 18:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:56 INFO - 'MOZ_NO_REMOTE': '1', 18:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:56 INFO - 'NO_EM_RESTART': '1', 18:44:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:56 INFO - 'PWD': '/builds/slave/test', 18:44:56 INFO - 'SHELL': '/bin/bash', 18:44:56 INFO - 'SHLVL': '1', 18:44:56 INFO - 'TERM': 'linux', 18:44:56 INFO - 'TMOUT': '86400', 18:44:56 INFO - 'USER': 'cltbld', 18:44:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', 18:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:56 INFO - '_': '/tools/buildbot/bin/python'} 18:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 INFO - Cleaning up... 18:44:57 INFO - Return code: 0 18:44:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:44:57 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')]} 18:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:57 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')]} 18:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:57 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 0x25f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b7570>, '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 0x28b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', '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 18:44:57 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 18:44:57 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 18:44:57 INFO - Using env: {'DISPLAY': ':0', 18:44:57 INFO - 'HOME': '/home/cltbld', 18:44:57 INFO - 'LANG': 'en_US.UTF-8', 18:44:57 INFO - 'LANGUAGE': 'en_US:en', 18:44:57 INFO - 'LOGNAME': 'cltbld', 18:44:57 INFO - 'MAIL': '/var/mail/cltbld', 18:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:57 INFO - 'MOZ_NO_REMOTE': '1', 18:44:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:57 INFO - 'NO_EM_RESTART': '1', 18:44:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:57 INFO - 'PWD': '/builds/slave/test', 18:44:57 INFO - 'SHELL': '/bin/bash', 18:44:57 INFO - 'SHLVL': '1', 18:44:57 INFO - 'TERM': 'linux', 18:44:57 INFO - 'TMOUT': '86400', 18:44:57 INFO - 'USER': 'cltbld', 18:44:57 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', 18:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:57 INFO - '_': '/tools/buildbot/bin/python'} 18:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:44:57 INFO - Cleaning up... 18:44:57 INFO - Return code: 0 18:44:57 INFO - Running post-action listener: _resource_record_post_action 18:44:57 INFO - Running post-action listener: _start_resource_monitoring 18:44:57 INFO - Starting resource monitoring. 18:44:57 INFO - ##### 18:44:57 INFO - ##### Finished create-virtualenv step (success) 18:44:57 INFO - ##### 18:44:57 INFO - ##### 18:44:57 INFO - ##### Running install step. 18:44:57 INFO - ##### 18:44:57 INFO - Running pre-action listener: _resource_record_pre_action 18:44:57 INFO - Running main action method: install 18:44:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:44:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:44:57 INFO - Reading from file tmpfile_stdout 18:44:57 INFO - Detecting whether we're running mozinstall >=1.0... 18:44:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:44:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:44:57 INFO - Reading from file tmpfile_stdout 18:44:57 INFO - Output received: 18:44:57 INFO - Usage: mozinstall [options] installer 18:44:57 INFO - Options: 18:44:57 INFO - -h, --help show this help message and exit 18:44:57 INFO - -d DEST, --destination=DEST 18:44:57 INFO - Directory to install application into. [default: 18:44:57 INFO - "/builds/slave/test"] 18:44:57 INFO - --app=APP Application being installed. [default: firefox] 18:44:57 INFO - mkdir: /builds/slave/test/build/application 18:44:57 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'] 18:44:57 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 18:45:14 INFO - Reading from file tmpfile_stdout 18:45:14 INFO - Output received: 18:45:14 INFO - /builds/slave/test/build/application/firefox/firefox 18:45:14 INFO - Running post-action listener: _resource_record_post_action 18:45:14 INFO - ##### 18:45:14 INFO - ##### Finished install step (success) 18:45:14 INFO - ##### 18:45:14 INFO - ##### 18:45:14 INFO - ##### Running run-tests step. 18:45:14 INFO - ##### 18:45:14 INFO - Running pre-action listener: _resource_record_pre_action 18:45:14 INFO - Running main action method: run_tests 18:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:45:14 INFO - Python 2.7.3 18:45:14 INFO - Return code: 0 18:45:14 INFO - grabbing minidump binary from tooltool 18:45:14 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')]} 18:45:14 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 0x28b7570>, '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 0x28b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:45:14 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 18:45:14 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 18:45:14 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 18:45:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:45:14 INFO - Return code: 0 18:45:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:45:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:45:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:45:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:45:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 18:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 18:45:14 INFO - Using env: {'DISPLAY': ':0', 18:45:14 INFO - 'HOME': '/home/cltbld', 18:45:14 INFO - 'LANG': 'en_US.UTF-8', 18:45:14 INFO - 'LANGUAGE': 'en_US:en', 18:45:14 INFO - 'LOGNAME': 'cltbld', 18:45:14 INFO - 'MAIL': '/var/mail/cltbld', 18:45:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:45:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:14 INFO - 'MOZ_NO_REMOTE': '1', 18:45:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:14 INFO - 'NO_EM_RESTART': '1', 18:45:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:14 INFO - 'PWD': '/builds/slave/test', 18:45:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:45:14 INFO - 'SHELL': '/bin/bash', 18:45:14 INFO - 'SHLVL': '1', 18:45:14 INFO - 'TERM': 'linux', 18:45:14 INFO - 'TMOUT': '86400', 18:45:14 INFO - 'USER': 'cltbld', 18:45:14 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087', 18:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:14 INFO - '_': '/tools/buildbot/bin/python'} 18:45:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 18:45:14 INFO - mozversion application_buildid: 20160707172726 18:45:14 INFO - mozversion application_changeset: 23dc78b7b57e9f91798ea44c242a04e112c37db0 18:45:14 INFO - mozversion application_display_name: Nightly 18:45:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:45:14 INFO - mozversion application_name: Firefox 18:45:14 INFO - mozversion application_remotingname: firefox 18:45:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:45:14 INFO - mozversion application_vendor: Mozilla 18:45:14 INFO - mozversion application_version: 50.0a1 18:45:14 INFO - mozversion platform_buildid: 20160707172726 18:45:14 INFO - mozversion platform_changeset: 23dc78b7b57e9f91798ea44c242a04e112c37db0 18:45:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:45:14 INFO - mozversion platform_version: 50.0a1 18:45:14 INFO - using testdate: 1467942314 18:45:14 INFO - actual date: 1467942314 18:45:14 INFO - starting webserver on 'localhost:59228' 18:45:14 INFO - SUITE-START | Running 2 tests 18:45:14 INFO - TEST-START | dromaeo_css 18:45:14 INFO - operating with platform_type : linux_ 18:45:14 INFO - Initialising browser for dromaeo_css test... 18:45:14 INFO - TEST-INFO | started process 1096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp65Q7R4/profile http://localhost:59228/getInfo.html) 18:45:19 INFO - PROCESS | 1096 | __metrics Screen width/height:1600/1200 18:45:19 INFO - PROCESS | 1096 | colorDepth:24 18:45:19 INFO - PROCESS | 1096 | Browser inner width/height: 1024/697 18:45:19 INFO - PROCESS | 1096 | __metrics 18:45:19 ERROR - PROCESS | 1096 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 18:45:20 INFO - TEST-INFO | 1096: exit 0 18:45:20 INFO - Browser initialized. 18:45:20 INFO - Running cycle 1/1 for dromaeo_css test... 18:45:20 INFO - TEST-INFO | started process 1286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp65Q7R4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:45:32 INFO - PROCESS | 1286 | RSS: Main: 169177088 18:45:32 INFO - PROCESS | 1286 | 18:46:22 INFO - PROCESS | 1286 | 1467942382351 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] 18:48:35 INFO - PROCESS | 1286 | Cycle 1(1): loaded http://localhost:59228/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59228/tests/dromaeo/cssquery-ext.html) 18:48:36 INFO - PROCESS | 1286 | RSS: Main: 168951808 18:48:36 INFO - PROCESS | 1286 | 18:51:38 INFO - PROCESS | 1286 | Cycle 1(1): loaded http://localhost:59228/tests/dromaeo/cssquery-ext.html (next: http://localhost:59228/tests/dromaeo/cssquery-jquery.html) 18:51:39 INFO - PROCESS | 1286 | RSS: Main: 167886848 18:51:39 INFO - PROCESS | 1286 | 18:54:41 INFO - PROCESS | 1286 | Cycle 1(1): loaded http://localhost:59228/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59228/tests/dromaeo/cssquery-mootools.html) 18:54:42 INFO - PROCESS | 1286 | RSS: Main: 170983424 18:54:42 INFO - PROCESS | 1286 | 18:57:44 INFO - PROCESS | 1286 | Cycle 1(1): loaded http://localhost:59228/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59228/tests/dromaeo/cssquery-prototype.html) 18:57:44 INFO - PROCESS | 1286 | RSS: Main: 166711296 18:57:44 INFO - PROCESS | 1286 | 19:00:47 INFO - PROCESS | 1286 | Cycle 1(1): loaded http://localhost:59228/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59228/tests/dromaeo/cssquery-yui.html) 19:00:48 INFO - PROCESS | 1286 | RSS: Main: 168374272 19:00:48 INFO - PROCESS | 1286 | 19:03:50 INFO - PROCESS | 1286 | Cycle 1(1): loaded http://localhost:59228/tests/dromaeo/cssquery-yui.html (next: http://localhost:59228/tests/dromaeo/cssquery-dojo.html) 19:03:51 INFO - PROCESS | 1286 | RSS: Main: 169906176 19:03:51 INFO - PROCESS | 1286 | 19:03:51 INFO - PROCESS | 1286 | __start_tp_report 19:03:51 INFO - PROCESS | 1286 | _x_x_mozilla_page_load 19:03:51 INFO - PROCESS | 1286 | _x_x_mozilla_page_load_details 19:03:51 INFO - PROCESS | 1286 | |i|pagename|runs| 19:03:51 INFO - PROCESS | 1286 | |0;dojo.html;2620.2008387441833;2632.644592979948;2642.2997905555026;2653.8938442462304;2668.999125328002;4753.500882407349;4798.976005119969;4823.083614113316;4823.78292976816;4887.266909963499;4694.788734506947;4735.90528189436;4779.64152688548;4821.710697358152;4822.97588512057;4341.956580434195;4366.170427618758;4430.490493593245;4458.576435238647;4462.241418958784;4441.866743997669;4513.977430112845;4525.751083690396;4540.0011997360525;4542.295944128666;4319.568043195687;4338.3058710606465;4353.346997950302;4402.647788176938;4471.441069866267;4377.255866502702;4379.671524635633;4390.363397307373;4404.427424434835;4417.359482874997;4326.372675961968;4357.84747533838;4377.846775362879;4382.213661608486;4392.956070439287;4661.230896902007;4685.461171965234;4730.881727956794;4751.216049351853;4772.02173554424;5079.124797083982;5113.181890897438;5116.539511443988;5119.948800511985;5182.663126896778;5116.923246151311;5118.360204974379;5121.052605268;5129.3075434816565;5150.175971844525;4718.834840780625;4719.3392924990185;4760.690555113976;4772.427308722976;4788.138135135709;5206.0368831766245;5215.217717342429;5227.137522308853;5232.9738351308;5242.7378631068295;4913.508649135129;4985.351904252424;4992.425871024879;4995.225740010304;5008.373953255843;5064.417591976896;5128.640995130305;5137.17805151174;5140.614453915971;5159.58723302135;4956.5786908112495;5022.347094877642;5104.2088476286235;5109.591232701375;5150.407703114115;5084.51697088776;5095.949040509548;5113.565346945476;5122.355251802893;5165.586753059746;4202.117555313357;4239.300515414922;4278.764667943231;4284.207421627009;4293.656507479394;3705.9981415053894;3743.5694895086867;3756.586775454698;3782.149016471327;3786.73492855503;4336.739795612273;4405.140997505456;4449.488308844459;4451.421315229064;4464.575865292792;5127.4872512748425;5204.71374074422;5207.114790485626;5221.216817477409;5234.18870075139;4436.819215576728;4458.264386376277;4458.710183838105;4459.598636122764;4480.059187570581;4479.059397526556;4545.0909818036525;4599.701019433726;4615.14619795339;4650.744209068466;4788.640851936118;4807.495213002724;4818.349522814376;4845.563899249085;4861.708297502161;5205.446798367218;5206.401263854554;5217.869553261199;5222.216667499905;5267.815626453055;4684.625229981525;4735.857924262277;4753.928691069567;4808.8797780055775;4883.462819089827;5081.161608334583;5084.872878178076;5087.211482220114;5091.847244582668;5124;5163.173892177234;5167.560757335668;5168.767405466839;5170.482951704799;5205.817796377109;4885.8289959852655;4998.050370429607;5019.824306149268;5025.597952163891;5041.596672266283;4908.214685650279;4915.852524424273;4945.67853089548;4955.083309587738;5002.824901128443;4903.239997800347;4925.704457732548;4936.407631084293;4938.703677779345;4960.007998400262;4976.552110310089;4986.077575648516;5017.422996355466;5039.017391608601;5053.418856831511;4896.975515122402;4947.406311242674;4950.579200767831;4994.275830004702;4998.175301075282 19:03:51 INFO - PROCESS | 1286 | |1;ext.html;538.4346436241945;546.6747285365207;555.222688236469;561.3039830610043;572.6678526454657;35761.28477430453;39434.60565394345;39468.80265598668;39518;39556.20887582246;39295.21409571814;39694;39768.60231397685;39815.800920995425;39870.401943970865;7564.96217518913;7744.728934487294;7746.651400686983;7751.689932402697;7762.611869406535;7743.8838417423785;7806.180351063142;7820.374370050411;7824.1002284737415;7827.452078354518;7857.332126769203;7864.842703145933;7887.921120788805;7888.1323054463965;7897.644605992716;7826.256505631955;7841.607919603997;7853.528788272693;7858;7873.724419645342;7712.3444507216955;7719.189485104095;7736.729214477523;7764;7764.728234511821;37132;37713.24573508515;37714.62285377138;37726.341048842616;37887.431688524695;2704.323919020245;2823.2095013396283;2957.7485913697146;3002.0093369188116;3260.4294248506417;29262.707372926212;29434.558481622793;29889.40221195564;29930.40139197204;30616;3274.3123943971796;3323.2522682396266;3345.7825241359233;3363.2937083212555;3460.532828068204;268392;269499;269562;269746;273553;31688;47344.763276183396;47693.76153119282;48203;48238.75880620575;32305.192370190933;33368.16579585481;33577.496337554956;33685.66314336874;33739.662603373654;12227.14409991292;12284.877151228553;12367.93816030914;12380.566680166332;12391.318477483645;9845.163161131384;9858.654947076819;9870.753231169278;9902.356346837432;9913.75215619601;7813.492123011986;7843.215678432111;7893.289603935674;7921.722739704082;7956.085050219299;3022.3955208958296;3049.5883055787626;3100.4264211121017;3121.1260846962887;3128.4368813613314;861.5046348349724;874.9956250218709;905.2893478619252;908.8682141089505;969.4619486185235;27704.445911081664;27762.861185693942;27905.16284511468;28370.574441383396;28644;907.832051070554;955.2119501411363;968.3076600230869;970.2916870684298;1042.8175069362983;14062.367193476319;14078.225697586526;14471.27643617836;14536.927315363355;14585;456324;459985;461022;676563;677781;48837.511624884006;50132.24801627979;50402.707715690056;50420.74789626028;50653.240201397006;1135.216700476685;1211.4487908002013;1212.9090318226167;1214.9635510934686;1221.1146918484028;27152.864235678695;28463.85768071229;28742.42515149727;28990.526231987766;29342.853285733436;42473.57526424696;42861.785691071345;42914.78542607267;43371;43383;288223;289546;290380;290668;291016;24656.383590410383;25165.370865728502;25384.11155609545;25555.616665749658;25694;39960.200795983335;40147.79926100351;40276.597234027286;40289.79855100706;41336;33094.5035824458;36890.44664330091;37250.8137459311;38038.23923521459;38559.228815424096;36224;36421.635783641825;36675.633243667224;36818.81590592137;37257;33230.16924576905;33452.66547334593;33703.494447582816;35161.8241908799;35662.64337356593;31128.377432450772;32991.83504082464;33386.33227335391;33516.49725254074;33718.49422258717;25215.74784252134;25497;25527.361815954006;25569.616455753552;25721.485570288864 19:03:51 INFO - PROCESS | 1286 | |2;jquery.html;365.3624425377715;370.9369407200774;373.6976636422067;377.7525720652972;391.8373874841941;15403.383864645415;16422.75365869513;16684.082375469345;16910.83089169108;16951.321947122102;15812.13033283169;16250.918745406256;16852.494425167264;16924.492265232064;16963.067031313272;5165.586753059765;5314.362276526822;5348.144296912495;5357.330333708286;5366.651167674108;3830.138218900739;5261.684298942076;5900.262467191601;6212.347703491136;6245.3442388549;6201.472874805647;6252.374762523734;6269.529785266101;6282.057691346289;6308.873822523547;6012.128241404972;6125.387461253884;6170.259568851721;6261.968690156566;6265.404786545271;5280.234366016906;5301;5310.309659744247;6146.170267013986;6723.66381680914;14570.4900328488;14901;21287.89356053225;24839.379015524577;24840;2144.839137064711;2152.2897443843494;2205.128974055255;2552.923412297634;2578.3940773918116;14648.414063437449;14827.92586037063;14870.182139982297;14887.404503819835;15319.617009574738;1856.071964017991;1874.6531891599961;1903.4289713086018;1941.2817257614631;2023.1705000949687;81773.59113204456;83824.16175838225;84494;85882;85922.57038714828;15993.200339982954;16411.261493232832;16511.83488165127;16631.168441577873;17875.553111172063;28754.281142971176;29052;29149.56275655867;29179;29290;8389.706360277483;8547.188017138362;8577.871331930026;8749.606267717969;8811.118888111267;6584.111144995364;6601.801945941629;6608.140941677647;6641.070250164981;6972.860542789116;8422.368322375847;8440.57797110142;8644.308455323684;8677.913220867837;8703.869441958375;1534.6853894951507;1625.5610985034211;1631.6247263129546;1647.6704659068234;3032.438998785232;826.8057006603443;841.8274253777961;842.3261390887266;877.6489404238356;930.1907340613709;17282.65434691299;17309;17823.910880445514;17879.46361609154;17953.281868725368;831.1812864328631;842.6334544473174;871.4596949891109;871.7776966873533;877.0834477970536;9540.761480963032;10730.517126729315;10738.140948724084;10747.301425407324;10773.676789696321;391784;393525;398410;400032;403264;58087;81098.59450702708;81529.18470815216;82535.587322063;82799.17200827914;845.564534264854;903.9548022598843;948.3029972969999;949.5299826585746;954.9045095490395;15913.920430397773;16113.194340283173;16242.837571624132;16243.187840607687;16393;35813.46279805753;35938.765511104124;36512.63487365199;38591.6140838588;40130.79934600425;49476.752616236685;49832;52968.20547691865;54068;55018.17472737832;7266.818329541592;7409.703611855681;7414.184439711736;7568.356689681439;7857.096433909945;8580.871286930826;11704.824427633423;11719;11920.04639628845;12403.441845116811;10448.68653940383;10638.9361063893;10757.30077544957;10870.673879783619;10880;10455.268131230741;10518.368897866152;10639.468026598794;10698.8930110701;10732.73168170802;10574.947125264325;10639.414832184304;10711.839322410015;10905.890941090487;11170.385628790169;7138.678759455733;7228.241034691492;7380.261973802577;7407.037085178892;7428.405727541892;8789.252913502423;10300.536475858755;10406.375617462976;10512.0013598708;10610.151187904794 19:03:51 INFO - PROCESS | 1286 | |3;mootools.html;1341.724946385991;1378.8207533020707;1435.4617018618019;1646.835316468354;1682.5288919102657;6708.96645516773;7149.106361704787;7402.111746590416;7705.691772329107;7734.613269336539;7523.623818809051;7718.536887786737;7742.380609551236;7765.068191816976;7783.455158138932;2104.2635077722825;2155.3103007037753;2163.0590693048493;2165.404513758713;2173.282816670495;2128.57428514297;2172.5220451500645;2184.868907865533;2207.812335951446;2220.100859152038;2190.080166330145;2196.5497073100055;2197.055266235518;2200.1639377036786;2214.3910424633195;2125.2774056820754;2130.456733532947;2133.434639820449;2135.370065830584;2137.230596985084;2108.4096452993185;2124.7875212478784;2150.193677370986;2157.7842215778455;2169.39257008038;7587.734429294948;7743.728969486097;7760.767176984643;7764.844703105906;7771.805704857367;4516.096780643885;4641.675082744209;4642.605378542828;4653.092646933849;4654.208784506642;2794.3652963016457;2828.6888442271334;2894.276430892277;2903.5499497577907;2917.4456853197826;820.9835803283961;842.8032194284132;845.9365547583956;849.8172892828071;1718.5703574106474;9965.35225210359;10224.284300098996;10324.483775811255;10349.223808214414;10364.948175259151;3879.3211188042546;4004.5795191505053;4064.4309796628495;4071.3689378146437;4118.75287482752;8296.668133274723;8344.415890887702;8353.415260931797;8357.665693372319;8359.038710548242;4543.795529201194;4563.589276965089;4564.269716845355;4565.452145742533;4567.109413664303;3666.5416822897137;4065.9593404066172;4230.175115852441;4238.19474299882;4238.618524332825;3433.656634336546;3466.584009918826;3511.17487390463;3525.8589656413455;3541.1855273287288;1042.1766804224578;1044.806710758512;1048.85840411545;1083.6261489786011;1099.796537640539;583.9591228614041;640.2732898160622;658.5620562326;660.9107770450928;702.8664553734774;5008.173651347487;5310.814121505806;5424.891502169935;5518.862028449321;5539.365887063326;848.7835601921471;866.8743032260287;877.4294013715378;889.1108891108892;894.5303715549259;3514.10390350459;3615.6565126312958;3770.490983717163;3778.301014312361;3807.8286477108595;9314.813703725888;9550.665726699532;9594.232461403071;9667.129958303645;9671.806563868824;9320.627174913063;9522.761930951781;9531.618735250513;9560.808783824285;9565.473898935486;7074.186468556079;7107.39587135089;7197.992281080653;7207.243239459886;7234.891476627855;5131.717755523482;5177.0940085484135;5271;5317.494837990384;5322.574194064543;8514.361422893184;8694.304455643407;8796.296296296408;8806.955965220133;8832.95583522104;8304.377171712025;8698.434601750865;8737.03892571804;8885.733427997171;8950.597223125105;5918.437748414066;6317.147185129948;6372.426481616677;6499.967500162658;6523.510736694672;7026.683799228945;7037.859242815012;7059.894101588377;7105.25394833535;7124.323189297009;6392.744290228339;6676.899846502403;6680.3987641112535;6765.458763298826;6767.458603311822;6591;6629.403353698191;6642.535022548375;6643.667816609053;6687;5897.292324921037;5916.26046744157;5946.256717910262;5965.6122352048715;5975.193348897843;4334.609885110355;4348.826046958086;4393.912121757611;4470.754108524063;4484.417025786627;4501.2347900857585;4505.752183629932;4527.547245275578;4569.634429245586;4588.908221835478 19:03:51 INFO - PROCESS | 1286 | |4;prototype.html;300.8751368182204;304.6511744053059;305.4806828391735;310.4303602888699;310.9300407408335;5081.187010078388;5100.795968161274;5110.259012443198;5129.974350128244;5159.355080614923;4986.626003049777;5012.899742005166;5046.44489106198;5061.367329083864;5089.949100508994;3759.6089446904616;3863.285292220934;3970.722049456525;3973.0663294125857;3990.8204130814183;3945.546262179843;3986.5216174059155;3999.9000024999464;4002.8398864045403;4012.598740125993;3989.2021595680835;3996.3406038003695;4004.319265724819;4004.3993400989793;4008.919821603566;3707.925841483182;3886.203328317688;3907.9218415631526;4006.779627120507;4008.098177909976;3402.0984439123654;3405.6083550391527;3408.7954722716468;3427.143214196451;3427.7943323400677;4907.901841963141;4915;4942.159832828428;4943;5011.298418221452;4229.830806767725;4465.866024019285;4498.707584007029;4503.707259028185;4507.819687212507;5254.238135470374;5258.763355649005;5260;5272.446393128743;5348.144296912515;3699.2416554606243;3706.5181526401666;3713.16453797896;3724.7951362675044;3729.7202709796875;5340.412554619028;5564.77574933514;5565.497315724731;5585.273914391144;5600.551955843523;3812.2375524895133;3815.08437974884;3817.2747178036084;3825.2158307547443;3832.4442955771256;3879.301725689403;3891.8248678809523;3892.4550562921213;3897.8830635080994;3902.434147048662;4448.955510444919;4458.621017213573;4467.508574056851;4474.932876006863;4493.775311234425;5129.820456284012;5200.297959775382;5229.843104706865;5253.4221235664045;5336.199570064521;1307.4443361571293;1328.4154971812372;1335.8196643453205;1336.2784096587927;1339.685173984113;840.9782114730632;847.9660813567511;858.8368210040072;863.5595846118525;879.336101243557;4487.618552423015;4491.708038977456;4506.211413002711;4521.073179998092;4525;5347.224652425377;5349.4650534946195;5371.194320851903;5382;5393.164059570773;4307.763073031013;4545.886352841139;4554.795034223468;4574.977125114353;4587.839425620087;2881;2882.654081510232;2904.8838046477904;2914.12576227131;2916.8186884311885;5039.329155547565;5044.974775126101;5048.469910659402;5072.873178170502;5080.7298175456135;5361.088614935392;5562;5583.469570390806;5596;5607.934492446422;5016.53858837401;5020.874478138076;5036.32009678696;5046.167382381939;5046.44489106198;5448.182772584144;5450.473867317158;5455.208994695826;5463.371712252982;5466.972665136649;5065.898682026413;5344.625876188629;5373.086575282133;5380.811671591476;5399.163129714901;5076.674778020402;5087.847364579068;5091.465396133352;5093.567046801063;5129.487051294841;3792.677622402127;3845.942310865283;3854.5567259764366;3863.4011728182177;3865.188310454836;5127.333446652061;5493.313335833021;5502.889942201214;5524.889502210013;5528.889422211453;5336.653117547347;5349.679019258857;5352.919706204488;5355.866103347447;5371.838844834661;5178.715170665499;5288.995090932711;5289.9471005291;5301.443348448512;5326.387465441524;5192.365344258958;5207.088759467002;5211.296474975829;5211.801285704233;5220.3213582235585;5028.823991160292;5178.689278643294;5304.310439642822;5324.227986941949;5348.304720386325;5156.587473002076;5176.50823171798;5178.870528236825;5191.532762051434;5257.842264732064 19:03:51 INFO - PROCESS | 1286 | |5;yui.html;544.2108942034051;550.1417788250327;578.8205656246563;657.3951964192944;669.4242951062085;11675.59135430259;12041.939790301058;12116.151869369136;12124.211926224789;12129.757404851909;11441.199116061878;11472.71318217045;11579.478923448443;11589.710257243572;11594.768104637902;603.6257520337375;740.3300013487789;757.5038349880837;758.5448730761555;758.6699785593257;733.4169335378386;752.086215248473;752.3153929923743;752.7177308509309;753.2204168685412;805.7623001214656;809.7570728781371;816.3346872299087;816.5182542300042;817.2807929022451;799.2926260259654;805.0822062848357;805.2310043908083;807.5033854179696;808.03036356372;588.6350462713102;589.7287247865987;593.391773432231;593.6586462783916;594.079177275226;11461.140414468864;11512.194146409754;11520.135989800714;11565.190436669436;11575.710607234887;13518.459261629523;13912.51306204288;13914.02601817873;13998.510052148125;14017.29913504331;9794;9817.803643927153;9846;9939.80120397588;9999.550020249106;3212.1166679163184;3247.3667634811222;3257.5765150530515;3266.6243382011135;3327.683870032343;60178.39821601772;61577.384226157614;62207.066893996176;62948;63061.05408418831;10099.394036357842;10225.948870255601;10343.63797267092;10401.895981040245;10539.209559282932;19476.318328858422;19543.609127817363;19615.31346402869;19657.705134422995;19880;5850.970745146247;6209.627422354673;6375.872482550323;6413.839654008687;6652.966735166293;3519.102628829632;3566.5363502744476;3569.411047177187;3575.2677469442738;3631.6913062389463;2680.624712540246;2803.453326601293;2805.5791631255474;2806.9298267543477;2808.9578656320173;462.8079347070928;463.25184826504955;477.7682823830439;478.4784584802582;480.4666819829986;488.15305445052803;497.6392115716077;498.5039885314063;521.163532530291;525.3013492055557;7768.145503994556;7945.165757595485;7970.561619111005;8148.796280093045;8154.429189956765;481.1867943176021;502.2767215210159;511.289307862072;542.395229319314;557.9079451890393;3562.8218589070443;3808.21931504041;3826.559945606291;3850.3646898261472;3922.117523557177;89169;89359.55320223357;90453;91391;93630.53184734168;79619.99999999884;80480;80531.59734201292;80682;80770.59614701889;44687.32969005468;72526.99999999894;72527.6373618139;73487.63256183792;74524;7162.914330824964;7278.199398066315;7293.598852062975;7317.26827317264;7423;35422.82288588644;43560.34659480174;43654.34518482162;44046.559534404245;45345.54654453413;55431;55763;59558.40441595702;65278.673606631666;65464.67267663631;8683.261922736638;8867.290616750515;8888.777780555538;8923.73228803137;9174.311926605398;10238.18094552449;10263.384196948207;10416.635417760343;10434.947825260826;10484.108850747467;9120.726378208665;9223.308251881002;9277.536123193948;9349.065093490597;9751.463669498246;9384.53014958743;9429.434233945985;9695.175910047725;9715.125638692552;9794.363366381162;7599.392048636207;7635.809104772425;7684.654190561327;7740.22597740244;7878.921210787818;7671.578063206577;7689.846203076019;7743.864457456086;7762.728304509541;7894.97248947829;7562.962185189039;7690.384769218337;7780.533168009937;7795.454318197899;7994.2405471480115 19:03:51 INFO - PROCESS | 1286 | __end_tp_report 19:03:51 INFO - PROCESS | 1286 | __start_cc_report 19:03:51 INFO - PROCESS | 1286 | _x_x_mozilla_cycle_collect,413 19:03:51 INFO - PROCESS | 1286 | __end_cc_report 19:03:51 INFO - PROCESS | 1286 | __startTimestamp1467943431111__endTimestamp 19:03:51 INFO - PROCESS | 1286 | 19:03:51 INFO - PROCESS | 1286 | ------- Summary: start ------- 19:03:51 INFO - PROCESS | 1286 | Number of tests: 6 19:03:51 INFO - PROCESS | 1286 | 19:03:51 INFO - PROCESS | 1286 | [#0] dojo.html Cycles:165 Average:4731.46 Median:4861.71 stddev:506.82 (10.4%) stddev-sans-first:480.55 19:03:51 INFO - PROCESS | 1286 | Values: 2620.2 2632.6 2642.3 2653.9 2669.0 4753.5 4799.0 4823.1 4823.8 4887.3 4694.8 4735.9 4779.6 4821.7 4823.0 4342.0 4366.2 4430.5 4458.6 4462.2 4441.9 4514.0 4525.8 4540.0 4542.3 4319.6 4338.3 4353.3 4402.6 4471.4 4377.3 4379.7 4390.4 4404.4 4417.4 4326.4 4357.8 4377.8 4382.2 4393.0 4661.2 4685.5 4730.9 4751.2 4772.0 5079.1 5113.2 5116.5 5119.9 5182.7 5116.9 5118.4 5121.1 5129.3 5150.2 4718.8 4719.3 4760.7 4772.4 4788.1 5206.0 5215.2 5227.1 5233.0 5242.7 4913.5 4985.4 4992.4 4995.2 5008.4 5064.4 5128.6 5137.2 5140.6 5159.6 4956.6 5022.3 5104.2 5109.6 5150.4 5084.5 5095.9 5113.6 5122.4 5165.6 4202.1 4239.3 4278.8 4284.2 4293.7 3706.0 3743.6 3756.6 3782.1 3786.7 4336.7 4405.1 4449.5 4451.4 4464.6 5127.5 5204.7 5207.1 5221.2 5234.2 4436.8 4458.3 4458.7 4459.6 4480.1 4479.1 4545.1 4599.7 4615.1 4650.7 4788.6 4807.5 4818.3 4845.6 4861.7 5205.4 5206.4 5217.9 5222.2 5267.8 4684.6 4735.9 4753.9 4808.9 4883.5 5081.2 5084.9 5087.2 5091.8 5124.0 5163.2 5167.6 5168.8 5170.5 5205.8 4885.8 4998.1 5019.8 5025.6 5041.6 4908.2 4915.9 4945.7 4955.1 5002.8 4903.2 4925.7 4936.4 4938.7 4960.0 4976.6 4986.1 5017.4 5039.0 5053.4 4897.0 4947.4 4950.6 4994.3 4998.2 19:03:51 INFO - PROCESS | 1286 | 19:03:51 INFO - PROCESS | 1286 | [#1] ext.html Cycles:180 Average:50230.66 Median:37253.91 stddev:105618.94 (283.5%) stddev-sans-first:105849.34 19:03:51 INFO - PROCESS | 1286 | Values: 538.4 546.7 555.2 561.3 572.7 35761.3 39434.6 39468.8 39518.0 39556.2 39295.2 39694.0 39768.6 39815.8 39870.4 7565.0 7744.7 7746.7 7751.7 7762.6 7743.9 7806.2 7820.4 7824.1 7827.5 7857.3 7864.8 7887.9 7888.1 7897.6 7826.3 7841.6 7853.5 7858.0 7873.7 7712.3 7719.2 7736.7 7764.0 7764.7 37132.0 37713.2 37714.6 37726.3 37887.4 2704.3 2823.2 2957.7 3002.0 3260.4 29262.7 29434.6 29889.4 29930.4 30616.0 3274.3 3323.3 3345.8 3363.3 3460.5 268392.0 269499.0 269562.0 269746.0 273553.0 31688.0 47344.8 47693.8 48203.0 48238.8 32305.2 33368.2 33577.5 33685.7 33739.7 12227.1 12284.9 12367.9 12380.6 12391.3 9845.2 9858.7 9870.8 9902.4 9913.8 7813.5 7843.2 7893.3 7921.7 7956.1 3022.4 3049.6 3100.4 3121.1 3128.4 861.5 875.0 905.3 908.9 969.5 27704.4 27762.9 27905.2 28370.6 28644.0 907.8 955.2 968.3 970.3 1042.8 14062.4 14078.2 14471.3 14536.9 14585.0 456324.0 459985.0 461022.0 676563.0 677781.0 48837.5 50132.2 50402.7 50420.7 50653.2 1135.2 1211.4 1212.9 1215.0 1221.1 27152.9 28463.9 28742.4 28990.5 29342.9 42473.6 42861.8 42914.8 43371.0 43383.0 288223.0 289546.0 290380.0 290668.0 291016.0 24656.4 25165.4 25384.1 25555.6 25694.0 39960.2 40147.8 40276.6 40289.8 41336.0 33094.5 36890.4 37250.8 38038.2 38559.2 36224.0 36421.6 36675.6 36818.8 37257.0 33230.2 33452.7 33703.5 35161.8 35662.6 31128.4 32991.8 33386.3 33516.5 33718.5 25215.7 25497.0 25527.4 25569.6 25721.5 19:03:51 INFO - PROCESS | 1286 | 19:03:51 INFO - PROCESS | 1286 | [#2] jquery.html Cycles:180 Average:26032.13 Median:19491.73 stddev:65784.98 (337.5%) stddev-sans-first:65941.30 19:03:51 INFO - PROCESS | 1286 | Values: 365.4 370.9 373.7 377.8 391.8 15403.4 16422.8 16684.1 16910.8 16951.3 15812.1 16250.9 16852.5 16924.5 16963.1 5165.6 5314.4 5348.1 5357.3 5366.7 3830.1 5261.7 5900.3 6212.3 6245.3 6201.5 6252.4 6269.5 6282.1 6308.9 6012.1 6125.4 6170.3 6262.0 6265.4 5280.2 5301.0 5310.3 6146.2 6723.7 14570.5 14901.0 21287.9 24839.4 24840.0 2144.8 2152.3 2205.1 2552.9 2578.4 14648.4 14827.9 14870.2 14887.4 15319.6 1856.1 1874.7 1903.4 1941.3 2023.2 81773.6 83824.2 84494.0 85882.0 85922.6 15993.2 16411.3 16511.8 16631.2 17875.6 28754.3 29052.0 29149.6 29179.0 29290.0 8389.7 8547.2 8577.9 8749.6 8811.1 6584.1 6601.8 6608.1 6641.1 6972.9 8422.4 8440.6 8644.3 8677.9 8703.9 1534.7 1625.6 1631.6 1647.7 3032.4 826.8 841.8 842.3 877.6 930.2 17282.7 17309.0 17823.9 17879.5 17953.3 831.2 842.6 871.5 871.8 877.1 9540.8 10730.5 10738.1 10747.3 10773.7 391784.0 393525.0 398410.0 400032.0 403264.0 58087.0 81098.6 81529.2 82535.6 82799.2 845.6 904.0 948.3 949.5 954.9 15913.9 16113.2 16242.8 16243.2 16393.0 35813.5 35938.8 36512.6 38591.6 40130.8 49476.8 49832.0 52968.2 54068.0 55018.2 7266.8 7409.7 7414.2 7568.4 7857.1 8580.9 11704.8 11719.0 11920.0 12403.4 10448.7 10638.9 10757.3 10870.7 10880.0 10455.3 10518.4 10639.5 10698.9 10732.7 10574.9 10639.4 10711.8 10905.9 11170.4 7138.7 7228.2 7380.3 7407.0 7428.4 8789.3 10300.5 10406.4 10512.0 10610.2 19:03:51 INFO - PROCESS | 1286 | 19:03:51 INFO - PROCESS | 1286 | [#3] mootools.html Cycles:180 Average:5013.33 Median:5320.03 stddev:2779.42 (52.2%) stddev-sans-first:2773.52 19:03:51 INFO - PROCESS | 1286 | Values: 1341.7 1378.8 1435.5 1646.8 1682.5 6709.0 7149.1 7402.1 7705.7 7734.6 7523.6 7718.5 7742.4 7765.1 7783.5 2104.3 2155.3 2163.1 2165.4 2173.3 2128.6 2172.5 2184.9 2207.8 2220.1 2190.1 2196.5 2197.1 2200.2 2214.4 2125.3 2130.5 2133.4 2135.4 2137.2 2108.4 2124.8 2150.2 2157.8 2169.4 7587.7 7743.7 7760.8 7764.8 7771.8 4516.1 4641.7 4642.6 4653.1 4654.2 2794.4 2828.7 2894.3 2903.5 2917.4 821.0 842.8 845.9 849.8 1718.6 9965.4 10224.3 10324.5 10349.2 10364.9 3879.3 4004.6 4064.4 4071.4 4118.8 8296.7 8344.4 8353.4 8357.7 8359.0 4543.8 4563.6 4564.3 4565.5 4567.1 3666.5 4066.0 4230.2 4238.2 4238.6 3433.7 3466.6 3511.2 3525.9 3541.2 1042.2 1044.8 1048.9 1083.6 1099.8 584.0 640.3 658.6 660.9 702.9 5008.2 5310.8 5424.9 5518.9 5539.4 848.8 866.9 877.4 889.1 894.5 3514.1 3615.7 3770.5 3778.3 3807.8 9314.8 9550.7 9594.2 9667.1 9671.8 9320.6 9522.8 9531.6 9560.8 9565.5 7074.2 7107.4 7198.0 7207.2 7234.9 5131.7 5177.1 5271.0 5317.5 5322.6 8514.4 8694.3 8796.3 8807.0 8833.0 8304.4 8698.4 8737.0 8885.7 8950.6 5918.4 6317.1 6372.4 6500.0 6523.5 7026.7 7037.9 7059.9 7105.3 7124.3 6392.7 6676.9 6680.4 6765.5 6767.5 6591.0 6629.4 6642.5 6643.7 6687.0 5897.3 5916.3 5946.3 5965.6 5975.2 4334.6 4348.8 4393.9 4470.8 4484.4 4501.2 4505.8 4527.5 4569.6 4588.9 19:03:51 INFO - PROCESS | 1286 | 19:03:51 INFO - PROCESS | 1286 | [#4] prototype.html Cycles:180 Average:4375.72 Median:5037.82 stddev:1278.06 (25.4%) stddev-sans-first:1244.51 19:03:51 INFO - PROCESS | 1286 | Values: 300.9 304.7 305.5 310.4 310.9 5081.2 5100.8 5110.3 5130.0 5159.4 4986.6 5012.9 5046.4 5061.4 5089.9 3759.6 3863.3 3970.7 3973.1 3990.8 3945.5 3986.5 3999.9 4002.8 4012.6 3989.2 3996.3 4004.3 4004.4 4008.9 3707.9 3886.2 3907.9 4006.8 4008.1 3402.1 3405.6 3408.8 3427.1 3427.8 4907.9 4915.0 4942.2 4943.0 5011.3 4229.8 4465.9 4498.7 4503.7 4507.8 5254.2 5258.8 5260.0 5272.4 5348.1 3699.2 3706.5 3713.2 3724.8 3729.7 5340.4 5564.8 5565.5 5585.3 5600.6 3812.2 3815.1 3817.3 3825.2 3832.4 3879.3 3891.8 3892.5 3897.9 3902.4 4449.0 4458.6 4467.5 4474.9 4493.8 5129.8 5200.3 5229.8 5253.4 5336.2 1307.4 1328.4 1335.8 1336.3 1339.7 841.0 848.0 858.8 863.6 879.3 4487.6 4491.7 4506.2 4521.1 4525.0 5347.2 5349.5 5371.2 5382.0 5393.2 4307.8 4545.9 4554.8 4575.0 4587.8 2881.0 2882.7 2904.9 2914.1 2916.8 5039.3 5045.0 5048.5 5072.9 5080.7 5361.1 5562.0 5583.5 5596.0 5607.9 5016.5 5020.9 5036.3 5046.2 5046.4 5448.2 5450.5 5455.2 5463.4 5467.0 5065.9 5344.6 5373.1 5380.8 5399.2 5076.7 5087.8 5091.5 5093.6 5129.5 3792.7 3845.9 3854.6 3863.4 3865.2 5127.3 5493.3 5502.9 5524.9 5528.9 5336.7 5349.7 5352.9 5355.9 5371.8 5178.7 5289.0 5289.9 5301.4 5326.4 5192.4 5207.1 5211.3 5211.8 5220.3 5028.8 5178.7 5304.3 5324.2 5348.3 5156.6 5176.5 5178.9 5191.5 5257.8 19:03:51 INFO - PROCESS | 1286 | 19:03:51 INFO - PROCESS | 1286 | [#5] yui.html Cycles:180 Average:16513.53 Median:33893.51 stddev:24131.56 (71.2%) stddev-sans-first:24169.46 19:03:51 INFO - PROCESS | 1286 | Values: 544.2 550.1 578.8 657.4 669.4 11675.6 12041.9 12116.2 12124.2 12129.8 11441.2 11472.7 11579.5 11589.7 11594.8 603.6 740.3 757.5 758.5 758.7 733.4 752.1 752.3 752.7 753.2 805.8 809.8 816.3 816.5 817.3 799.3 805.1 805.2 807.5 808.0 588.6 589.7 593.4 593.7 594.1 11461.1 11512.2 11520.1 11565.2 11575.7 13518.5 13912.5 13914.0 13998.5 14017.3 9794.0 9817.8 9846.0 9939.8 9999.6 3212.1 3247.4 3257.6 3266.6 3327.7 60178.4 61577.4 62207.1 62948.0 63061.1 10099.4 10225.9 10343.6 10401.9 10539.2 19476.3 19543.6 19615.3 19657.7 19880.0 5851.0 6209.6 6375.9 6413.8 6653.0 3519.1 3566.5 3569.4 3575.3 3631.7 2680.6 2803.5 2805.6 2806.9 2809.0 462.8 463.3 477.8 478.5 480.5 488.2 497.6 498.5 521.2 525.3 7768.1 7945.2 7970.6 8148.8 8154.4 481.2 502.3 511.3 542.4 557.9 3562.8 3808.2 3826.6 3850.4 3922.1 89169.0 89359.6 90453.0 91391.0 93630.5 79620.0 80480.0 80531.6 80682.0 80770.6 44687.3 72527.0 72527.6 73487.6 74524.0 7162.9 7278.2 7293.6 7317.3 7423.0 35422.8 43560.3 43654.3 44046.6 45345.5 55431.0 55763.0 59558.4 65278.7 65464.7 8683.3 8867.3 8888.8 8923.7 9174.3 10238.2 10263.4 10416.6 10434.9 10484.1 9120.7 9223.3 9277.5 9349.1 9751.5 9384.5 9429.4 9695.2 9715.1 9794.4 7599.4 7635.8 7684.7 7740.2 7878.9 7671.6 7689.8 7743.9 7762.7 7895.0 7563.0 7690.4 7780.5 7795.5 7994.2 19:03:51 INFO - PROCESS | 1286 | -------- Summary: end -------- 19:03:51 INFO - PROCESS | 1286 | 19:03:51 INFO - TEST-INFO | 1286: exit 0 19:03:51 INFO - TEST-OK | dromaeo_css | took 1117549ms 19:03:51 INFO - TEST-START | kraken 19:03:51 INFO - operating with platform_type : linux_ 19:03:51 INFO - Initialising browser for kraken test... 19:03:51 INFO - TEST-INFO | started process 1535 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplQN0Yt/profile http://localhost:59228/getInfo.html) 19:03:56 INFO - PROCESS | 1535 | __metrics Screen width/height:1600/1200 19:03:56 INFO - PROCESS | 1535 | colorDepth:24 19:03:56 INFO - PROCESS | 1535 | Browser inner width/height: 1024/697 19:03:56 INFO - PROCESS | 1535 | __metrics 19:03:57 ERROR - PROCESS | 1535 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 19:03:58 INFO - TEST-INFO | 1535: exit 0 19:03:58 INFO - Browser initialized. 19:03:58 INFO - Running cycle 1/1 for kraken test... 19:03:58 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplQN0Yt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:04:10 INFO - PROCESS | 1655 | RSS: Main: 168624128 19:04:10 INFO - PROCESS | 1655 | 19:04:13 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:59228/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59228/tests/kraken/driver.html?testName=audio-beat-detection) 19:04:14 INFO - PROCESS | 1655 | RSS: Main: 173449216 19:04:14 INFO - PROCESS | 1655 | 19:04:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:59228/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59228/tests/kraken/driver.html?testName=audio-dft) 19:04:17 INFO - PROCESS | 1655 | RSS: Main: 173305856 19:04:17 INFO - PROCESS | 1655 | 19:04:20 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:59228/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59228/tests/kraken/driver.html?testName=audio-fft) 19:04:21 INFO - PROCESS | 1655 | RSS: Main: 168525824 19:04:21 INFO - PROCESS | 1655 | 19:04:23 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:59228/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59228/tests/kraken/driver.html?testName=audio-oscillator) 19:04:23 INFO - PROCESS | 1655 | RSS: Main: 169398272 19:04:23 INFO - PROCESS | 1655 | 19:04:26 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:59228/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59228/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:04:26 INFO - PROCESS | 1655 | RSS: Main: 169558016 19:04:26 INFO - PROCESS | 1655 | 19:04:29 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:59228/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59228/tests/kraken/driver.html?testName=imaging-darkroom) 19:04:30 INFO - PROCESS | 1655 | RSS: Main: 169971712 19:04:30 INFO - PROCESS | 1655 | 19:04:34 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:59228/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59228/tests/kraken/driver.html?testName=imaging-desaturate) 19:04:34 INFO - PROCESS | 1655 | RSS: Main: 167456768 19:04:34 INFO - PROCESS | 1655 | 19:04:37 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:59228/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59228/tests/kraken/driver.html?testName=json-parse-financial) 19:04:38 INFO - PROCESS | 1655 | RSS: Main: 169074688 19:04:38 INFO - PROCESS | 1655 | 19:04:40 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:59228/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59228/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:04:40 INFO - PROCESS | 1655 | RSS: Main: 169132032 19:04:40 INFO - PROCESS | 1655 | 19:04:42 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:59228/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59228/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:04:43 INFO - PROCESS | 1655 | RSS: Main: 169500672 19:04:43 INFO - PROCESS | 1655 | 19:04:45 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:59228/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59228/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:04:46 INFO - PROCESS | 1655 | RSS: Main: 170430464 19:04:46 INFO - PROCESS | 1655 | 19:04:48 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:59228/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:04:49 INFO - PROCESS | 1655 | RSS: Main: 170430464 19:04:49 INFO - PROCESS | 1655 | 19:04:52 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:59228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:04:53 INFO - PROCESS | 1655 | RSS: Main: 169938944 19:04:53 INFO - PROCESS | 1655 | 19:04:54 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:59228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59228/tests/kraken/driver.html?testName=ai-astar) 19:04:55 INFO - PROCESS | 1655 | RSS: Main: 170942464 19:04:55 INFO - PROCESS | 1655 | 19:04:55 INFO - PROCESS | 1655 | __start_tp_report 19:04:55 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 19:04:55 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 19:04:55 INFO - PROCESS | 1655 | |i|pagename|runs| 19:04:55 INFO - PROCESS | 1655 | |0;ai-astar;106;114;109;114;114;115;117;113;114;112 19:04:55 INFO - PROCESS | 1655 | |1;audio-beat-detection;149;123;152;174;125;149;151;129;183;125 19:04:55 INFO - PROCESS | 1655 | |2;audio-dft;165;165;166;180;162;164;162;162;163;163 19:04:55 INFO - PROCESS | 1655 | |3;audio-fft;76;77;77;168;78;77;74;75;156;77 19:04:55 INFO - PROCESS | 1655 | |4;audio-oscillator;86;87;151;90;88;91;142;86;88;145 19:04:55 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;120;118;118;118;118;118;118;118;117;118 19:04:55 INFO - PROCESS | 1655 | |6;imaging-darkroom;149;149;148;148;149;150;148;148;148;149 19:04:55 INFO - PROCESS | 1655 | |7;imaging-desaturate;97;96;96;96;101;96;96;97;96;98 19:04:55 INFO - PROCESS | 1655 | |8;json-parse-financial;65;66;66;66;66;67;66;67;66;66 19:04:55 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;66;69;66;65;66;68;65;65;66;65 19:04:55 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;88;82;85;87;81;80;80;81;86;81 19:04:55 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;142;128;134;134;142;132;148;141;165;133 19:04:55 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;169;166;166;168;166;170;169;168;164;164 19:04:55 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;71;70;72;69;68;71;70;72;67;66 19:04:55 INFO - PROCESS | 1655 | __end_tp_report 19:04:55 INFO - PROCESS | 1655 | __start_cc_report 19:04:55 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,989 19:04:55 INFO - PROCESS | 1655 | __end_cc_report 19:04:55 INFO - PROCESS | 1655 | __startTimestamp1467943495084__endTimestamp 19:04:55 INFO - PROCESS | 1655 | 19:04:55 INFO - PROCESS | 1655 | ------- Summary: start ------- 19:04:55 INFO - PROCESS | 1655 | Number of tests: 14 19:04:55 INFO - PROCESS | 1655 | 19:04:55 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.16 (2.8%) stddev-sans-first:2.19 19:04:55 INFO - PROCESS | 1655 | Values: 106.0 114.0 109.0 114.0 114.0 115.0 117.0 113.0 114.0 112.0 19:04:55 INFO - PROCESS | 1655 | 19:04:55 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:150.00 stddev:20.90 (13.9%) stddev-sans-first:22.14 19:04:55 INFO - PROCESS | 1655 | Values: 149.0 123.0 152.0 174.0 125.0 149.0 151.0 129.0 183.0 125.0 19:04:55 INFO - PROCESS | 1655 | 19:04:55 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.50 stddev:5.39 (3.3%) stddev-sans-first:5.72 19:04:55 INFO - PROCESS | 1655 | Values: 165.0 165.0 166.0 180.0 162.0 164.0 162.0 162.0 163.0 163.0 19:04:55 INFO - PROCESS | 1655 | 19:04:55 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:93.50 Median:77.00 stddev:36.23 (47.1%) stddev-sans-first:37.87 19:04:55 INFO - PROCESS | 1655 | Values: 76.0 77.0 77.0 168.0 78.0 77.0 74.0 75.0 156.0 77.0 19:04:55 INFO - PROCESS | 1655 | 19:04:55 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:105.40 Median:87.50 stddev:28.14 (32.2%) stddev-sans-first:28.96 19:04:55 INFO - PROCESS | 1655 | Values: 86.0 87.0 151.0 90.0 88.0 91.0 142.0 86.0 88.0 145.0 19:04:55 INFO - PROCESS | 1655 | 19:04:55 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.33 19:04:55 INFO - PROCESS | 1655 | Values: 120.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 118.0 19:04:55 INFO - PROCESS | 1655 | 19:04:55 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 19:04:55 INFO - PROCESS | 1655 | Values: 149.0 149.0 148.0 148.0 149.0 150.0 148.0 148.0 148.0 149.0 19:04:55 INFO - PROCESS | 1655 | 19:04:55 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:96.00 stddev:1.60 (1.7%) stddev-sans-first:1.69 19:04:55 INFO - PROCESS | 1655 | Values: 97.0 96.0 96.0 96.0 101.0 96.0 96.0 97.0 96.0 98.0 19:04:55 INFO - PROCESS | 1655 | 19:04:55 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 19:04:55 INFO - PROCESS | 1655 | Values: 65.0 66.0 66.0 66.0 66.0 67.0 66.0 67.0 66.0 66.0 19:04:55 INFO - PROCESS | 1655 | 19:04:55 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:1.37 (2.1%) stddev-sans-first:1.45 19:04:55 INFO - PROCESS | 1655 | Values: 66.0 69.0 66.0 65.0 66.0 68.0 65.0 65.0 66.0 65.0 19:04:55 INFO - PROCESS | 1655 | 19:04:55 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:3.07 (3.7%) stddev-sans-first:2.70 19:04:55 INFO - PROCESS | 1655 | Values: 88.0 82.0 85.0 87.0 81.0 80.0 80.0 81.0 86.0 81.0 19:04:55 INFO - PROCESS | 1655 | 19:04:55 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:141.50 stddev:10.68 (7.5%) stddev-sans-first:11.30 19:04:55 INFO - PROCESS | 1655 | Values: 142.0 128.0 134.0 134.0 142.0 132.0 148.0 141.0 165.0 133.0 19:04:55 INFO - PROCESS | 1655 | 19:04:55 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:168.00 stddev:2.11 (1.3%) stddev-sans-first:2.11 19:04:55 INFO - PROCESS | 1655 | Values: 169.0 166.0 166.0 168.0 166.0 170.0 169.0 168.0 164.0 164.0 19:04:55 INFO - PROCESS | 1655 | 19:04:55 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.50 stddev:2.07 (2.9%) stddev-sans-first:2.13 19:04:55 INFO - PROCESS | 1655 | Values: 71.0 70.0 72.0 69.0 68.0 71.0 70.0 72.0 67.0 66.0 19:04:55 INFO - PROCESS | 1655 | -------- Summary: end -------- 19:04:55 INFO - PROCESS | 1655 | 19:04:56 INFO - TEST-INFO | 1655: exit 0 19:04:56 INFO - TEST-OK | kraken | took 64271ms 19:04:56 INFO - SUITE-END | took 1181s 19:04:56 INFO - Completed test suite (00:19:41) 19:04:56 INFO - javascript benchmark 19:04:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6375.808932772672, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2620.2008387441833, 2632.644592979948, 2642.2997905555026, 2653.8938442462304, 2668.999125328002, 4753.500882407349, 4798.976005119969, 4823.083614113316, 4823.78292976816, 4887.266909963499, 4694.788734506947, 4735.90528189436, 4779.64152688548, 4821.710697358152, 4822.97588512057, 4341.956580434195, 4366.170427618758, 4430.490493593245, 4458.576435238647, 4462.241418958784, 4441.866743997669, 4513.977430112845, 4525.751083690396, 4540.0011997360525, 4542.295944128666, 4319.568043195687, 4338.3058710606465, 4353.346997950302, 4402.647788176938, 4471.441069866267, 4377.255866502702, 4379.671524635633, 4390.363397307373, 4404.427424434835, 4417.359482874997, 4326.372675961968, 4357.84747533838, 4377.846775362879, 4382.213661608486, 4392.956070439287, 4661.230896902007, 4685.461171965234, 4730.881727956794, 4751.216049351853, 4772.02173554424, 5079.124797083982, 5113.181890897438, 5116.539511443988, 5119.948800511985, 5182.663126896778, 5116.923246151311, 5118.360204974379, 5121.052605268, 5129.3075434816565, 5150.175971844525, 4718.834840780625, 4719.3392924990185, 4760.690555113976, 4772.427308722976, 4788.138135135709, 5206.0368831766245, 5215.217717342429, 5227.137522308853, 5232.9738351308, 5242.7378631068295, 4913.508649135129, 4985.351904252424, 4992.425871024879, 4995.225740010304, 5008.373953255843, 5064.417591976896, 5128.640995130305, 5137.17805151174, 5140.614453915971, 5159.58723302135, 4956.5786908112495, 5022.347094877642, 5104.2088476286235, 5109.591232701375, 5150.407703114115, 5084.51697088776, 5095.949040509548, 5113.565346945476, 5122.355251802893, 5165.586753059746, 4202.117555313357, 4239.300515414922, 4278.764667943231, 4284.207421627009, 4293.656507479394, 3705.9981415053894, 3743.5694895086867, 3756.586775454698, 3782.149016471327, 3786.73492855503, 4336.739795612273, 4405.140997505456, 4449.488308844459, 4451.421315229064, 4464.575865292792, 5127.4872512748425, 5204.71374074422, 5207.114790485626, 5221.216817477409, 5234.18870075139, 4436.819215576728, 4458.264386376277, 4458.710183838105, 4459.598636122764, 4480.059187570581, 4479.059397526556, 4545.0909818036525, 4599.701019433726, 4615.14619795339, 4650.744209068466, 4788.640851936118, 4807.495213002724, 4818.349522814376, 4845.563899249085, 4861.708297502161, 5205.446798367218, 5206.401263854554, 5217.869553261199, 5222.216667499905, 5267.815626453055, 4684.625229981525, 4735.857924262277, 4753.928691069567, 4808.8797780055775, 4883.462819089827, 5081.161608334583, 5084.872878178076, 5087.211482220114, 5091.847244582668, 5124.0, 5163.173892177234, 5167.560757335668, 5168.767405466839, 5170.482951704799, 5205.817796377109, 4885.8289959852655, 4998.050370429607, 5019.824306149268, 5025.597952163891, 5041.596672266283, 4908.214685650279, 4915.852524424273, 4945.67853089548, 4955.083309587738, 5002.824901128443, 4903.239997800347, 4925.704457732548, 4936.407631084293, 4938.703677779345, 4960.007998400262, 4976.552110310089, 4986.077575648516, 5017.422996355466, 5039.017391608601, 5053.418856831511, 4896.975515122402, 4947.406311242674, 4950.579200767831, 4994.275830004702, 4998.175301075282], "value": 4698.222141363712, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.4346436241945, 546.6747285365207, 555.222688236469, 561.3039830610043, 572.6678526454657, 35761.28477430453, 39434.60565394345, 39468.80265598668, 39518.0, 39556.20887582246, 39295.21409571814, 39694.0, 39768.60231397685, 39815.800920995425, 39870.401943970865, 7564.96217518913, 7744.728934487294, 7746.651400686983, 7751.689932402697, 7762.611869406535, 7743.8838417423785, 7806.180351063142, 7820.374370050411, 7824.1002284737415, 7827.452078354518, 7857.332126769203, 7864.842703145933, 7887.921120788805, 7888.1323054463965, 7897.644605992716, 7826.256505631955, 7841.607919603997, 7853.528788272693, 7858.0, 7873.724419645342, 7712.3444507216955, 7719.189485104095, 7736.729214477523, 7764.0, 7764.728234511821, 37132.0, 37713.24573508515, 37714.62285377138, 37726.341048842616, 37887.431688524695, 2704.323919020245, 2823.2095013396283, 2957.7485913697146, 3002.0093369188116, 3260.4294248506417, 29262.707372926212, 29434.558481622793, 29889.40221195564, 29930.40139197204, 30616.0, 3274.3123943971796, 3323.2522682396266, 3345.7825241359233, 3363.2937083212555, 3460.532828068204, 268392.0, 269499.0, 269562.0, 269746.0, 273553.0, 31688.0, 47344.763276183396, 47693.76153119282, 48203.0, 48238.75880620575, 32305.192370190933, 33368.16579585481, 33577.496337554956, 33685.66314336874, 33739.662603373654, 12227.14409991292, 12284.877151228553, 12367.93816030914, 12380.566680166332, 12391.318477483645, 9845.163161131384, 9858.654947076819, 9870.753231169278, 9902.356346837432, 9913.75215619601, 7813.492123011986, 7843.215678432111, 7893.289603935674, 7921.722739704082, 7956.085050219299, 3022.3955208958296, 3049.5883055787626, 3100.4264211121017, 3121.1260846962887, 3128.4368813613314, 861.5046348349724, 874.9956250218709, 905.2893478619252, 908.8682141089505, 969.4619486185235, 27704.445911081664, 27762.861185693942, 27905.16284511468, 28370.574441383396, 28644.0, 907.832051070554, 955.2119501411363, 968.3076600230869, 970.2916870684298, 1042.8175069362983, 14062.367193476319, 14078.225697586526, 14471.27643617836, 14536.927315363355, 14585.0, 456324.0, 459985.0, 461022.0, 676563.0, 677781.0, 48837.511624884006, 50132.24801627979, 50402.707715690056, 50420.74789626028, 50653.240201397006, 1135.216700476685, 1211.4487908002013, 1212.9090318226167, 1214.9635510934686, 1221.1146918484028, 27152.864235678695, 28463.85768071229, 28742.42515149727, 28990.526231987766, 29342.853285733436, 42473.57526424696, 42861.785691071345, 42914.78542607267, 43371.0, 43383.0, 288223.0, 289546.0, 290380.0, 290668.0, 291016.0, 24656.383590410383, 25165.370865728502, 25384.11155609545, 25555.616665749658, 25694.0, 39960.200795983335, 40147.79926100351, 40276.597234027286, 40289.79855100706, 41336.0, 33094.5035824458, 36890.44664330091, 37250.8137459311, 38038.23923521459, 38559.228815424096, 36224.0, 36421.635783641825, 36675.633243667224, 36818.81590592137, 37257.0, 33230.16924576905, 33452.66547334593, 33703.494447582816, 35161.8241908799, 35662.64337356593, 31128.377432450772, 32991.83504082464, 33386.33227335391, 33516.49725254074, 33718.49422258717, 25215.74784252134, 25497.0, 25527.361815954006, 25569.616455753552, 25721.485570288864], "value": 16392.743245121957, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.3624425377715, 370.9369407200774, 373.6976636422067, 377.7525720652972, 391.8373874841941, 15403.383864645415, 16422.75365869513, 16684.082375469345, 16910.83089169108, 16951.321947122102, 15812.13033283169, 16250.918745406256, 16852.494425167264, 16924.492265232064, 16963.067031313272, 5165.586753059765, 5314.362276526822, 5348.144296912495, 5357.330333708286, 5366.651167674108, 3830.138218900739, 5261.684298942076, 5900.262467191601, 6212.347703491136, 6245.3442388549, 6201.472874805647, 6252.374762523734, 6269.529785266101, 6282.057691346289, 6308.873822523547, 6012.128241404972, 6125.387461253884, 6170.259568851721, 6261.968690156566, 6265.404786545271, 5280.234366016906, 5301.0, 5310.309659744247, 6146.170267013986, 6723.66381680914, 14570.4900328488, 14901.0, 21287.89356053225, 24839.379015524577, 24840.0, 2144.839137064711, 2152.2897443843494, 2205.128974055255, 2552.923412297634, 2578.3940773918116, 14648.414063437449, 14827.92586037063, 14870.182139982297, 14887.404503819835, 15319.617009574738, 1856.071964017991, 1874.6531891599961, 1903.4289713086018, 1941.2817257614631, 2023.1705000949687, 81773.59113204456, 83824.16175838225, 84494.0, 85882.0, 85922.57038714828, 15993.200339982954, 16411.261493232832, 16511.83488165127, 16631.168441577873, 17875.553111172063, 28754.281142971176, 29052.0, 29149.56275655867, 29179.0, 29290.0, 8389.706360277483, 8547.188017138362, 8577.871331930026, 8749.606267717969, 8811.118888111267, 6584.111144995364, 6601.801945941629, 6608.140941677647, 6641.070250164981, 6972.860542789116, 8422.368322375847, 8440.57797110142, 8644.308455323684, 8677.913220867837, 8703.869441958375, 1534.6853894951507, 1625.5610985034211, 1631.6247263129546, 1647.6704659068234, 3032.438998785232, 826.8057006603443, 841.8274253777961, 842.3261390887266, 877.6489404238356, 930.1907340613709, 17282.65434691299, 17309.0, 17823.910880445514, 17879.46361609154, 17953.281868725368, 831.1812864328631, 842.6334544473174, 871.4596949891109, 871.7776966873533, 877.0834477970536, 9540.761480963032, 10730.517126729315, 10738.140948724084, 10747.301425407324, 10773.676789696321, 391784.0, 393525.0, 398410.0, 400032.0, 403264.0, 58087.0, 81098.59450702708, 81529.18470815216, 82535.587322063, 82799.17200827914, 845.564534264854, 903.9548022598843, 948.3029972969999, 949.5299826585746, 954.9045095490395, 15913.920430397773, 16113.194340283173, 16242.837571624132, 16243.187840607687, 16393.0, 35813.46279805753, 35938.765511104124, 36512.63487365199, 38591.6140838588, 40130.79934600425, 49476.752616236685, 49832.0, 52968.20547691865, 54068.0, 55018.17472737832, 7266.818329541592, 7409.703611855681, 7414.184439711736, 7568.356689681439, 7857.096433909945, 8580.871286930826, 11704.824427633423, 11719.0, 11920.04639628845, 12403.441845116811, 10448.68653940383, 10638.9361063893, 10757.30077544957, 10870.673879783619, 10880.0, 10455.268131230741, 10518.368897866152, 10639.468026598794, 10698.8930110701, 10732.73168170802, 10574.947125264325, 10639.414832184304, 10711.839322410015, 10905.890941090487, 11170.385628790169, 7138.678759455733, 7228.241034691492, 7380.261973802577, 7407.037085178892, 7428.405727541892, 8789.252913502423, 10300.536475858755, 10406.375617462976, 10512.0013598708, 10610.151187904794], "value": 9091.048175461867, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.724946385991, 1378.8207533020707, 1435.4617018618019, 1646.835316468354, 1682.5288919102657, 6708.96645516773, 7149.106361704787, 7402.111746590416, 7705.691772329107, 7734.613269336539, 7523.623818809051, 7718.536887786737, 7742.380609551236, 7765.068191816976, 7783.455158138932, 2104.2635077722825, 2155.3103007037753, 2163.0590693048493, 2165.404513758713, 2173.282816670495, 2128.57428514297, 2172.5220451500645, 2184.868907865533, 2207.812335951446, 2220.100859152038, 2190.080166330145, 2196.5497073100055, 2197.055266235518, 2200.1639377036786, 2214.3910424633195, 2125.2774056820754, 2130.456733532947, 2133.434639820449, 2135.370065830584, 2137.230596985084, 2108.4096452993185, 2124.7875212478784, 2150.193677370986, 2157.7842215778455, 2169.39257008038, 7587.734429294948, 7743.728969486097, 7760.767176984643, 7764.844703105906, 7771.805704857367, 4516.096780643885, 4641.675082744209, 4642.605378542828, 4653.092646933849, 4654.208784506642, 2794.3652963016457, 2828.6888442271334, 2894.276430892277, 2903.5499497577907, 2917.4456853197826, 820.9835803283961, 842.8032194284132, 845.9365547583956, 849.8172892828071, 1718.5703574106474, 9965.35225210359, 10224.284300098996, 10324.483775811255, 10349.223808214414, 10364.948175259151, 3879.3211188042546, 4004.5795191505053, 4064.4309796628495, 4071.3689378146437, 4118.75287482752, 8296.668133274723, 8344.415890887702, 8353.415260931797, 8357.665693372319, 8359.038710548242, 4543.795529201194, 4563.589276965089, 4564.269716845355, 4565.452145742533, 4567.109413664303, 3666.5416822897137, 4065.9593404066172, 4230.175115852441, 4238.19474299882, 4238.618524332825, 3433.656634336546, 3466.584009918826, 3511.17487390463, 3525.8589656413455, 3541.1855273287288, 1042.1766804224578, 1044.806710758512, 1048.85840411545, 1083.6261489786011, 1099.796537640539, 583.9591228614041, 640.2732898160622, 658.5620562326, 660.9107770450928, 702.8664553734774, 5008.173651347487, 5310.814121505806, 5424.891502169935, 5518.862028449321, 5539.365887063326, 848.7835601921471, 866.8743032260287, 877.4294013715378, 889.1108891108892, 894.5303715549259, 3514.10390350459, 3615.6565126312958, 3770.490983717163, 3778.301014312361, 3807.8286477108595, 9314.813703725888, 9550.665726699532, 9594.232461403071, 9667.129958303645, 9671.806563868824, 9320.627174913063, 9522.761930951781, 9531.618735250513, 9560.808783824285, 9565.473898935486, 7074.186468556079, 7107.39587135089, 7197.992281080653, 7207.243239459886, 7234.891476627855, 5131.717755523482, 5177.0940085484135, 5271.0, 5317.494837990384, 5322.574194064543, 8514.361422893184, 8694.304455643407, 8796.296296296408, 8806.955965220133, 8832.95583522104, 8304.377171712025, 8698.434601750865, 8737.03892571804, 8885.733427997171, 8950.597223125105, 5918.437748414066, 6317.147185129948, 6372.426481616677, 6499.967500162658, 6523.510736694672, 7026.683799228945, 7037.859242815012, 7059.894101588377, 7105.25394833535, 7124.323189297009, 6392.744290228339, 6676.899846502403, 6680.3987641112535, 6765.458763298826, 6767.458603311822, 6591.0, 6629.403353698191, 6642.535022548375, 6643.667816609053, 6687.0, 5897.292324921037, 5916.26046744157, 5946.256717910262, 5965.6122352048715, 5975.193348897843, 4334.609885110355, 4348.826046958086, 4393.912121757611, 4470.754108524063, 4484.417025786627, 4501.2347900857585, 4505.752183629932, 4527.547245275578, 4569.634429245586, 4588.908221835478], "value": 4041.3030562669874, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.8751368182204, 304.6511744053059, 305.4806828391735, 310.4303602888699, 310.9300407408335, 5081.187010078388, 5100.795968161274, 5110.259012443198, 5129.974350128244, 5159.355080614923, 4986.626003049777, 5012.899742005166, 5046.44489106198, 5061.367329083864, 5089.949100508994, 3759.6089446904616, 3863.285292220934, 3970.722049456525, 3973.0663294125857, 3990.8204130814183, 3945.546262179843, 3986.5216174059155, 3999.9000024999464, 4002.8398864045403, 4012.598740125993, 3989.2021595680835, 3996.3406038003695, 4004.319265724819, 4004.3993400989793, 4008.919821603566, 3707.925841483182, 3886.203328317688, 3907.9218415631526, 4006.779627120507, 4008.098177909976, 3402.0984439123654, 3405.6083550391527, 3408.7954722716468, 3427.143214196451, 3427.7943323400677, 4907.901841963141, 4915.0, 4942.159832828428, 4943.0, 5011.298418221452, 4229.830806767725, 4465.866024019285, 4498.707584007029, 4503.707259028185, 4507.819687212507, 5254.238135470374, 5258.763355649005, 5260.0, 5272.446393128743, 5348.144296912515, 3699.2416554606243, 3706.5181526401666, 3713.16453797896, 3724.7951362675044, 3729.7202709796875, 5340.412554619028, 5564.77574933514, 5565.497315724731, 5585.273914391144, 5600.551955843523, 3812.2375524895133, 3815.08437974884, 3817.2747178036084, 3825.2158307547443, 3832.4442955771256, 3879.301725689403, 3891.8248678809523, 3892.4550562921213, 3897.8830635080994, 3902.434147048662, 4448.955510444919, 4458.621017213573, 4467.508574056851, 4474.932876006863, 4493.775311234425, 5129.820456284012, 5200.297959775382, 5229.843104706865, 5253.4221235664045, 5336.199570064521, 1307.4443361571293, 1328.4154971812372, 1335.8196643453205, 1336.2784096587927, 1339.685173984113, 840.9782114730632, 847.9660813567511, 858.8368210040072, 863.5595846118525, 879.336101243557, 4487.618552423015, 4491.708038977456, 4506.211413002711, 4521.073179998092, 4525.0, 5347.224652425377, 5349.4650534946195, 5371.194320851903, 5382.0, 5393.164059570773, 4307.763073031013, 4545.886352841139, 4554.795034223468, 4574.977125114353, 4587.839425620087, 2881.0, 2882.654081510232, 2904.8838046477904, 2914.12576227131, 2916.8186884311885, 5039.329155547565, 5044.974775126101, 5048.469910659402, 5072.873178170502, 5080.7298175456135, 5361.088614935392, 5562.0, 5583.469570390806, 5596.0, 5607.934492446422, 5016.53858837401, 5020.874478138076, 5036.32009678696, 5046.167382381939, 5046.44489106198, 5448.182772584144, 5450.473867317158, 5455.208994695826, 5463.371712252982, 5466.972665136649, 5065.898682026413, 5344.625876188629, 5373.086575282133, 5380.811671591476, 5399.163129714901, 5076.674778020402, 5087.847364579068, 5091.465396133352, 5093.567046801063, 5129.487051294841, 3792.677622402127, 3845.942310865283, 3854.5567259764366, 3863.4011728182177, 3865.188310454836, 5127.333446652061, 5493.313335833021, 5502.889942201214, 5524.889502210013, 5528.889422211453, 5336.653117547347, 5349.679019258857, 5352.919706204488, 5355.866103347447, 5371.838844834661, 5178.715170665499, 5288.995090932711, 5289.9471005291, 5301.443348448512, 5326.387465441524, 5192.365344258958, 5207.088759467002, 5211.296474975829, 5211.801285704233, 5220.3213582235585, 5028.823991160292, 5178.689278643294, 5304.310439642822, 5324.227986941949, 5348.304720386325, 5156.587473002076, 5176.50823171798, 5178.870528236825, 5191.532762051434, 5257.842264732064], "value": 3964.8725188184867, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.2108942034051, 550.1417788250327, 578.8205656246563, 657.3951964192944, 669.4242951062085, 11675.59135430259, 12041.939790301058, 12116.151869369136, 12124.211926224789, 12129.757404851909, 11441.199116061878, 11472.71318217045, 11579.478923448443, 11589.710257243572, 11594.768104637902, 603.6257520337375, 740.3300013487789, 757.5038349880837, 758.5448730761555, 758.6699785593257, 733.4169335378386, 752.086215248473, 752.3153929923743, 752.7177308509309, 753.2204168685412, 805.7623001214656, 809.7570728781371, 816.3346872299087, 816.5182542300042, 817.2807929022451, 799.2926260259654, 805.0822062848357, 805.2310043908083, 807.5033854179696, 808.03036356372, 588.6350462713102, 589.7287247865987, 593.391773432231, 593.6586462783916, 594.079177275226, 11461.140414468864, 11512.194146409754, 11520.135989800714, 11565.190436669436, 11575.710607234887, 13518.459261629523, 13912.51306204288, 13914.02601817873, 13998.510052148125, 14017.29913504331, 9794.0, 9817.803643927153, 9846.0, 9939.80120397588, 9999.550020249106, 3212.1166679163184, 3247.3667634811222, 3257.5765150530515, 3266.6243382011135, 3327.683870032343, 60178.39821601772, 61577.384226157614, 62207.066893996176, 62948.0, 63061.05408418831, 10099.394036357842, 10225.948870255601, 10343.63797267092, 10401.895981040245, 10539.209559282932, 19476.318328858422, 19543.609127817363, 19615.31346402869, 19657.705134422995, 19880.0, 5850.970745146247, 6209.627422354673, 6375.872482550323, 6413.839654008687, 6652.966735166293, 3519.102628829632, 3566.5363502744476, 3569.411047177187, 3575.2677469442738, 3631.6913062389463, 2680.624712540246, 2803.453326601293, 2805.5791631255474, 2806.9298267543477, 2808.9578656320173, 462.8079347070928, 463.25184826504955, 477.7682823830439, 478.4784584802582, 480.4666819829986, 488.15305445052803, 497.6392115716077, 498.5039885314063, 521.163532530291, 525.3013492055557, 7768.145503994556, 7945.165757595485, 7970.561619111005, 8148.796280093045, 8154.429189956765, 481.1867943176021, 502.2767215210159, 511.289307862072, 542.395229319314, 557.9079451890393, 3562.8218589070443, 3808.21931504041, 3826.559945606291, 3850.3646898261472, 3922.117523557177, 89169.0, 89359.55320223357, 90453.0, 91391.0, 93630.53184734168, 79619.99999999884, 80480.0, 80531.59734201292, 80682.0, 80770.59614701889, 44687.32969005468, 72526.99999999894, 72527.6373618139, 73487.63256183792, 74524.0, 7162.914330824964, 7278.199398066315, 7293.598852062975, 7317.26827317264, 7423.0, 35422.82288588644, 43560.34659480174, 43654.34518482162, 44046.559534404245, 45345.54654453413, 55431.0, 55763.0, 59558.40441595702, 65278.673606631666, 65464.67267663631, 8683.261922736638, 8867.290616750515, 8888.777780555538, 8923.73228803137, 9174.311926605398, 10238.18094552449, 10263.384196948207, 10416.635417760343, 10434.947825260826, 10484.108850747467, 9120.726378208665, 9223.308251881002, 9277.536123193948, 9349.065093490597, 9751.463669498246, 9384.53014958743, 9429.434233945985, 9695.175910047725, 9715.125638692552, 9794.363366381162, 7599.392048636207, 7635.809104772425, 7684.654190561327, 7740.22597740244, 7878.921210787818, 7671.578063206577, 7689.846203076019, 7743.864457456086, 7762.728304509541, 7894.97248947829, 7562.962185189039, 7690.384769218337, 7780.533168009937, 7795.454318197899, 7994.2405471480115], "value": 5987.071459456676, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 109.0, 114.0, 114.0, 115.0, 117.0, 113.0, 114.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 152.0, 174.0, 125.0, 149.0, 151.0, 129.0, 183.0, 125.0], "value": 146.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 166.0, 180.0, 162.0, 164.0, 162.0, 162.0, 163.0, 163.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 168.0, 78.0, 77.0, 74.0, 75.0, 156.0, 77.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 151.0, 90.0, 88.0, 91.0, 142.0, 86.0, 88.0, 145.0], "value": 105.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 148.0, 149.0, 150.0, 148.0, 148.0, 148.0, 149.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 101.0, 96.0, 96.0, 97.0, 96.0, 98.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 66.0, 65.0, 66.0, 68.0, 65.0, 65.0, 66.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 85.0, 87.0, 81.0, 80.0, 80.0, 81.0, 86.0, 81.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 128.0, 134.0, 134.0, 142.0, 132.0, 148.0, 141.0, 165.0, 133.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 166.0, 168.0, 166.0, 170.0, 169.0, 168.0, 164.0, 164.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 72.0, 69.0, 68.0, 71.0, 70.0, 72.0, 67.0, 66.0], "value": 69.6, "unit": "score"}]}]} 19:04:56 INFO - Return code: 0 19:04:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:04:56 ERROR - # TBPL SUCCESS # 19:04:56 INFO - Running post-action listener: _resource_record_post_action 19:04:56 INFO - ##### 19:04:56 INFO - ##### Finished run-tests step (success) 19:04:56 INFO - ##### 19:04:56 INFO - Running post-run listener: _resource_record_post_run 19:04:56 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534679552; Read time: 8; Write time: 618216 19:04:56 INFO - TinderboxPrint: CPU usage
13.3% 19:04:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:04:56 INFO - TinderboxPrint: I/O write bytes / time
534,679,552 / 618,216 19:04:56 INFO - TinderboxPrint: CPU idle
8,284.3 (86.7%) 19:04:56 INFO - TinderboxPrint: CPU user
1,220.1 (12.8%) 19:04:56 INFO - TinderboxPrint: Swap in / out
0 / 0 19:04:56 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 246292480; Read time: 0; Write time: 397552 19:04:56 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288083968; Read time: 0; Write time: 220628 19:04:56 INFO - Running post-run listener: _upload_blobber_files 19:04:56 INFO - Blob upload gear active. 19:04:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:04:56 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 19:04:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:04:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:04:57 INFO - (blobuploader) - INFO - Open directory for files ... 19:04:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:04:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:04:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:04:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:04:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:04:58 INFO - (blobuploader) - INFO - Done attempting. 19:04:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:04:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:04:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:05:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:05:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:05:02 INFO - (blobuploader) - INFO - Done attempting. 19:05:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:05:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:05:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:05:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:05:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:05:03 INFO - (blobuploader) - INFO - Done attempting. 19:05:03 INFO - (blobuploader) - INFO - Iteration through files over. 19:05:03 INFO - Return code: 0 19:05:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:05:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:05:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f87408309404bd86e04fd38a56c14dab47dbca40fadc079ee65b1bb381b4bf1dcc7d0b58cd5c55d1e416724f4c9bba7bc0256c96d9c11bbb490b2a27bf781848", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc28d4a8fb5e0f5b7e7459b78a797fdc60d0327d300da5e9a7fbae9d5391557de3334b4c27886b25f77dca22b0396eba2863fda76ed173bb58c0e927c7a7af06", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b001b3cf2aa72682a15d4820c4131b976acbb399ee32ed97b0a9deb73b110a86e275da2ba0edf0c257bd397df2748d70fa0a0fd03638d08b5af32a58b3cfecb"} 19:05:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:05:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:05:03 INFO - Contents: 19:05:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f87408309404bd86e04fd38a56c14dab47dbca40fadc079ee65b1bb381b4bf1dcc7d0b58cd5c55d1e416724f4c9bba7bc0256c96d9c11bbb490b2a27bf781848", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc28d4a8fb5e0f5b7e7459b78a797fdc60d0327d300da5e9a7fbae9d5391557de3334b4c27886b25f77dca22b0396eba2863fda76ed173bb58c0e927c7a7af06", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b001b3cf2aa72682a15d4820c4131b976acbb399ee32ed97b0a9deb73b110a86e275da2ba0edf0c257bd397df2748d70fa0a0fd03638d08b5af32a58b3cfecb"} 19:05:03 INFO - Running post-run listener: copy_logs_to_upload_dir 19:05:03 INFO - Copying logs to upload dir... 19:05:03 INFO - mkdir: /builds/slave/test/build/upload/logs 19:05:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.016717 ========= master_lag: 0.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-07 19:05:03.126131) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 19:05:03.133918) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087 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/Firefox-Non-PGO/sha512/f87408309404bd86e04fd38a56c14dab47dbca40fadc079ee65b1bb381b4bf1dcc7d0b58cd5c55d1e416724f4c9bba7bc0256c96d9c11bbb490b2a27bf781848", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc28d4a8fb5e0f5b7e7459b78a797fdc60d0327d300da5e9a7fbae9d5391557de3334b4c27886b25f77dca22b0396eba2863fda76ed173bb58c0e927c7a7af06", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b001b3cf2aa72682a15d4820c4131b976acbb399ee32ed97b0a9deb73b110a86e275da2ba0edf0c257bd397df2748d70fa0a0fd03638d08b5af32a58b3cfecb"} build_url:https://queue.taskcluster.net/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011230 build_url: 'https://queue.taskcluster.net/v1/task/T_wGXrZ-TBmKWnT_tq97Ww/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/Firefox-Non-PGO/sha512/f87408309404bd86e04fd38a56c14dab47dbca40fadc079ee65b1bb381b4bf1dcc7d0b58cd5c55d1e416724f4c9bba7bc0256c96d9c11bbb490b2a27bf781848", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc28d4a8fb5e0f5b7e7459b78a797fdc60d0327d300da5e9a7fbae9d5391557de3334b4c27886b25f77dca22b0396eba2863fda76ed173bb58c0e927c7a7af06", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b001b3cf2aa72682a15d4820c4131b976acbb399ee32ed97b0a9deb73b110a86e275da2ba0edf0c257bd397df2748d70fa0a0fd03638d08b5af32a58b3cfecb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 19:05:03.166275) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:05:03.166653) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467941944.322163-573108087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:05:03.216181) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 19:05:03.216488) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 19:05:03.216798) ========= ========= Total master_lag: 0.40 =========