builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-047 starttime: 1467939360.65 results: success (0) buildid: 20160707172126 builduid: 0f623c932f87495ca722f9b4ac359847 revision: e5f3271d0dbd01fcd0dbc5fad5e732c10ddf22ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 17:56:00.648751) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 17:56:00.649244) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 17:56:00.649593) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 17:56:00.699545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 17:56:00.699867) ========= 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=03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 17:56:00-- 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% 220M=0s 2016-07-07 17:56:00 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086755 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 17:56:00.816985) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 17:56:00.817385) ========= 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=03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019711 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 17:56:00.879122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 17:56:00.879549) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e5f3271d0dbd01fcd0dbc5fad5e732c10ddf22ef --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e5f3271d0dbd01fcd0dbc5fad5e732c10ddf22ef --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=03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 17:56:00,976 truncating revision to first 12 chars 2016-07-07 17:56:00,977 Setting DEBUG logging. 2016-07-07 17:56:00,977 attempt 1/10 2016-07-07 17:56:00,977 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e5f3271d0dbd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 17:56:01,524 unpacking tar archive at: fx-team-e5f3271d0dbd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.882398 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 17:56:01.779397) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 17:56:01.779735) ========= script_repo_revision: e5f3271d0dbd01fcd0dbc5fad5e732c10ddf22ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 17:56:01.780176) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 17:56:01.780458) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 17:56:01.802971) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-07 17:56:01.803261) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:56:01 INFO - MultiFileLogger online at 20160707 17:56:01 in /builds/slave/test 17:56:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:56:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:56:01 INFO - {'append_to_log': False, 17:56:01 INFO - 'base_work_dir': '/builds/slave/test', 17:56:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:56:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:56:01 INFO - 'branch': 'Fx-Team-Non-PGO', 17:56:01 INFO - 'buildbot_json_path': 'buildprops.json', 17:56:01 INFO - 'config_files': ('talos/linux_config.py',), 17:56:01 INFO - 'default_actions': ('clobber', 17:56:01 INFO - 'read-buildbot-config', 17:56:01 INFO - 'download-and-extract', 17:56:01 INFO - 'populate-webroot', 17:56:01 INFO - 'create-virtualenv', 17:56:01 INFO - 'install', 17:56:01 INFO - 'run-tests'), 17:56:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:56:01 INFO - 'download_minidump_stackwalk': True, 17:56:01 INFO - 'download_symbols': 'ondemand', 17:56:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:56:01 INFO - 'tooltool.py': '/tools/tooltool.py', 17:56:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:56:01 INFO - '/tools/misc-python/virtualenv.py')}, 17:56:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:56:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:56:01 INFO - 'installer_path': 'installer.exe', 17:56:01 INFO - 'log_level': 'info', 17:56:01 INFO - 'log_name': 'talos', 17:56:01 INFO - 'log_to_console': True, 17:56:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:56:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:56:01 INFO - 'opt_config_files': (), 17:56:01 INFO - 'pip_index': False, 17:56:01 INFO - 'sps_profile': False, 17:56:01 INFO - 'sps_profile_interval': 0, 17:56:01 INFO - 'suite': 'dromaeojs-e10s', 17:56:01 INFO - 'system_bits': '32', 17:56:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:56:01 INFO - 'title': 'talos-linux64-ix-047', 17:56:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:56:01 INFO - 'use_talos_json': True, 17:56:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:56:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:56:01 INFO - 'work_dir': 'build'} 17:56:01 INFO - ##### 17:56:01 INFO - ##### Running clobber step. 17:56:01 INFO - ##### 17:56:01 INFO - Running pre-action listener: _resource_record_pre_action 17:56:01 INFO - Running main action method: clobber 17:56:01 INFO - rmtree: /builds/slave/test/build 17:56:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:56:02 INFO - Running post-action listener: _resource_record_post_action 17:56:02 INFO - ##### 17:56:02 INFO - ##### Finished clobber step (success) 17:56:02 INFO - ##### 17:56:02 INFO - ##### 17:56:02 INFO - ##### Running read-buildbot-config step. 17:56:02 INFO - ##### 17:56:02 INFO - Running pre-action listener: _resource_record_pre_action 17:56:02 INFO - Running main action method: read_buildbot_config 17:56:02 INFO - Using buildbot properties: 17:56:02 INFO - { 17:56:02 INFO - "project": "", 17:56:02 INFO - "product": "firefox", 17:56:02 INFO - "script_repo_revision": "production", 17:56:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:56:02 INFO - "repository": "", 17:56:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 17:56:02 INFO - "buildid": "20160707172126", 17:56:02 INFO - "pgo_build": "False", 17:56:02 INFO - "basedir": "/builds/slave/test", 17:56:02 INFO - "buildnumber": 1428, 17:56:02 INFO - "slavename": "talos-linux64-ix-047", 17:56:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:56:02 INFO - "platform": "ubuntu64_hw", 17:56:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:56:02 INFO - "branch": "fx-team", 17:56:02 INFO - "repo_path": "integration/fx-team", 17:56:02 INFO - "revision": "e5f3271d0dbd01fcd0dbc5fad5e732c10ddf22ef", 17:56:02 INFO - "stage_platform": "linux64", 17:56:02 INFO - "builduid": "0f623c932f87495ca722f9b4ac359847", 17:56:02 INFO - "slavebuilddir": "test" 17:56:02 INFO - } 17:56:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:56:02 INFO - Running post-action listener: _resource_record_post_action 17:56:02 INFO - ##### 17:56:02 INFO - ##### Finished read-buildbot-config step (success) 17:56:02 INFO - ##### 17:56:02 INFO - ##### 17:56:02 INFO - ##### Running download-and-extract step. 17:56:02 INFO - ##### 17:56:02 INFO - Running pre-action listener: _resource_record_pre_action 17:56:02 INFO - Running main action method: download_and_extract 17:56:02 INFO - mkdir: /builds/slave/test/build/tests 17:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:56:02 INFO - https://queue.taskcluster.net/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:56:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:56:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:56:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/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 17:56:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/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 17:56:05 INFO - Downloaded 1361 bytes. 17:56:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:56:05 INFO - Using the following test package requirements: 17:56:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:56:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:56:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:56:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:05 INFO - u'jsshell-linux-x86_64.zip'], 17:56:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:56:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:56:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:56:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:56:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:56:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:56:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:56:05 INFO - https://queue.taskcluster.net/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:56:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:56:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:56:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/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 17:56:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/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 17:56:06 INFO - Downloaded 22734622 bytes. 17:56:06 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'] 17:56:06 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 17:56:07 INFO - Return code: 0 17:56:07 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 17:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:56:07 INFO - https://queue.taskcluster.net/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:56:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:56:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:56:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/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 17:56:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/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 17:56:24 INFO - Downloaded 22734622 bytes. 17:56: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'] 17:56: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 17:56:25 INFO - Return code: 0 17:56: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')]} 17:56:25 INFO - https://queue.taskcluster.net/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:56:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:56:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:56:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/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 17:56:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/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 17:56:26 INFO - Downloaded 14403333 bytes. 17:56:26 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'] 17:56:26 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 17:56:26 INFO - Return code: 0 17:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:56:26 INFO - https://queue.taskcluster.net/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:56:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:56:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:56:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/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 17:56:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSn2p32sSQOeTDLFemWHBw/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 17:56:28 INFO - Downloaded 56646849 bytes. 17:56:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:56:28 INFO - mkdir: /builds/slave/test/properties 17:56:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:56:28 INFO - Writing to file /builds/slave/test/properties/build_url 17:56:28 INFO - Contents: 17:56:28 INFO - build_url:https://queue.taskcluster.net/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:56:28 INFO - Running post-action listener: _resource_record_post_action 17:56:28 INFO - Running post-action listener: set_extra_try_arguments 17:56:28 INFO - ##### 17:56:28 INFO - ##### Finished download-and-extract step (success) 17:56:28 INFO - ##### 17:56:28 INFO - ##### 17:56:28 INFO - ##### Running populate-webroot step. 17:56:28 INFO - ##### 17:56:28 INFO - Running pre-action listener: _resource_record_pre_action 17:56:28 INFO - Running main action method: populate_webroot 17:56:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:56:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:56:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:56:28 INFO - '--tppagecycles', 17:56:28 INFO - '7'], 17:56:28 INFO - 'tests': ['tsvgm']}}, 17:56:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:56:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:56:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:56:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:56:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:56:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:56:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:28 INFO - 'talos_options': ['--disable-e10s'], 17:56:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:28 INFO - 'talos_options': ['--disable-e10s'], 17:56:28 INFO - 'tests': ['damp', 'tps']}, 17:56:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:28 INFO - 'tests': ['damp', 'tps']}, 17:56:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:56:28 INFO - 'tests': ['dromaeo_dom']}, 17:56:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:56:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:56:28 INFO - 'tests': ['basic_compositor_video']}, 17:56:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:56:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:56:28 INFO - 'tests': ['a11yr', 17:56:28 INFO - 'ts_paint', 17:56:28 INFO - 'tpaint', 17:56:28 INFO - 'sessionrestore', 17:56:28 INFO - 'sessionrestore_no_auto_restore', 17:56:28 INFO - 'tabpaint']}, 17:56:28 INFO - 'other-e10s': {'tests': ['a11yr', 17:56:28 INFO - 'ts_paint', 17:56:28 INFO - 'tpaint', 17:56:28 INFO - 'sessionrestore', 17:56:28 INFO - 'sessionrestore_no_auto_restore', 17:56:28 INFO - 'tabpaint']}, 17:56:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:56:28 INFO - 'ts_paint', 17:56:28 INFO - 'tpaint', 17:56:28 INFO - 'sessionrestore', 17:56:28 INFO - 'sessionrestore_no_auto_restore', 17:56:28 INFO - 'tabpaint']}, 17:56:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:56:28 INFO - 'ts_paint', 17:56:28 INFO - 'tpaint', 17:56:28 INFO - 'sessionrestore', 17:56:28 INFO - 'sessionrestore_no_auto_restore', 17:56:28 INFO - 'tabpaint']}, 17:56:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:56:28 INFO - 'tests': ['a11yr', 17:56:28 INFO - 'ts_paint', 17:56:28 INFO - 'tpaint', 17:56:28 INFO - 'sessionrestore', 17:56:28 INFO - 'sessionrestore_no_auto_restore', 17:56:28 INFO - 'tabpaint']}, 17:56:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:56:28 INFO - 'tests': ['a11yr', 17:56:28 INFO - 'ts_paint', 17:56:28 INFO - 'tpaint', 17:56:28 INFO - 'sessionrestore', 17:56:28 INFO - 'sessionrestore_no_auto_restore', 17:56:28 INFO - 'tabpaint']}, 17:56:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:56:28 INFO - 'tests': ['tsvgx', 17:56:28 INFO - 'tsvgr_opacity', 17:56:28 INFO - 'tart', 17:56:28 INFO - 'tscrollx', 17:56:28 INFO - 'cart']}, 17:56:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:56:28 INFO - 'tsvgr_opacity', 17:56:28 INFO - 'tart', 17:56:28 INFO - 'tscrollx', 17:56:28 INFO - 'cart']}, 17:56:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:28 INFO - 'talos_options': ['--disable-e10s'], 17:56:28 INFO - 'tests': ['tp5o']}, 17:56:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:28 INFO - 'tests': ['tp5o']}, 17:56:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:28 INFO - 'talos_options': ['--disable-e10s', 17:56:28 INFO - '--xperf_path', 17:56:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:28 INFO - 'tests': ['tp5n']}, 17:56:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:28 INFO - 'talos_options': ['--xperf_path', 17:56:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:28 INFO - 'tests': ['tp5n']}}, 17:56:28 INFO - 'talos.zip': {'path': '', 17:56:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:56:28 INFO - Running post-action listener: _resource_record_post_action 17:56:28 INFO - ##### 17:56:28 INFO - ##### Finished populate-webroot step (success) 17:56:28 INFO - ##### 17:56:28 INFO - ##### 17:56:28 INFO - ##### Running create-virtualenv step. 17:56:28 INFO - ##### 17:56:28 INFO - Running pre-action listener: _resource_record_pre_action 17:56:28 INFO - Running main action method: create_virtualenv 17:56:28 INFO - Creating virtualenv /builds/slave/test/build/venv 17:56:28 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 17:56:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:56:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:56:29 INFO - Using real prefix '/usr' 17:56:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:56:29 INFO - Installing distribute.............................................................................................................................................................................................done. 17:56:31 INFO - Installing pip.................done. 17:56:31 INFO - Return code: 0 17:56:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:56: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')]} 17:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56: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')]} 17:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x214a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2379400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408570>, '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 0x2409470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409900>, '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': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', '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 17:56:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:56:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:56:31 INFO - Using env: {'DISPLAY': ':0', 17:56:31 INFO - 'HOME': '/home/cltbld', 17:56:31 INFO - 'LANG': 'en_US.UTF-8', 17:56:31 INFO - 'LANGUAGE': 'en_US:en', 17:56:31 INFO - 'LOGNAME': 'cltbld', 17:56:31 INFO - 'MAIL': '/var/mail/cltbld', 17:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:31 INFO - 'MOZ_NO_REMOTE': '1', 17:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:31 INFO - 'NO_EM_RESTART': '1', 17:56:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:31 INFO - 'PWD': '/builds/slave/test', 17:56:31 INFO - 'SHELL': '/bin/bash', 17:56:31 INFO - 'SHLVL': '1', 17:56:31 INFO - 'TERM': 'linux', 17:56:31 INFO - 'TMOUT': '86400', 17:56:31 INFO - 'USER': 'cltbld', 17:56:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', 17:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:31 INFO - '_': '/tools/buildbot/bin/python'} 17:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:31 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 17:56:31 INFO - Cleaning up... 17:56:31 INFO - Return code: 0 17:56:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:56: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')]} 17:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56: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')]} 17:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x214a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2379400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408570>, '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 0x2409470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409900>, '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': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', '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 17:56:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:56:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:56:31 INFO - Using env: {'DISPLAY': ':0', 17:56:31 INFO - 'HOME': '/home/cltbld', 17:56:31 INFO - 'LANG': 'en_US.UTF-8', 17:56:31 INFO - 'LANGUAGE': 'en_US:en', 17:56:31 INFO - 'LOGNAME': 'cltbld', 17:56:31 INFO - 'MAIL': '/var/mail/cltbld', 17:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:31 INFO - 'MOZ_NO_REMOTE': '1', 17:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:31 INFO - 'NO_EM_RESTART': '1', 17:56:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:31 INFO - 'PWD': '/builds/slave/test', 17:56:31 INFO - 'SHELL': '/bin/bash', 17:56:31 INFO - 'SHLVL': '1', 17:56:31 INFO - 'TERM': 'linux', 17:56:31 INFO - 'TMOUT': '86400', 17:56:31 INFO - 'USER': 'cltbld', 17:56:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', 17:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:31 INFO - '_': '/tools/buildbot/bin/python'} 17:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:32 INFO - Downloading/unpacking psutil>=3.1.1 17:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:56:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:34 INFO - Installing collected packages: psutil 17:56:34 INFO - Running setup.py install for psutil 17:56:34 INFO - building 'psutil._psutil_linux' extension 17:56:34 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 17:56:34 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 17:56:34 INFO - building 'psutil._psutil_posix' extension 17:56:34 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 17:56:34 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 17:56:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:34 INFO - Successfully installed psutil 17:56:34 INFO - Cleaning up... 17:56:34 INFO - Return code: 0 17:56:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x214a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2379400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408570>, '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 0x2409470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409900>, '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': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', '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 17:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:56:34 INFO - Using env: {'DISPLAY': ':0', 17:56:34 INFO - 'HOME': '/home/cltbld', 17:56:34 INFO - 'LANG': 'en_US.UTF-8', 17:56:34 INFO - 'LANGUAGE': 'en_US:en', 17:56:34 INFO - 'LOGNAME': 'cltbld', 17:56:34 INFO - 'MAIL': '/var/mail/cltbld', 17:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:34 INFO - 'MOZ_NO_REMOTE': '1', 17:56:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:34 INFO - 'NO_EM_RESTART': '1', 17:56:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:34 INFO - 'PWD': '/builds/slave/test', 17:56:34 INFO - 'SHELL': '/bin/bash', 17:56:34 INFO - 'SHLVL': '1', 17:56:34 INFO - 'TERM': 'linux', 17:56:34 INFO - 'TMOUT': '86400', 17:56:34 INFO - 'USER': 'cltbld', 17:56:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', 17:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:34 INFO - '_': '/tools/buildbot/bin/python'} 17:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:56:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:56:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:56:36 INFO - Installing collected packages: mozsystemmonitor 17:56:36 INFO - Running setup.py install for mozsystemmonitor 17:56:36 INFO - Successfully installed mozsystemmonitor 17:56:36 INFO - Cleaning up... 17:56:36 INFO - Return code: 0 17:56:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x214a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2379400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408570>, '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 0x2409470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409900>, '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': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', '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 17:56:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:56:36 INFO - Using env: {'DISPLAY': ':0', 17:56:36 INFO - 'HOME': '/home/cltbld', 17:56:36 INFO - 'LANG': 'en_US.UTF-8', 17:56:36 INFO - 'LANGUAGE': 'en_US:en', 17:56:36 INFO - 'LOGNAME': 'cltbld', 17:56:36 INFO - 'MAIL': '/var/mail/cltbld', 17:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:36 INFO - 'MOZ_NO_REMOTE': '1', 17:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:36 INFO - 'NO_EM_RESTART': '1', 17:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:36 INFO - 'PWD': '/builds/slave/test', 17:56:36 INFO - 'SHELL': '/bin/bash', 17:56:36 INFO - 'SHLVL': '1', 17:56:36 INFO - 'TERM': 'linux', 17:56:36 INFO - 'TMOUT': '86400', 17:56:36 INFO - 'USER': 'cltbld', 17:56:36 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', 17:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:36 INFO - '_': '/tools/buildbot/bin/python'} 17:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:37 INFO - Downloading/unpacking jsonschema==2.5.1 17:56:37 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 17:56:37 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 17:56:37 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 17:56:37 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 17:56:37 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 17:56:37 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 17:56:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:56:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:56: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 17:56: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 17:56: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 17:56: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 17:56: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 17:56: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 17:56:39 INFO - Downloading functools32-3.2.3-2.tar.gz 17:56:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:56:39 INFO - warning: no files found matching '*.txt' 17:56:39 INFO - no previously-included directories found matching 'build' 17:56:39 INFO - no previously-included directories found matching 'dist' 17:56:39 INFO - no previously-included directories found matching '.git*' 17:56:39 INFO - Installing collected packages: jsonschema, functools32 17:56:39 INFO - Running setup.py install for functools32 17:56:39 INFO - warning: no files found matching '*.txt' 17:56:39 INFO - no previously-included directories found matching 'build' 17:56:39 INFO - no previously-included directories found matching 'dist' 17:56:39 INFO - no previously-included directories found matching '.git*' 17:56:39 INFO - Successfully installed jsonschema functools32 17:56:39 INFO - Cleaning up... 17:56:39 INFO - Return code: 0 17:56:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:56:39 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')]} 17:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:39 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')]} 17:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:39 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 0x214a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2379400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408570>, '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 0x2409470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409900>, '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': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', '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 17:56:39 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 17:56:39 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 17:56:39 INFO - Using env: {'DISPLAY': ':0', 17:56:39 INFO - 'HOME': '/home/cltbld', 17:56:39 INFO - 'LANG': 'en_US.UTF-8', 17:56:39 INFO - 'LANGUAGE': 'en_US:en', 17:56:39 INFO - 'LOGNAME': 'cltbld', 17:56:39 INFO - 'MAIL': '/var/mail/cltbld', 17:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:39 INFO - 'MOZ_NO_REMOTE': '1', 17:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:39 INFO - 'NO_EM_RESTART': '1', 17:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:39 INFO - 'PWD': '/builds/slave/test', 17:56:39 INFO - 'SHELL': '/bin/bash', 17:56:39 INFO - 'SHLVL': '1', 17:56:39 INFO - 'TERM': 'linux', 17:56:39 INFO - 'TMOUT': '86400', 17:56:39 INFO - 'USER': 'cltbld', 17:56:39 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', 17:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:39 INFO - '_': '/tools/buildbot/bin/python'} 17:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:39 INFO - Downloading/unpacking blobuploader==1.2.4 17:56:39 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 17:56:39 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 17:56:39 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 17:56:39 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 17:56:39 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 17:56:39 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 17:56:41 INFO - Downloading blobuploader-1.2.4.tar.gz 17:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:56:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:56: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 17:56: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 17:56: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 17:56: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 17:56: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 17:56: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 17:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:56:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:42 INFO - Downloading docopt-0.6.1.tar.gz 17:56:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:56:42 INFO - Installing collected packages: blobuploader, requests, docopt 17:56:42 INFO - Running setup.py install for blobuploader 17:56:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:56:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:56:42 INFO - Running setup.py install for requests 17:56:42 INFO - Running setup.py install for docopt 17:56:42 INFO - Successfully installed blobuploader requests docopt 17:56:42 INFO - Cleaning up... 17:56:43 INFO - Return code: 0 17:56:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56: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')]} 17:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56: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')]} 17:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:43 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 0x214a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2379400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408570>, '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 0x2409470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409900>, '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': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', '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 17:56:43 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 17:56:43 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 17:56:43 INFO - Using env: {'DISPLAY': ':0', 17:56:43 INFO - 'HOME': '/home/cltbld', 17:56:43 INFO - 'LANG': 'en_US.UTF-8', 17:56:43 INFO - 'LANGUAGE': 'en_US:en', 17:56:43 INFO - 'LOGNAME': 'cltbld', 17:56:43 INFO - 'MAIL': '/var/mail/cltbld', 17:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:43 INFO - 'MOZ_NO_REMOTE': '1', 17:56:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:43 INFO - 'NO_EM_RESTART': '1', 17:56:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:43 INFO - 'PWD': '/builds/slave/test', 17:56:43 INFO - 'SHELL': '/bin/bash', 17:56:43 INFO - 'SHLVL': '1', 17:56:43 INFO - 'TERM': 'linux', 17:56:43 INFO - 'TMOUT': '86400', 17:56:43 INFO - 'USER': 'cltbld', 17:56:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', 17:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:43 INFO - '_': '/tools/buildbot/bin/python'} 17:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:56:43 INFO - Running setup.py (path:/tmp/pip-ARXkMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:56:43 INFO - Running setup.py (path:/tmp/pip-D8zQzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:56:43 INFO - Running setup.py (path:/tmp/pip-khbM9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:56:43 INFO - Running setup.py (path:/tmp/pip-f0GDvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:56:43 INFO - Running setup.py (path:/tmp/pip-Dq6alM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:56:43 INFO - Running setup.py (path:/tmp/pip-lixVsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:56:43 INFO - Running setup.py (path:/tmp/pip-1xHFio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:56:43 INFO - Running setup.py (path:/tmp/pip-5L5C4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:56:43 INFO - Running setup.py (path:/tmp/pip-x09wKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:56:43 INFO - Running setup.py (path:/tmp/pip-J1wzKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:56:43 INFO - Running setup.py (path:/tmp/pip-YeBzjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:56:44 INFO - Running setup.py (path:/tmp/pip-0xIogG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:56:44 INFO - Running setup.py (path:/tmp/pip-8Up6jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:56:44 INFO - Running setup.py (path:/tmp/pip-ydNDBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:44 INFO - Running setup.py (path:/tmp/pip-6gV7ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:56:44 INFO - Running setup.py (path:/tmp/pip-lJVAVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:56:44 INFO - Running setup.py (path:/tmp/pip-7VFHas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:56:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:56:44 INFO - Running setup.py install for manifestparser 17:56:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:56:44 INFO - Running setup.py install for mozcrash 17:56:44 INFO - Running setup.py install for mozdebug 17:56:44 INFO - Running setup.py install for mozdevice 17:56:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:56:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:56:44 INFO - Running setup.py install for mozfile 17:56:44 INFO - Running setup.py install for mozhttpd 17:56:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:56:45 INFO - Running setup.py install for mozinfo 17:56:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:56:45 INFO - Running setup.py install for mozInstall 17:56:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:56:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:56:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:56:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:56:45 INFO - Running setup.py install for mozleak 17:56:45 INFO - Running setup.py install for mozlog 17:56:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:56:45 INFO - Running setup.py install for moznetwork 17:56:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:56:45 INFO - Running setup.py install for mozprocess 17:56:45 INFO - Running setup.py install for mozprofile 17:56:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:56:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:56:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:56:45 INFO - Running setup.py install for mozrunner 17:56:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:56:45 INFO - Running setup.py install for mozscreenshot 17:56:46 INFO - Running setup.py install for moztest 17:56:46 INFO - Running setup.py install for mozversion 17:56:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:56:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:56:46 INFO - Cleaning up... 17:56:46 INFO - Return code: 0 17:56:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56: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')]} 17:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56: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')]} 17:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:46 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 0x214a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2379400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408570>, '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 0x2409470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409900>, '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': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', '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 17:56:46 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 17:56:46 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 17:56:46 INFO - Using env: {'DISPLAY': ':0', 17:56:46 INFO - 'HOME': '/home/cltbld', 17:56:46 INFO - 'LANG': 'en_US.UTF-8', 17:56:46 INFO - 'LANGUAGE': 'en_US:en', 17:56:46 INFO - 'LOGNAME': 'cltbld', 17:56:46 INFO - 'MAIL': '/var/mail/cltbld', 17:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:46 INFO - 'MOZ_NO_REMOTE': '1', 17:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:46 INFO - 'NO_EM_RESTART': '1', 17:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:46 INFO - 'PWD': '/builds/slave/test', 17:56:46 INFO - 'SHELL': '/bin/bash', 17:56:46 INFO - 'SHLVL': '1', 17:56:46 INFO - 'TERM': 'linux', 17:56:46 INFO - 'TMOUT': '86400', 17:56:46 INFO - 'USER': 'cltbld', 17:56:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', 17:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:46 INFO - '_': '/tools/buildbot/bin/python'} 17:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:56:46 INFO - Running setup.py (path:/tmp/pip-lC68FV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:56:46 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)) 17:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:56:46 INFO - Running setup.py (path:/tmp/pip-f62snR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:56:46 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)) 17:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:56:46 INFO - Running setup.py (path:/tmp/pip-SzOXFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:56:46 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)) 17:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:56:46 INFO - Running setup.py (path:/tmp/pip-8JF89v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:56:46 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)) 17:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:56:46 INFO - Running setup.py (path:/tmp/pip-MSgm_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:56:46 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)) 17:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:56:46 INFO - Running setup.py (path:/tmp/pip-RRGCXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:56:46 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)) 17:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:56:46 INFO - Running setup.py (path:/tmp/pip-TicSqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:56:46 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)) 17:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:56:46 INFO - Running setup.py (path:/tmp/pip-uYZ4hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:56:47 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)) 17:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:56:47 INFO - Running setup.py (path:/tmp/pip-qg0NuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:56:47 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)) 17:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:56:47 INFO - Running setup.py (path:/tmp/pip-BxYVoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:56:47 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)) 17:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:56:47 INFO - Running setup.py (path:/tmp/pip-zsGncv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:56:47 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)) 17:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:56:47 INFO - Running setup.py (path:/tmp/pip-ZOmDlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:56:47 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)) 17:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:56:47 INFO - Running setup.py (path:/tmp/pip-PuOJ5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:56:47 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)) 17:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:56:47 INFO - Running setup.py (path:/tmp/pip-nTJvZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:56:47 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)) 17:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:47 INFO - Running setup.py (path:/tmp/pip-I6TIc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:47 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)) 17:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:56:47 INFO - Running setup.py (path:/tmp/pip-W0aPnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:56:47 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)) 17:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:56:47 INFO - Running setup.py (path:/tmp/pip-frP8Z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:56:47 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)) 17:56:47 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)) 17:56:47 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)) 17:56:47 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)) 17:56:47 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)) 17:56:47 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)) 17:56:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:56:47 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 17:56:47 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 17:56:47 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 17:56:47 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 17:56:47 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 17:56:47 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 17:56:49 INFO - Downloading blessings-1.6.tar.gz 17:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:56:49 INFO - Installing collected packages: blessings 17:56:49 INFO - Running setup.py install for blessings 17:56:49 INFO - Successfully installed blessings 17:56:49 INFO - Cleaning up... 17:56:49 INFO - Return code: 0 17:56:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:56:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:50 INFO - Reading from file tmpfile_stdout 17:56:50 INFO - Current package versions: 17:56:50 INFO - argparse == 1.2.1 17:56:50 INFO - blessings == 1.6 17:56:50 INFO - blobuploader == 1.2.4 17:56:50 INFO - docopt == 0.6.1 17:56:50 INFO - functools32 == 3.2.3-2 17:56:50 INFO - jsonschema == 2.5.1 17:56:50 INFO - manifestparser == 1.1 17:56:50 INFO - mozInstall == 1.12 17:56:50 INFO - mozcrash == 0.17 17:56:50 INFO - mozdebug == 0.1 17:56:50 INFO - mozdevice == 0.48 17:56:50 INFO - mozfile == 1.2 17:56:50 INFO - mozhttpd == 0.7 17:56:50 INFO - mozinfo == 0.9 17:56:50 INFO - mozleak == 0.1 17:56:50 INFO - mozlog == 3.2 17:56:50 INFO - moznetwork == 0.27 17:56:50 INFO - mozprocess == 0.23 17:56:50 INFO - mozprofile == 0.28 17:56:50 INFO - mozrunner == 6.12 17:56:50 INFO - mozscreenshot == 0.1 17:56:50 INFO - mozsystemmonitor == 0.3 17:56:50 INFO - moztest == 0.7 17:56:50 INFO - mozversion == 1.4 17:56:50 INFO - psutil == 3.1.1 17:56:50 INFO - requests == 1.2.3 17:56:50 INFO - wsgiref == 0.1.2 17:56:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:50 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')]} 17:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:50 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')]} 17:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:50 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 0x214a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2379400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408570>, '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 0x2409470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409900>, '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': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', '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 17:56:50 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 17:56:50 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 17:56:50 INFO - Using env: {'DISPLAY': ':0', 17:56:50 INFO - 'HOME': '/home/cltbld', 17:56:50 INFO - 'LANG': 'en_US.UTF-8', 17:56:50 INFO - 'LANGUAGE': 'en_US:en', 17:56:50 INFO - 'LOGNAME': 'cltbld', 17:56:50 INFO - 'MAIL': '/var/mail/cltbld', 17:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:50 INFO - 'MOZ_NO_REMOTE': '1', 17:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:50 INFO - 'NO_EM_RESTART': '1', 17:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:50 INFO - 'PWD': '/builds/slave/test', 17:56:50 INFO - 'SHELL': '/bin/bash', 17:56:50 INFO - 'SHLVL': '1', 17:56:50 INFO - 'TERM': 'linux', 17:56:50 INFO - 'TMOUT': '86400', 17:56:50 INFO - 'USER': 'cltbld', 17:56:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', 17:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:50 INFO - '_': '/tools/buildbot/bin/python'} 17:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:50 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)) 17:56:50 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)) 17:56:50 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)) 17:56:50 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)) 17:56:50 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)) 17:56:50 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)) 17:56:50 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)) 17:56:50 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)) 17:56:50 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)) 17:56:50 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)) 17:56:50 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)) 17:56:50 INFO - Cleaning up... 17:56:50 INFO - Return code: 0 17:56:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:56:50 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')]} 17:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:50 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')]} 17:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:50 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 0x214a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2379400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408570>, '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 0x2409470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409900>, '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': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', '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 17:56:50 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 17:56:50 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 17:56:50 INFO - Using env: {'DISPLAY': ':0', 17:56:50 INFO - 'HOME': '/home/cltbld', 17:56:50 INFO - 'LANG': 'en_US.UTF-8', 17:56:50 INFO - 'LANGUAGE': 'en_US:en', 17:56:50 INFO - 'LOGNAME': 'cltbld', 17:56:50 INFO - 'MAIL': '/var/mail/cltbld', 17:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:50 INFO - 'MOZ_NO_REMOTE': '1', 17:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:50 INFO - 'NO_EM_RESTART': '1', 17:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:50 INFO - 'PWD': '/builds/slave/test', 17:56:50 INFO - 'SHELL': '/bin/bash', 17:56:50 INFO - 'SHLVL': '1', 17:56:50 INFO - 'TERM': 'linux', 17:56:50 INFO - 'TMOUT': '86400', 17:56:50 INFO - 'USER': 'cltbld', 17:56:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', 17:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:50 INFO - '_': '/tools/buildbot/bin/python'} 17:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:56:50 INFO - Cleaning up... 17:56:50 INFO - Return code: 0 17:56:50 INFO - Running post-action listener: _resource_record_post_action 17:56:50 INFO - Running post-action listener: _start_resource_monitoring 17:56:50 INFO - Starting resource monitoring. 17:56:50 INFO - ##### 17:56:50 INFO - ##### Finished create-virtualenv step (success) 17:56:50 INFO - ##### 17:56:50 INFO - ##### 17:56:50 INFO - ##### Running install step. 17:56:50 INFO - ##### 17:56:50 INFO - Running pre-action listener: _resource_record_pre_action 17:56:50 INFO - Running main action method: install 17:56:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:50 INFO - Reading from file tmpfile_stdout 17:56:50 INFO - Detecting whether we're running mozinstall >=1.0... 17:56:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:56:50 INFO - Reading from file tmpfile_stdout 17:56:50 INFO - Output received: 17:56:50 INFO - Usage: mozinstall [options] installer 17:56:50 INFO - Options: 17:56:50 INFO - -h, --help show this help message and exit 17:56:50 INFO - -d DEST, --destination=DEST 17:56:50 INFO - Directory to install application into. [default: 17:56:50 INFO - "/builds/slave/test"] 17:56:50 INFO - --app=APP Application being installed. [default: firefox] 17:56:50 INFO - mkdir: /builds/slave/test/build/application 17:56:50 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'] 17:56:50 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 17:57:07 INFO - Reading from file tmpfile_stdout 17:57:07 INFO - Output received: 17:57:07 INFO - /builds/slave/test/build/application/firefox/firefox 17:57:07 INFO - Running post-action listener: _resource_record_post_action 17:57:07 INFO - ##### 17:57:07 INFO - ##### Finished install step (success) 17:57:07 INFO - ##### 17:57:07 INFO - ##### 17:57:07 INFO - ##### Running run-tests step. 17:57:07 INFO - ##### 17:57:07 INFO - Running pre-action listener: _resource_record_pre_action 17:57:07 INFO - Running main action method: run_tests 17:57:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:57:07 INFO - Python 2.7.3 17:57:07 INFO - Return code: 0 17:57:07 INFO - grabbing minidump binary from tooltool 17:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:57:07 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 0x2408570>, '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 0x2409470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:57:07 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 17:57:07 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 17:57:07 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 17:57:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:57:07 INFO - Return code: 0 17:57:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:57:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:57:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:57:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:57:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:57:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 17:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 17:57:07 INFO - Using env: {'DISPLAY': ':0', 17:57:07 INFO - 'HOME': '/home/cltbld', 17:57:07 INFO - 'LANG': 'en_US.UTF-8', 17:57:07 INFO - 'LANGUAGE': 'en_US:en', 17:57:07 INFO - 'LOGNAME': 'cltbld', 17:57:07 INFO - 'MAIL': '/var/mail/cltbld', 17:57:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:57:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:07 INFO - 'MOZ_NO_REMOTE': '1', 17:57:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:07 INFO - 'NO_EM_RESTART': '1', 17:57:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:07 INFO - 'PWD': '/builds/slave/test', 17:57:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:57:07 INFO - 'SHELL': '/bin/bash', 17:57:07 INFO - 'SHLVL': '1', 17:57:07 INFO - 'TERM': 'linux', 17:57:07 INFO - 'TMOUT': '86400', 17:57:07 INFO - 'USER': 'cltbld', 17:57:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549', 17:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:07 INFO - '_': '/tools/buildbot/bin/python'} 17:57:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 17:57:07 INFO - mozversion application_buildid: 20160707172126 17:57:07 INFO - mozversion application_changeset: e5f3271d0dbd01fcd0dbc5fad5e732c10ddf22ef 17:57:07 INFO - mozversion application_display_name: Nightly 17:57:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:57:07 INFO - mozversion application_name: Firefox 17:57:07 INFO - mozversion application_remotingname: firefox 17:57:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:57:07 INFO - mozversion application_vendor: Mozilla 17:57:07 INFO - mozversion application_version: 50.0a1 17:57:07 INFO - mozversion platform_buildid: 20160707172126 17:57:07 INFO - mozversion platform_changeset: e5f3271d0dbd01fcd0dbc5fad5e732c10ddf22ef 17:57:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:57:07 INFO - mozversion platform_version: 50.0a1 17:57:07 INFO - using testdate: 1467939427 17:57:07 INFO - actual date: 1467939427 17:57:07 INFO - starting webserver on 'localhost:51362' 17:57:07 INFO - SUITE-START | Running 2 tests 17:57:07 INFO - TEST-START | dromaeo_css 17:57:07 INFO - operating with platform_type : linux_ 17:57:07 INFO - Initialising browser for dromaeo_css test... 17:57:07 INFO - TEST-INFO | started process 25207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTYKbGp/profile http://localhost:51362/getInfo.html) 17:57:12 INFO - PROCESS | 25207 | __metrics Screen width/height:1600/1200 17:57:12 INFO - PROCESS | 25207 | colorDepth:24 17:57:12 INFO - PROCESS | 25207 | Browser inner width/height: 1024/697 17:57:12 INFO - PROCESS | 25207 | __metrics 17:57:12 ERROR - PROCESS | 25207 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 17:57:13 INFO - TEST-INFO | 25207: exit 0 17:57:13 INFO - Browser initialized. 17:57:13 INFO - Running cycle 1/1 for dromaeo_css test... 17:57:13 INFO - TEST-INFO | started process 25330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTYKbGp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:57:25 INFO - PROCESS | 25330 | RSS: Main: 168984576 17:57:25 INFO - PROCESS | 25330 | 17:58:15 INFO - PROCESS | 25330 | 1467939495357 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:00:27 INFO - PROCESS | 25330 | Cycle 1(1): loaded http://localhost:51362/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51362/tests/dromaeo/cssquery-ext.html) 18:00:28 INFO - PROCESS | 25330 | RSS: Main: 169218048 18:00:28 INFO - PROCESS | 25330 | 18:03:30 INFO - PROCESS | 25330 | Cycle 1(1): loaded http://localhost:51362/tests/dromaeo/cssquery-ext.html (next: http://localhost:51362/tests/dromaeo/cssquery-jquery.html) 18:03:31 INFO - PROCESS | 25330 | RSS: Main: 168542208 18:03:31 INFO - PROCESS | 25330 | 18:06:33 INFO - PROCESS | 25330 | Cycle 1(1): loaded http://localhost:51362/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51362/tests/dromaeo/cssquery-mootools.html) 18:06:33 INFO - PROCESS | 25330 | RSS: Main: 172109824 18:06:33 INFO - PROCESS | 25330 | 18:09:35 INFO - PROCESS | 25330 | Cycle 1(1): loaded http://localhost:51362/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51362/tests/dromaeo/cssquery-prototype.html) 18:09:36 INFO - PROCESS | 25330 | RSS: Main: 167915520 18:09:36 INFO - PROCESS | 25330 | 18:12:39 INFO - PROCESS | 25330 | Cycle 1(1): loaded http://localhost:51362/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51362/tests/dromaeo/cssquery-yui.html) 18:12:40 INFO - PROCESS | 25330 | RSS: Main: 168964096 18:12:40 INFO - PROCESS | 25330 | 18:15:42 INFO - PROCESS | 25330 | Cycle 1(1): loaded http://localhost:51362/tests/dromaeo/cssquery-yui.html (next: http://localhost:51362/tests/dromaeo/cssquery-dojo.html) 18:15:42 INFO - PROCESS | 25330 | RSS: Main: 170549248 18:15:42 INFO - PROCESS | 25330 | 18:15:42 INFO - PROCESS | 25330 | __start_tp_report 18:15:42 INFO - PROCESS | 25330 | _x_x_mozilla_page_load 18:15:42 INFO - PROCESS | 25330 | _x_x_mozilla_page_load_details 18:15:42 INFO - PROCESS | 25330 | |i|pagename|runs| 18:15:42 INFO - PROCESS | 25330 | |0;dojo.html;2599.8830052647636;2614.947701045979;2620.344913771557;2623.7245089265616;2627.579587266038;4790.209615413457;4805.759712014394;4827.493113223105;4839.733814640198;4879.243717223827;4756.334113224151;4756.571908528232;4804.183288840897;4828.830990915319;4869.196582563873;4402.83324918896;4436.264052469159;4508.233600287943;4526.026904215593;4547;179.66779205523554;4461.486929003174;4479.216137175998;4522.909541809162;4546.47715512717;4427.845025424111;4459.799309031101;4472.46330440346;4475.149721552927;4503.279475283972;4366.694331396803;4489.506154323022;4495.617872480843;4500.617447516965;4501.662375321864;4398.626116780078;4432.889177770549;4435.246008178618;4482.7758612069265;4489.214387482178;4778.95221047792;4796.064767370364;4822.083804077214;4841.225403935354;4890.951090489085;5010.949890501085;5084.161113416282;5142;5160.0969830279555;5199.324087868591;5263.735715355073;5287.286216360781;5287.894242115175;5292.57659387252;5333.866653333697;4903.092927808331;4906.092372911023;4908.975455122773;4909.656324057353;4956.999999999964;5216.1393370094265;5219.921701174486;5248.6588371755715;5272.288241087481;5391.083515802323;5016.874578135576;5025.974870125626;5056.317397151338;5065.56942659878;5066.417362003343;5111.386633603917;5118.820841270612;5122.641415100981;5124.871878203;5127.794968182474;4975.0796102721115;5083.212102124176;5115.87210319745;5118.462561430996;5168.147255702842;4884.072026314989;5014.473480284591;5025.321581586439;5062.443131255559;5099.9490005100215;4423.557644235615;4423.911521769546;4426.468823741172;4439.378487011821;4459.152760975404;3751.0809851586537;3799.297130030953;3813.466114743938;3837.0407398150464;3857.4406711027304;4360.258756011485;4372.213001659732;4383;4413.536578659195;4424.358468022118;5092.159793634009;5145.819896303687;5183.611229157828;5184.688918664892;5196.324477817935;4338.089001309697;4365.388845561624;4368.388425620416;4373.540778218305;4380.561943805594;4650.139724151043;4661.440627124767;4675.742834144086;4706.1528924793865;4711.905761884743;4692.812287508462;4763.666543341933;4788.23388257884;4799.736014519095;4801.087793319328;5160.303359046481;5172.818951336685;5202.661826981234;5217.321748172713;5250.0549901018185;4791.185498465339;4816.446108697544;4826.927596086131;4830.106430310404;4860.635452341018;4950.801967921243;5002.274670172877;5051.696898186121;5118.181091025418;5128.820491282787;5170.1986192140275;5189.922151167811;5196.636235463632;5205.037068142406;5233.6074794389815;5028.094942910311;5029.823956161516;5031.3207716959205;5039.697618142924;5075.5178258065425;4824.34871292371;4913.975430122827;4970.403551573834;5025.974870125626;5032.144535429059;4864;4875.68308059975;4875.80496780139;4909.189983652657;4932.087563800708;5098.541131298052;5102.795888164432;5103.974480127724;5118.33461649998;5165.535101840853;4801.95198048029;4809.78355973989;4982.75086245679;4989.176785830297;4993.154947106409 18:15:42 INFO - PROCESS | 25330 | |1;ext.html;544.4528249109646;557.0947210782479;557.9525740312073;573.1002326347634;602.9027170549601;36312;40327.798361008194;40389.192216155694;40541.39187912184;40545.59454405455;40354.79822600883;40937;40983;41007.38488922668;41063.58936410635;7726.845463090749;7868.055833300012;7875.803104922394;7881.448298619099;7881.448298619099;7786.571738554378;7856.214378562156;7875.212478752136;7876.094249161362;7876.5667888266125;7876.921230787705;7890;7905.249001344863;7909.446338756289;7910.920890791076;7811.648475818602;7855.41084418668;7895.092064412551;7904.920950790476;7919.128895821455;7813.453058285922;7849;7852.76441706744;7870.606469676493;7885.645145968445;37628.81185594082;38113;38143.427848582294;38152.23695526074;38207;2386.72552656445;2843.1328444824526;2895.7972941894077;2997.9850100749577;3012.2770535071645;25710.10014649497;27208.047718329963;27628.58557121645;27830.860845695843;28314.29214269639;3043.7260646541918;3067.5858759067687;3077.7383922366625;3103.0690792762307;3184.3949649566507;224977;225896;226852.86573567192;227073;227462;31923.68076319207;32092.518612220836;32415.837920810718;32697.18257043593;32969;34154.316913662085;34273.65726342754;34433;34458.655413446046;34538.82730586331;13712.17726936387;13738.244396558286;13866.098703584235;13883.4446622136;13887.930560347335;11300.94349528247;11411.60059397917;11494.080473562095;11511.251768635011;11516.251443656303;7954.204579542;8031;8048.315893149031;8101.108878023413;8111.067227268822;3062.4181405532877;3065.1877252528097;3089.6910308968922;3103.05356866158;3124.5781819454537;903.8508646073324;908.6274627402734;976.4287891583504;977.731123940922;996.1283876607968;27536;28918.27704307367;29126.563101553493;29285.85357073201;29373.412531749247;961.3030552849128;994.1500017485091;1000.2778549597099;1067.4876059491332;1088.2871719023894;15308.923455382652;15418.537443876701;15426.845731542766;15579.994243233174;15707.293171807296;360561;362599;364656;365841;367720;48257.75871120622;49431.25853112206;49627.50372496301;49680;49789.253161202614;1173.2960223865782;1174.448009435564;1200.2798321007501;1207.8731733168067;1225.3566877389264;27561.448771024065;27721.861390692917;28298.434031318848;28703.712962870104;28843.711562884942;42230.15539689128;42379.576204237565;42464.78767606266;42478.78760606177;42693;294040;301410;302893;303342;303661;25417.237482875542;25512.489750205263;25568.10511632084;25773.484530309663;25854.482910342063;41560.376594351714;42545.574544255396;42699;43223.783881080395;43593;37594.68418605336;38052.809735951145;38071;38144.427833583075;38423.80788096042;37884.242315152995;37958.43062354122;38040;38365.80817095897;38378.61621383751;31125.844370778002;36123.63876361203;36223.094422639646;36259.81870090738;36456.63543364532;31975.840120799247;33814.830925846196;33887.49168762421;33958.15104622404;34299.485507716905;25330.24009279651;26017.219483415527;26069.73930260749;26126.86936565381;26717.332066698487 18:15:42 INFO - PROCESS | 25330 | |2;jquery.html;360.0692210635507;361.9077135330491;372.8303621852058;383.6815443182159;389.07982621101087;16080.678386432279;16804.15979201041;17963.91018044911;17993.7300940486;18018.369357072504;17036.148192590354;17537.736933946002;18022.09889505526;18037.639247215047;18083.27666893326;5177.430482646906;5343.438938911417;5361.758720857551;5397.757100930448;5406.8918621627545;5271.65734227274;5286.286351342558;5336;5345.492178243061;5354.250404943311;5144.922826157611;5267.446918073604;5300.363956325246;5312.335958005249;5317.069512835258;5247.842564723064;5259.76331065103;5283.6037297202865;5285.207218917155;5323.813666521653;4704.976475117637;4731.810727570927;4735.857924262277;4757.048590281957;4760.45254795696;20576.279830206022;21770.673439898415;22001.449963750874;22252.109915603356;22468.55062898733;1746.633207026526;1781.4566557200048;1889.4048374761906;1904.1812020831037;1910.770707515107;13504.864951350557;13592.660183495393;13657.521986730417;14009.299535023209;14116.576502704935;1751.8948863068129;1778.0487439220085;1786.7498550202981;1807.9276828926827;1822.334847780564;46198.76900615509;71358.28641713568;71403.28596714018;71553;71629.64185179041;9249.16757491829;9695.272854535939;9868.802623947624;10026.548805303779;10155.441450720133;13716.245606491739;13799.931000344934;13809.51666691681;13845.376958036912;13846.446142154402;7618.733344333033;7636.427267954926;7689.769306920802;7816.374690024784;7832.060152781589;7459;7491.10106787189;7495.138059123271;7627.389808815282;7633.465657404039;6164.229471316085;6261.530385221126;6287.528435367366;6315.305316415191;6404.534254312123;1711.9400820971455;1744.345870298638;1772.3087995681694;1793.5874748807848;1832.862535309857;873.868919662043;875.2035647560689;895.5746020640274;913.9268858491305;957.5020989085637;17639.206235719423;18070.18684159216;18601.255949761857;18707.15817788203;18732.81267187338;909.2771246858763;914.3234006834895;927.8566511358783;943.0710749911332;958.5878072428923;10135.695929122137;10495.737606559896;10521.316114452537;10568.207384446197;10587;361563;363022;364842;366248;377301;40791;49267.507324927006;63973.36026639767;64763.67618161879;70887;903.1600611431301;922.8154369126202;927.1423932862076;950.2467946638441;951.833429149896;15429.61425964315;15561.766573501633;15675;15913;15945;34642.48036279508;36313;37360.626393735714;37750.811245943594;38286.042848929;48898.75550622224;49521.50478495169;49849.750751246014;49991.25013124733;50611.74694126506;4384.430024096847;4584.9312260315455;6246.250449946036;7256.346928776436;7332.853342933005;9694.272929530172;9791.167750740982;9877.209823213982;9912.405255684682;11481.885181148082;9692.70921872345;10097.495125243562;10139.391636501834;10314.587416503256;10580.788384232426;9586.95206523963;9607.51962401863;10062.195024397884;10241.283110182216;10329.32859364169;10510.31682940637;10606.204534659777;10691.465426728788;10785.245032847626;11014.724631884266;7376.4836461447185;7535.321821035914;7617.961910190414;7672.232776722283;7858.214178582096;8208;9837.360571562825;10208.59165633396;10406.687799365729;10574.365538067741 18:15:42 INFO - PROCESS | 25330 | |3;mootools.html;1376.4219028008235;1426.3367534096642;1499.3178103962691;1683.335082642357;1719.4927496388564;6420.614763114217;7375.37309328707;7485.775426737193;7794.961025194881;7798.454108212427;7631.122420921596;7673.040869891263;7708.30625243728;7754.108277548084;7761.844763104735;2188.070070220154;2216.900239489227;2221.8111460525874;2223.7109175807122;2234.128689810975;2195.879226642534;2217.157480157538;2263.60386932287;2267.6031694453486;2269.1377276634857;2221.322496638533;2233.452804062999;2234.664800279963;2251.2570851618925;2259.0850705464313;2199.9560008799813;2204.0853045985896;2208.536207396449;2218.157100301891;2222.922197723072;2134.7224860768156;2140.871547707143;2145.216995796523;2149.333706550974;2158.7409510858643;7720.575368354738;7743.961280193563;7774.378049756063;7799.415043871732;7863.803404914923;4443.33349997503;4557.521460246659;4559.521250268707;4560.498345182027;4563.429571303587;2773.6948935617065;2788.4562510310498;2849.401625658614;2866.8423236721974;2900.7389334959744;811.5658122904218;839.4040231435688;848.6732607945924;858.2661824140395;883.1830556734994;10062.547185376603;10067.647632332833;10097;10102.39385636864;10109.545070471846;3962.445257663929;4034.9394759078637;4123.299039163349;4150.522689890701;4161.146964872194;8656.047834738174;8684.60919258635;8700.30397568193;8703.825923481494;8716.302695784321;4565.748883811356;4578.175928332932;4596.218642830727;4603.148417542699;4610.884727881829;3550.751447398657;4104.651104656137;4206.158768246363;4223.303154979394;4226.070264541858;3643.398839191557;3656.74402791802;3727.1800203955086;3735.1595890924323;3770.4344348347418;1230.5816022552376;1242.819791130299;1246.9650190341995;1250.7686078075585;1251.268008215186;755.4522970846093;770.6994272233833;775.352580595198;787.6455594982281;836.7531578184451;4879.243717223836;5079.545624616466;5159.896802063938;5213.661112027706;5214.608904332114;429.1674152144829;434.71960585422227;435.2383329173946;937.6249500199974;957.2198658093631;3482.1294676330917;3509.4384898416642;3603.747737658391;3617.5116359291687;3654.8172591370326;9129.589168487433;9361.110694484014;9380.296477764196;9435.6697515588;9466.148046675833;9018.729438116867;9366.62533498666;9384.483853387992;9426.293028022927;9436.197923176469;7222.386097181693;7357.227491113356;7394.11270647515;7398.852022959511;7427.517211381243;5119.28330033803;5217.556507696889;5315.760790764502;5326.786928522815;5396.460353964572;8550.82898342042;8583.613737381707;8726.389152759246;8861.202491775772;8862.955685221532;8785.560721964004;8816.338774591803;8853.51305678194;8892.33307501927;9008.639654414012;5817;6315.55791094619;6535.4444872184495;6796.796096117125;6922.446204303543;7533.698652054076;7570.05374328209;7574.242575742602;7605.087389513294;7651.043619547557;6753.797386078426;6963.6866341013765;6988.510804243654;7050.612216328152;7120.6795694194925;6799.762008329685;6886.827829304107;6903.827404314932;6909.654517274015;6969.686364113526;6023.849403764766;6082.178905847831;6114.144019837316;6226.221722284715;6265.8746825062335;4354.238008348463;4365.192439398721;4406.192432691435;4478.641708663365;4479.776011199492;4252.638525725348;4325.7837108145095;4343.154159482145;4345;4447.110577884371 18:15:42 INFO - PROCESS | 25330 | |4;prototype.html;300.2119436479242;305.87459141751884;308;308.0312417447128;308.1326067121054;5074.594032477402;5115.439790863795;5123.436421993582;5135.512126347996;5160.225966105086;5050.722210278443;5068;5072.72100034498;5095;5095.490450954902;3747.0445036515716;3860.8455661773496;3953.7430067045693;3990.900227494307;4000.639942405183;3970.1662650843214;3985.760854348734;3998.6801055915603;4006.13868018376;4028.7784171870535;3949.2693851637396;3983.3228351180223;3988.641022308006;4009.8797036088818;4027.2549578328103;3709.9072523186865;3948.881533553998;3955;4022.879313620596;4028.5568587455355;3428.422925454294;3429.605595356541;3433.296174284266;3434.6737059979264;3439.329330780499;5029.497050294978;5041.420236672793;5047.545720885138;5059.06407314648;5097.672931786292;4377.409049778271;4531.886702832423;4539.205639013159;4540.228161212602;4548.863534093983;5383.596230282745;5390.5418039466695;5402.864928376783;5419.268398766156;5459.918101228484;3905.882823515299;3913.3934240192816;3922.097917478996;3925.568187499373;3937.6652984496354;5304.761285742113;5716.771329146829;5722;5727.684977326246;5734.913976290317;3786.3718601001283;3817.1602247505502;3823.483829682957;3825.713071519647;3834;3880.690988861679;3886.2810380079777;3890.910545047391;3891.2217556488818;3892.727509074394;4452.243118669834;4462.0104529965;4466.821327146943;4473.172463094338;4493.618042466362;5138.4604616514725;5280.9207861882105;5291.894162116736;5316.973415132899;5364.785408583613;1371.3828777050367;1380.7859781733848;1382.384838746768;1392.2968900705282;1401.3133564553295;890.7060669978891;898.8292224477459;905.6060613633091;920.3189639666598;925.1581061234244;4544.795484203219;4569.428821397325;4581.679282450196;4583.4041574595085;4583.891409951393;5441.510264076173;5462.180672899097;5470.671759694431;5471.23402723619;5503.449655034545;4478.298246666312;4499.482559505634;4585.853536615846;4595.1039547287955;4604.654650901196;2877.8704958276926;2923.181509177434;2931.750801181881;2933.823970561773;2943.617329747162;4984.152694042022;5050.368703912011;5113.130767769489;5125.359330083739;5127.66670166438;5277.604179686539;5544.279243698374;5571.749271282802;5588.888222235532;5607.345832979281;5031.622628302892;5037.4458809530925;5046.167382381939;5046.697198168122;5057.875692209281;5433.646812957145;5441.183822426668;5464.153056276284;5468.179773034077;5504.394516603251;5117.8464646060675;5329.653572517774;5425.755840987086;5449.782008719607;5482.738970036834;5185.196294574347;5195.19474481456;5195.818146364859;5197.428282888804;5214.165733482625;3768.3217020936495;3794.317022935898;3802.9239415210986;3807.2004878975727;3815.427685847034;5267;5554.2779438672715;5578.3584887738425;5616.315105468261;5653.717314134359;5384.7576859040655;5414.648047876875;5436.656456279439;5444.50999410055;5467.5625949923115;5204.687718736888;5390.946090539202;5394.514493695587;5410.1343784994215;5476.589255805751;5300.337457817773;5303.223420154137;5304.761285742074;5315.282436871127;5340.679559226459;5168.793248270027;5225.268462415341;5388.434214407587;5398;5402.189671549142;5266.131088370376;5302.973485132549;5328.8401347959625;5345.625806193529;5375.596830237826 18:15:42 INFO - PROCESS | 25330 | |5;yui.html;668.291610892454;674.376202013138;686.4096876686052;705.6189657584904;739.866823971685;13253.403596838141;13689.247091409981;13693.657658558528;13707.588772336821;14923.776143357858;14535.345909434074;14670.706585868276;14680.706385872303;14688.632784180401;14729.92635036826;632.1497585747163;780.637003793236;803.1566854802463;808.4017826808179;810.2262339465825;773.8955241042472;794.5749024272016;796.2714116583319;802.458340620082;804.16768644453;836.2682652678906;843.3464065349342;843.4686147726924;843.6203708331245;844.586152785137;827.6234313387395;837.4933165434916;838.5807096451774;839.0267289943636;840.436907272123;601.8284788835161;605.1346574398608;608.3976862905736;609.1259043272873;611.5199568338877;13634.045616806827;13647.86352136476;13710.24593647349;13720.862791372158;13741.519046833413;13528.729425411535;13616.387262573207;13786.172829630254;13903.235322057282;13957.162570245717;10018.59925602975;10142.645007424704;10164.542595583216;10287.074163325336;10327.380357178594;3255.755818313636;3267.591551056118;3314.1880239341276;3323.7507186961075;3393.372226138172;60946.695266523384;62037.37962620361;63561.999999999534;64032.3596764031;64190.358096419375;10643.946780266204;10647.84028239577;10723;10781.730456738487;10821.83767243492;18148.727769083474;18721.157547910378;18805.62388752217;19406.12672429716;19542.70685939712;7179.317964793337;7182.60495672743;7213.963930180315;7301.050863387832;7354.96322518384;3728.3289007978283;3798.810059497014;3802.923941521154;3805.7906815125434;3831.2529056834205;2968.228260652246;3079.707427794356;3080.2299425143715;3080.2761351082477;3082.3372974810522;530.5887936848973;540.1330863963361;541.0180522351918;547.975341109651;551.7903196785196;571.7684337843181;601.1583782704249;608.2305883057935;627.6391075131726;636.7771280051945;7921;8132.512049277062;8173.632186551619;8291.419600628018;8345.54099524532;493.64704236471096;500.38968839820865;552.1937970562943;566.3119310038323;573.5554944917723;3756.4553139794575;4153.480814898137;4190.099128687347;4207.305794543927;4227.281362168439;90258.54870725605;91016;93507.53246233861;94082.529587353;96819.51590242004;81029;81712;82160;83113.58443207745;83914.16085839186;72973.27026729664;73977;75674.24325756672;75880;76851.99999999888;7961.681532738626;8615.827683446421;8708.477491350539;8847.336449766164;8922.152395522415;40694.79652601718;41197.382039270036;41531.792341038104;43951.340729889715;44256.67229983106;61228.69385653043;61879.6906015467;62465.37534624596;65191;65375.34624653692;12120.068150547479;12225.816612750637;12226.694332641398;12428.75142497127;12555.623331300076;12825.551105711254;13104;13386.397612107285;13459.596212113653;14026.01817872739;11020.173486988348;11288.32270063766;11301.604443844426;11312.773744525228;11337.489812958273;11625.18623696333;11906.880931190577;11944.343061131722;12000.219985700902;12041.759164816829;10671.092957098423;11353.205275630626;11654.592089276835;11819.468123934272;12004.519819207135;9760.707178784647;9779;10100.646477373257;10471.183434004854;10548;9719.708408747749;10227.54491017964;10319.742006449898;10349.327293725884;10360.792784144425 18:15:42 INFO - PROCESS | 25330 | __end_tp_report 18:15:42 INFO - PROCESS | 25330 | __start_cc_report 18:15:42 INFO - PROCESS | 25330 | _x_x_mozilla_cycle_collect,384 18:15:42 INFO - PROCESS | 25330 | __end_cc_report 18:15:42 INFO - PROCESS | 25330 | __startTimestamp1467940542910__endTimestamp 18:15:42 INFO - PROCESS | 25330 | 18:15:42 INFO - PROCESS | 25330 | ------- Summary: start ------- 18:15:42 INFO - PROCESS | 25330 | Number of tests: 6 18:15:42 INFO - PROCESS | 25330 | 18:15:42 INFO - PROCESS | 25330 | [#0] dojo.html Cycles:165 Average:4735.31 Median:4875.68 stddev:618.46 (12.7%) stddev-sans-first:597.24 18:15:42 INFO - PROCESS | 25330 | Values: 2599.9 2614.9 2620.3 2623.7 2627.6 4790.2 4805.8 4827.5 4839.7 4879.2 4756.3 4756.6 4804.2 4828.8 4869.2 4402.8 4436.3 4508.2 4526.0 4547.0 179.7 4461.5 4479.2 4522.9 4546.5 4427.8 4459.8 4472.5 4475.1 4503.3 4366.7 4489.5 4495.6 4500.6 4501.7 4398.6 4432.9 4435.2 4482.8 4489.2 4779.0 4796.1 4822.1 4841.2 4891.0 5010.9 5084.2 5142.0 5160.1 5199.3 5263.7 5287.3 5287.9 5292.6 5333.9 4903.1 4906.1 4909.0 4909.7 4957.0 5216.1 5219.9 5248.7 5272.3 5391.1 5016.9 5026.0 5056.3 5065.6 5066.4 5111.4 5118.8 5122.6 5124.9 5127.8 4975.1 5083.2 5115.9 5118.5 5168.1 4884.1 5014.5 5025.3 5062.4 5099.9 4423.6 4423.9 4426.5 4439.4 4459.2 3751.1 3799.3 3813.5 3837.0 3857.4 4360.3 4372.2 4383.0 4413.5 4424.4 5092.2 5145.8 5183.6 5184.7 5196.3 4338.1 4365.4 4368.4 4373.5 4380.6 4650.1 4661.4 4675.7 4706.2 4711.9 4692.8 4763.7 4788.2 4799.7 4801.1 5160.3 5172.8 5202.7 5217.3 5250.1 4791.2 4816.4 4826.9 4830.1 4860.6 4950.8 5002.3 5051.7 5118.2 5128.8 5170.2 5189.9 5196.6 5205.0 5233.6 5028.1 5029.8 5031.3 5039.7 5075.5 4824.3 4914.0 4970.4 5026.0 5032.1 4864.0 4875.7 4875.8 4909.2 4932.1 5098.5 5102.8 5104.0 5118.3 5165.5 4802.0 4809.8 4982.8 4989.2 4993.2 18:15:42 INFO - PROCESS | 25330 | 18:15:42 INFO - PROCESS | 25330 | [#1] ext.html Cycles:180 Average:44267.78 Median:36173.37 stddev:79635.64 (220.1%) stddev-sans-first:79791.37 18:15:42 INFO - PROCESS | 25330 | Values: 544.5 557.1 558.0 573.1 602.9 36312.0 40327.8 40389.2 40541.4 40545.6 40354.8 40937.0 40983.0 41007.4 41063.6 7726.8 7868.1 7875.8 7881.4 7881.4 7786.6 7856.2 7875.2 7876.1 7876.6 7876.9 7890.0 7905.2 7909.4 7910.9 7811.6 7855.4 7895.1 7904.9 7919.1 7813.5 7849.0 7852.8 7870.6 7885.6 37628.8 38113.0 38143.4 38152.2 38207.0 2386.7 2843.1 2895.8 2998.0 3012.3 25710.1 27208.0 27628.6 27830.9 28314.3 3043.7 3067.6 3077.7 3103.1 3184.4 224977.0 225896.0 226852.9 227073.0 227462.0 31923.7 32092.5 32415.8 32697.2 32969.0 34154.3 34273.7 34433.0 34458.7 34538.8 13712.2 13738.2 13866.1 13883.4 13887.9 11300.9 11411.6 11494.1 11511.3 11516.3 7954.2 8031.0 8048.3 8101.1 8111.1 3062.4 3065.2 3089.7 3103.1 3124.6 903.9 908.6 976.4 977.7 996.1 27536.0 28918.3 29126.6 29285.9 29373.4 961.3 994.2 1000.3 1067.5 1088.3 15308.9 15418.5 15426.8 15580.0 15707.3 360561.0 362599.0 364656.0 365841.0 367720.0 48257.8 49431.3 49627.5 49680.0 49789.3 1173.3 1174.4 1200.3 1207.9 1225.4 27561.4 27721.9 28298.4 28703.7 28843.7 42230.2 42379.6 42464.8 42478.8 42693.0 294040.0 301410.0 302893.0 303342.0 303661.0 25417.2 25512.5 25568.1 25773.5 25854.5 41560.4 42545.6 42699.0 43223.8 43593.0 37594.7 38052.8 38071.0 38144.4 38423.8 37884.2 37958.4 38040.0 38365.8 38378.6 31125.8 36123.6 36223.1 36259.8 36456.6 31975.8 33814.8 33887.5 33958.2 34299.5 25330.2 26017.2 26069.7 26126.9 26717.3 18:15:42 INFO - PROCESS | 25330 | 18:15:42 INFO - PROCESS | 25330 | [#2] jquery.html Cycles:180 Average:23246.89 Median:25391.85 stddev:60256.31 (237.3%) stddev-sans-first:60400.84 18:15:42 INFO - PROCESS | 25330 | Values: 360.1 361.9 372.8 383.7 389.1 16080.7 16804.2 17963.9 17993.7 18018.4 17036.1 17537.7 18022.1 18037.6 18083.3 5177.4 5343.4 5361.8 5397.8 5406.9 5271.7 5286.3 5336.0 5345.5 5354.3 5144.9 5267.4 5300.4 5312.3 5317.1 5247.8 5259.8 5283.6 5285.2 5323.8 4705.0 4731.8 4735.9 4757.0 4760.5 20576.3 21770.7 22001.4 22252.1 22468.6 1746.6 1781.5 1889.4 1904.2 1910.8 13504.9 13592.7 13657.5 14009.3 14116.6 1751.9 1778.0 1786.7 1807.9 1822.3 46198.8 71358.3 71403.3 71553.0 71629.6 9249.2 9695.3 9868.8 10026.5 10155.4 13716.2 13799.9 13809.5 13845.4 13846.4 7618.7 7636.4 7689.8 7816.4 7832.1 7459.0 7491.1 7495.1 7627.4 7633.5 6164.2 6261.5 6287.5 6315.3 6404.5 1711.9 1744.3 1772.3 1793.6 1832.9 873.9 875.2 895.6 913.9 957.5 17639.2 18070.2 18601.3 18707.2 18732.8 909.3 914.3 927.9 943.1 958.6 10135.7 10495.7 10521.3 10568.2 10587.0 361563.0 363022.0 364842.0 366248.0 377301.0 40791.0 49267.5 63973.4 64763.7 70887.0 903.2 922.8 927.1 950.2 951.8 15429.6 15561.8 15675.0 15913.0 15945.0 34642.5 36313.0 37360.6 37750.8 38286.0 48898.8 49521.5 49849.8 49991.3 50611.7 4384.4 4584.9 6246.3 7256.3 7332.9 9694.3 9791.2 9877.2 9912.4 11481.9 9692.7 10097.5 10139.4 10314.6 10580.8 9587.0 9607.5 10062.2 10241.3 10329.3 10510.3 10606.2 10691.5 10785.2 11014.7 7376.5 7535.3 7618.0 7672.2 7858.2 8208.0 9837.4 10208.6 10406.7 10574.4 18:15:42 INFO - PROCESS | 25330 | 18:15:42 INFO - PROCESS | 25330 | [#3] mootools.html Cycles:180 Average:5055.47 Median:5139.59 stddev:2800.96 (54.5%) stddev-sans-first:2795.17 18:15:42 INFO - PROCESS | 25330 | Values: 1376.4 1426.3 1499.3 1683.3 1719.5 6420.6 7375.4 7485.8 7795.0 7798.5 7631.1 7673.0 7708.3 7754.1 7761.8 2188.1 2216.9 2221.8 2223.7 2234.1 2195.9 2217.2 2263.6 2267.6 2269.1 2221.3 2233.5 2234.7 2251.3 2259.1 2200.0 2204.1 2208.5 2218.2 2222.9 2134.7 2140.9 2145.2 2149.3 2158.7 7720.6 7744.0 7774.4 7799.4 7863.8 4443.3 4557.5 4559.5 4560.5 4563.4 2773.7 2788.5 2849.4 2866.8 2900.7 811.6 839.4 848.7 858.3 883.2 10062.5 10067.6 10097.0 10102.4 10109.5 3962.4 4034.9 4123.3 4150.5 4161.1 8656.0 8684.6 8700.3 8703.8 8716.3 4565.7 4578.2 4596.2 4603.1 4610.9 3550.8 4104.7 4206.2 4223.3 4226.1 3643.4 3656.7 3727.2 3735.2 3770.4 1230.6 1242.8 1247.0 1250.8 1251.3 755.5 770.7 775.4 787.6 836.8 4879.2 5079.5 5159.9 5213.7 5214.6 429.2 434.7 435.2 937.6 957.2 3482.1 3509.4 3603.7 3617.5 3654.8 9129.6 9361.1 9380.3 9435.7 9466.1 9018.7 9366.6 9384.5 9426.3 9436.2 7222.4 7357.2 7394.1 7398.9 7427.5 5119.3 5217.6 5315.8 5326.8 5396.5 8550.8 8583.6 8726.4 8861.2 8863.0 8785.6 8816.3 8853.5 8892.3 9008.6 5817.0 6315.6 6535.4 6796.8 6922.4 7533.7 7570.1 7574.2 7605.1 7651.0 6753.8 6963.7 6988.5 7050.6 7120.7 6799.8 6886.8 6903.8 6909.7 6969.7 6023.8 6082.2 6114.1 6226.2 6265.9 4354.2 4365.2 4406.2 4478.6 4479.8 4252.6 4325.8 4343.2 4345.0 4447.1 18:15:42 INFO - PROCESS | 25330 | 18:15:42 INFO - PROCESS | 25330 | [#4] prototype.html Cycles:180 Average:4425.67 Median:5058.47 stddev:1293.05 (25.6%) stddev-sans-first:1259.06 18:15:42 INFO - PROCESS | 25330 | Values: 300.2 305.9 308.0 308.0 308.1 5074.6 5115.4 5123.4 5135.5 5160.2 5050.7 5068.0 5072.7 5095.0 5095.5 3747.0 3860.8 3953.7 3990.9 4000.6 3970.2 3985.8 3998.7 4006.1 4028.8 3949.3 3983.3 3988.6 4009.9 4027.3 3709.9 3948.9 3955.0 4022.9 4028.6 3428.4 3429.6 3433.3 3434.7 3439.3 5029.5 5041.4 5047.5 5059.1 5097.7 4377.4 4531.9 4539.2 4540.2 4548.9 5383.6 5390.5 5402.9 5419.3 5459.9 3905.9 3913.4 3922.1 3925.6 3937.7 5304.8 5716.8 5722.0 5727.7 5734.9 3786.4 3817.2 3823.5 3825.7 3834.0 3880.7 3886.3 3890.9 3891.2 3892.7 4452.2 4462.0 4466.8 4473.2 4493.6 5138.5 5280.9 5291.9 5317.0 5364.8 1371.4 1380.8 1382.4 1392.3 1401.3 890.7 898.8 905.6 920.3 925.2 4544.8 4569.4 4581.7 4583.4 4583.9 5441.5 5462.2 5470.7 5471.2 5503.4 4478.3 4499.5 4585.9 4595.1 4604.7 2877.9 2923.2 2931.8 2933.8 2943.6 4984.2 5050.4 5113.1 5125.4 5127.7 5277.6 5544.3 5571.7 5588.9 5607.3 5031.6 5037.4 5046.2 5046.7 5057.9 5433.6 5441.2 5464.2 5468.2 5504.4 5117.8 5329.7 5425.8 5449.8 5482.7 5185.2 5195.2 5195.8 5197.4 5214.2 3768.3 3794.3 3802.9 3807.2 3815.4 5267.0 5554.3 5578.4 5616.3 5653.7 5384.8 5414.6 5436.7 5444.5 5467.6 5204.7 5390.9 5394.5 5410.1 5476.6 5300.3 5303.2 5304.8 5315.3 5340.7 5168.8 5225.3 5388.4 5398.0 5402.2 5266.1 5303.0 5328.8 5345.6 5375.6 18:15:42 INFO - PROCESS | 25330 | 18:15:42 INFO - PROCESS | 25330 | [#5] yui.html Cycles:180 Average:17780.23 Median:44104.01 stddev:24808.22 (56.2%) stddev-sans-first:24844.53 18:15:42 INFO - PROCESS | 25330 | Values: 668.3 674.4 686.4 705.6 739.9 13253.4 13689.2 13693.7 13707.6 14923.8 14535.3 14670.7 14680.7 14688.6 14729.9 632.1 780.6 803.2 808.4 810.2 773.9 794.6 796.3 802.5 804.2 836.3 843.3 843.5 843.6 844.6 827.6 837.5 838.6 839.0 840.4 601.8 605.1 608.4 609.1 611.5 13634.0 13647.9 13710.2 13720.9 13741.5 13528.7 13616.4 13786.2 13903.2 13957.2 10018.6 10142.6 10164.5 10287.1 10327.4 3255.8 3267.6 3314.2 3323.8 3393.4 60946.7 62037.4 63562.0 64032.4 64190.4 10643.9 10647.8 10723.0 10781.7 10821.8 18148.7 18721.2 18805.6 19406.1 19542.7 7179.3 7182.6 7214.0 7301.1 7355.0 3728.3 3798.8 3802.9 3805.8 3831.3 2968.2 3079.7 3080.2 3080.3 3082.3 530.6 540.1 541.0 548.0 551.8 571.8 601.2 608.2 627.6 636.8 7921.0 8132.5 8173.6 8291.4 8345.5 493.6 500.4 552.2 566.3 573.6 3756.5 4153.5 4190.1 4207.3 4227.3 90258.5 91016.0 93507.5 94082.5 96819.5 81029.0 81712.0 82160.0 83113.6 83914.2 72973.3 73977.0 75674.2 75880.0 76852.0 7961.7 8615.8 8708.5 8847.3 8922.2 40694.8 41197.4 41531.8 43951.3 44256.7 61228.7 61879.7 62465.4 65191.0 65375.3 12120.1 12225.8 12226.7 12428.8 12555.6 12825.6 13104.0 13386.4 13459.6 14026.0 11020.2 11288.3 11301.6 11312.8 11337.5 11625.2 11906.9 11944.3 12000.2 12041.8 10671.1 11353.2 11654.6 11819.5 12004.5 9760.7 9779.0 10100.6 10471.2 10548.0 9719.7 10227.5 10319.7 10349.3 10360.8 18:15:42 INFO - PROCESS | 25330 | -------- Summary: end -------- 18:15:42 INFO - PROCESS | 25330 | 18:15:43 INFO - TEST-INFO | 25330: exit 0 18:15:43 INFO - TEST-OK | dromaeo_css | took 1116270ms 18:15:43 INFO - TEST-START | kraken 18:15:43 INFO - operating with platform_type : linux_ 18:15:43 INFO - Initialising browser for kraken test... 18:15:43 INFO - TEST-INFO | started process 25574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxaRqDX/profile http://localhost:51362/getInfo.html) 18:15:48 INFO - PROCESS | 25574 | __metrics Screen width/height:1600/1200 18:15:48 INFO - PROCESS | 25574 | colorDepth:24 18:15:48 INFO - PROCESS | 25574 | Browser inner width/height: 1024/697 18:15:48 INFO - PROCESS | 25574 | __metrics 18:15:49 ERROR - PROCESS | 25574 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 18:15:50 INFO - TEST-INFO | 25574: exit 0 18:15:50 INFO - Browser initialized. 18:15:50 INFO - Running cycle 1/1 for kraken test... 18:15:50 INFO - TEST-INFO | started process 25693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxaRqDX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:16:02 INFO - PROCESS | 25693 | RSS: Main: 168693760 18:16:02 INFO - PROCESS | 25693 | 18:16:04 INFO - PROCESS | 25693 | Cycle 1(1): loaded http://localhost:51362/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51362/tests/kraken/driver.html?testName=audio-beat-detection) 18:16:05 INFO - PROCESS | 25693 | RSS: Main: 173981696 18:16:05 INFO - PROCESS | 25693 | 18:16:08 INFO - PROCESS | 25693 | Cycle 1(1): loaded http://localhost:51362/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51362/tests/kraken/driver.html?testName=audio-dft) 18:16:09 INFO - PROCESS | 25693 | RSS: Main: 173686784 18:16:09 INFO - PROCESS | 25693 | 18:16:11 INFO - PROCESS | 25693 | Cycle 1(1): loaded http://localhost:51362/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51362/tests/kraken/driver.html?testName=audio-fft) 18:16:12 INFO - PROCESS | 25693 | RSS: Main: 168030208 18:16:12 INFO - PROCESS | 25693 | 18:16:14 INFO - PROCESS | 25693 | Cycle 1(1): loaded http://localhost:51362/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51362/tests/kraken/driver.html?testName=audio-oscillator) 18:16:15 INFO - PROCESS | 25693 | RSS: Main: 169132032 18:16:15 INFO - PROCESS | 25693 | 18:16:17 INFO - PROCESS | 25693 | Cycle 1(1): loaded http://localhost:51362/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51362/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:16:18 INFO - PROCESS | 25693 | RSS: Main: 169160704 18:16:18 INFO - PROCESS | 25693 | 18:16:21 INFO - PROCESS | 25693 | Cycle 1(1): loaded http://localhost:51362/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51362/tests/kraken/driver.html?testName=imaging-darkroom) 18:16:22 INFO - PROCESS | 25693 | RSS: Main: 169271296 18:16:22 INFO - PROCESS | 25693 | 18:16:25 INFO - PROCESS | 25693 | Cycle 1(1): loaded http://localhost:51362/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51362/tests/kraken/driver.html?testName=imaging-desaturate) 18:16:26 INFO - PROCESS | 25693 | RSS: Main: 167247872 18:16:26 INFO - PROCESS | 25693 | 18:16:29 INFO - PROCESS | 25693 | Cycle 1(1): loaded http://localhost:51362/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51362/tests/kraken/driver.html?testName=json-parse-financial) 18:16:29 INFO - PROCESS | 25693 | RSS: Main: 168472576 18:16:29 INFO - PROCESS | 25693 | 18:16:31 INFO - PROCESS | 25693 | Cycle 1(1): loaded http://localhost:51362/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51362/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:16:32 INFO - PROCESS | 25693 | RSS: Main: 168689664 18:16:32 INFO - PROCESS | 25693 | 18:16:34 INFO - PROCESS | 25693 | Cycle 1(1): loaded http://localhost:51362/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51362/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:16:34 INFO - PROCESS | 25693 | RSS: Main: 169201664 18:16:34 INFO - PROCESS | 25693 | 18:16:36 INFO - PROCESS | 25693 | Cycle 1(1): loaded http://localhost:51362/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51362/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:16:37 INFO - PROCESS | 25693 | RSS: Main: 169320448 18:16:37 INFO - PROCESS | 25693 | 18:16:40 INFO - PROCESS | 25693 | Cycle 1(1): loaded http://localhost:51362/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:16:41 INFO - PROCESS | 25693 | RSS: Main: 170221568 18:16:41 INFO - PROCESS | 25693 | 18:16:43 INFO - PROCESS | 25693 | Cycle 1(1): loaded http://localhost:51362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:16:44 INFO - PROCESS | 25693 | RSS: Main: 169881600 18:16:44 INFO - PROCESS | 25693 | 18:16:46 INFO - PROCESS | 25693 | Cycle 1(1): loaded http://localhost:51362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51362/tests/kraken/driver.html?testName=ai-astar) 18:16:46 INFO - PROCESS | 25693 | RSS: Main: 170590208 18:16:46 INFO - PROCESS | 25693 | 18:16:46 INFO - PROCESS | 25693 | __start_tp_report 18:16:46 INFO - PROCESS | 25693 | _x_x_mozilla_page_load 18:16:46 INFO - PROCESS | 25693 | _x_x_mozilla_page_load_details 18:16:46 INFO - PROCESS | 25693 | |i|pagename|runs| 18:16:46 INFO - PROCESS | 25693 | |0;ai-astar;104;115;110;116;115;117;115;114;113;114 18:16:46 INFO - PROCESS | 25693 | |1;audio-beat-detection;154;128;147;177;124;157;150;127;183;123 18:16:46 INFO - PROCESS | 25693 | |2;audio-dft;163;163;161;166;170;164;163;164;164;163 18:16:46 INFO - PROCESS | 25693 | |3;audio-fft;76;77;76;151;78;78;76;78;164;77 18:16:46 INFO - PROCESS | 25693 | |4;audio-oscillator;86;86;140;86;87;85;138;86;86;139 18:16:46 INFO - PROCESS | 25693 | |5;imaging-gaussian-blur;118;118;117;119;118;118;118;117;120;119 18:16:46 INFO - PROCESS | 25693 | |6;imaging-darkroom;150;149;148;148;148;148;147;147;147;148 18:16:46 INFO - PROCESS | 25693 | |7;imaging-desaturate;96;96;96;96;96;95;96;97;95;95 18:16:46 INFO - PROCESS | 25693 | |8;json-parse-financial;66;66;65;65;68;66;65;68;66;66 18:16:46 INFO - PROCESS | 25693 | |9;json-stringify-tinderbox;64;64;64;64;65;65;64;64;64;65 18:16:46 INFO - PROCESS | 25693 | |10;stanford-crypto-aes;80;79;81;79;81;78;80;88;89;80 18:16:46 INFO - PROCESS | 25693 | |11;stanford-crypto-ccm;140;138;133;137;143;134;134;132;169;136 18:16:46 INFO - PROCESS | 25693 | |12;stanford-crypto-pbkdf2;166;164;166;172;167;173;166;166;170;164 18:16:46 INFO - PROCESS | 25693 | |13;stanford-crypto-sha256-iterative;67;74;72;67;71;70;67;68;70;68 18:16:46 INFO - PROCESS | 25693 | __end_tp_report 18:16:46 INFO - PROCESS | 25693 | __start_cc_report 18:16:46 INFO - PROCESS | 25693 | _x_x_mozilla_cycle_collect,977 18:16:46 INFO - PROCESS | 25693 | __end_cc_report 18:16:46 INFO - PROCESS | 25693 | __startTimestamp1467940606520__endTimestamp 18:16:46 INFO - PROCESS | 25693 | 18:16:46 INFO - PROCESS | 25693 | ------- Summary: start ------- 18:16:46 INFO - PROCESS | 25693 | Number of tests: 14 18:16:46 INFO - PROCESS | 25693 | 18:16:46 INFO - PROCESS | 25693 | [#0] ai-astar Cycles:10 Average:113.30 Median:115.00 stddev:3.77 (3.3%) stddev-sans-first:2.00 18:16:46 INFO - PROCESS | 25693 | Values: 104.0 115.0 110.0 116.0 115.0 117.0 115.0 114.0 113.0 114.0 18:16:46 INFO - PROCESS | 25693 | 18:16:46 INFO - PROCESS | 25693 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:152.00 stddev:21.65 (14.2%) stddev-sans-first:22.82 18:16:46 INFO - PROCESS | 25693 | Values: 154.0 128.0 147.0 177.0 124.0 157.0 150.0 127.0 183.0 123.0 18:16:46 INFO - PROCESS | 25693 | 18:16:46 INFO - PROCESS | 25693 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.42 (1.5%) stddev-sans-first:2.54 18:16:46 INFO - PROCESS | 25693 | Values: 163.0 163.0 161.0 166.0 170.0 164.0 163.0 164.0 164.0 163.0 18:16:46 INFO - PROCESS | 25693 | 18:16:46 INFO - PROCESS | 25693 | [#3] audio-fft Cycles:10 Average:93.10 Median:77.00 stddev:34.09 (44.3%) stddev-sans-first:35.59 18:16:46 INFO - PROCESS | 25693 | Values: 76.0 77.0 76.0 151.0 78.0 78.0 76.0 78.0 164.0 77.0 18:16:46 INFO - PROCESS | 25693 | 18:16:46 INFO - PROCESS | 25693 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:86.00 stddev:25.61 (29.8%) stddev-sans-first:26.51 18:16:46 INFO - PROCESS | 25693 | Values: 86.0 86.0 140.0 86.0 87.0 85.0 138.0 86.0 86.0 139.0 18:16:46 INFO - PROCESS | 25693 | 18:16:46 INFO - PROCESS | 25693 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 18:16:46 INFO - PROCESS | 25693 | Values: 118.0 118.0 117.0 119.0 118.0 118.0 118.0 117.0 120.0 119.0 18:16:46 INFO - PROCESS | 25693 | 18:16:46 INFO - PROCESS | 25693 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.94 (0.6%) stddev-sans-first:0.67 18:16:46 INFO - PROCESS | 25693 | Values: 150.0 149.0 148.0 148.0 148.0 148.0 147.0 147.0 147.0 148.0 18:16:46 INFO - PROCESS | 25693 | 18:16:46 INFO - PROCESS | 25693 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 18:16:46 INFO - PROCESS | 25693 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 96.0 97.0 95.0 95.0 18:16:46 INFO - PROCESS | 25693 | 18:16:46 INFO - PROCESS | 25693 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 18:16:46 INFO - PROCESS | 25693 | Values: 66.0 66.0 65.0 65.0 68.0 66.0 65.0 68.0 66.0 66.0 18:16:46 INFO - PROCESS | 25693 | 18:16:46 INFO - PROCESS | 25693 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 18:16:46 INFO - PROCESS | 25693 | Values: 64.0 64.0 64.0 64.0 65.0 65.0 64.0 64.0 64.0 65.0 18:16:46 INFO - PROCESS | 25693 | 18:16:46 INFO - PROCESS | 25693 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:80.50 stddev:3.81 (4.7%) stddev-sans-first:4.00 18:16:46 INFO - PROCESS | 25693 | Values: 80.0 79.0 81.0 79.0 81.0 78.0 80.0 88.0 89.0 80.0 18:16:46 INFO - PROCESS | 25693 | 18:16:46 INFO - PROCESS | 25693 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:137.50 stddev:10.86 (7.9%) stddev-sans-first:11.52 18:16:46 INFO - PROCESS | 25693 | Values: 140.0 138.0 133.0 137.0 143.0 134.0 134.0 132.0 169.0 136.0 18:16:46 INFO - PROCESS | 25693 | 18:16:46 INFO - PROCESS | 25693 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:166.50 stddev:3.17 (1.9%) stddev-sans-first:3.32 18:16:46 INFO - PROCESS | 25693 | Values: 166.0 164.0 166.0 172.0 167.0 173.0 166.0 166.0 170.0 164.0 18:16:46 INFO - PROCESS | 25693 | 18:16:46 INFO - PROCESS | 25693 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:2.41 (3.4%) stddev-sans-first:2.40 18:16:46 INFO - PROCESS | 25693 | Values: 67.0 74.0 72.0 67.0 71.0 70.0 67.0 68.0 70.0 68.0 18:16:46 INFO - PROCESS | 25693 | -------- Summary: end -------- 18:16:46 INFO - PROCESS | 25693 | 18:16:47 INFO - TEST-INFO | 25693: exit 0 18:16:47 INFO - TEST-OK | kraken | took 63931ms 18:16:47 INFO - SUITE-END | took 1180s 18:16:47 INFO - Completed test suite (00:19:40) 18:16:47 INFO - javascript benchmark 18:16:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6405.807196433443, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2599.8830052647636, 2614.947701045979, 2620.344913771557, 2623.7245089265616, 2627.579587266038, 4790.209615413457, 4805.759712014394, 4827.493113223105, 4839.733814640198, 4879.243717223827, 4756.334113224151, 4756.571908528232, 4804.183288840897, 4828.830990915319, 4869.196582563873, 4402.83324918896, 4436.264052469159, 4508.233600287943, 4526.026904215593, 4547.0, 179.66779205523554, 4461.486929003174, 4479.216137175998, 4522.909541809162, 4546.47715512717, 4427.845025424111, 4459.799309031101, 4472.46330440346, 4475.149721552927, 4503.279475283972, 4366.694331396803, 4489.506154323022, 4495.617872480843, 4500.617447516965, 4501.662375321864, 4398.626116780078, 4432.889177770549, 4435.246008178618, 4482.7758612069265, 4489.214387482178, 4778.95221047792, 4796.064767370364, 4822.083804077214, 4841.225403935354, 4890.951090489085, 5010.949890501085, 5084.161113416282, 5142.0, 5160.0969830279555, 5199.324087868591, 5263.735715355073, 5287.286216360781, 5287.894242115175, 5292.57659387252, 5333.866653333697, 4903.092927808331, 4906.092372911023, 4908.975455122773, 4909.656324057353, 4956.999999999964, 5216.1393370094265, 5219.921701174486, 5248.6588371755715, 5272.288241087481, 5391.083515802323, 5016.874578135576, 5025.974870125626, 5056.317397151338, 5065.56942659878, 5066.417362003343, 5111.386633603917, 5118.820841270612, 5122.641415100981, 5124.871878203, 5127.794968182474, 4975.0796102721115, 5083.212102124176, 5115.87210319745, 5118.462561430996, 5168.147255702842, 4884.072026314989, 5014.473480284591, 5025.321581586439, 5062.443131255559, 5099.9490005100215, 4423.557644235615, 4423.911521769546, 4426.468823741172, 4439.378487011821, 4459.152760975404, 3751.0809851586537, 3799.297130030953, 3813.466114743938, 3837.0407398150464, 3857.4406711027304, 4360.258756011485, 4372.213001659732, 4383.0, 4413.536578659195, 4424.358468022118, 5092.159793634009, 5145.819896303687, 5183.611229157828, 5184.688918664892, 5196.324477817935, 4338.089001309697, 4365.388845561624, 4368.388425620416, 4373.540778218305, 4380.561943805594, 4650.139724151043, 4661.440627124767, 4675.742834144086, 4706.1528924793865, 4711.905761884743, 4692.812287508462, 4763.666543341933, 4788.23388257884, 4799.736014519095, 4801.087793319328, 5160.303359046481, 5172.818951336685, 5202.661826981234, 5217.321748172713, 5250.0549901018185, 4791.185498465339, 4816.446108697544, 4826.927596086131, 4830.106430310404, 4860.635452341018, 4950.801967921243, 5002.274670172877, 5051.696898186121, 5118.181091025418, 5128.820491282787, 5170.1986192140275, 5189.922151167811, 5196.636235463632, 5205.037068142406, 5233.6074794389815, 5028.094942910311, 5029.823956161516, 5031.3207716959205, 5039.697618142924, 5075.5178258065425, 4824.34871292371, 4913.975430122827, 4970.403551573834, 5025.974870125626, 5032.144535429059, 4864.0, 4875.68308059975, 4875.80496780139, 4909.189983652657, 4932.087563800708, 5098.541131298052, 5102.795888164432, 5103.974480127724, 5118.33461649998, 5165.535101840853, 4801.95198048029, 4809.78355973989, 4982.75086245679, 4989.176785830297, 4993.154947106409], "value": 4697.720024683885, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.4528249109646, 557.0947210782479, 557.9525740312073, 573.1002326347634, 602.9027170549601, 36312.0, 40327.798361008194, 40389.192216155694, 40541.39187912184, 40545.59454405455, 40354.79822600883, 40937.0, 40983.0, 41007.38488922668, 41063.58936410635, 7726.845463090749, 7868.055833300012, 7875.803104922394, 7881.448298619099, 7881.448298619099, 7786.571738554378, 7856.214378562156, 7875.212478752136, 7876.094249161362, 7876.5667888266125, 7876.921230787705, 7890.0, 7905.249001344863, 7909.446338756289, 7910.920890791076, 7811.648475818602, 7855.41084418668, 7895.092064412551, 7904.920950790476, 7919.128895821455, 7813.453058285922, 7849.0, 7852.76441706744, 7870.606469676493, 7885.645145968445, 37628.81185594082, 38113.0, 38143.427848582294, 38152.23695526074, 38207.0, 2386.72552656445, 2843.1328444824526, 2895.7972941894077, 2997.9850100749577, 3012.2770535071645, 25710.10014649497, 27208.047718329963, 27628.58557121645, 27830.860845695843, 28314.29214269639, 3043.7260646541918, 3067.5858759067687, 3077.7383922366625, 3103.0690792762307, 3184.3949649566507, 224977.0, 225896.0, 226852.86573567192, 227073.0, 227462.0, 31923.68076319207, 32092.518612220836, 32415.837920810718, 32697.18257043593, 32969.0, 34154.316913662085, 34273.65726342754, 34433.0, 34458.655413446046, 34538.82730586331, 13712.17726936387, 13738.244396558286, 13866.098703584235, 13883.4446622136, 13887.930560347335, 11300.94349528247, 11411.60059397917, 11494.080473562095, 11511.251768635011, 11516.251443656303, 7954.204579542, 8031.0, 8048.315893149031, 8101.108878023413, 8111.067227268822, 3062.4181405532877, 3065.1877252528097, 3089.6910308968922, 3103.05356866158, 3124.5781819454537, 903.8508646073324, 908.6274627402734, 976.4287891583504, 977.731123940922, 996.1283876607968, 27536.0, 28918.27704307367, 29126.563101553493, 29285.85357073201, 29373.412531749247, 961.3030552849128, 994.1500017485091, 1000.2778549597099, 1067.4876059491332, 1088.2871719023894, 15308.923455382652, 15418.537443876701, 15426.845731542766, 15579.994243233174, 15707.293171807296, 360561.0, 362599.0, 364656.0, 365841.0, 367720.0, 48257.75871120622, 49431.25853112206, 49627.50372496301, 49680.0, 49789.253161202614, 1173.2960223865782, 1174.448009435564, 1200.2798321007501, 1207.8731733168067, 1225.3566877389264, 27561.448771024065, 27721.861390692917, 28298.434031318848, 28703.712962870104, 28843.711562884942, 42230.15539689128, 42379.576204237565, 42464.78767606266, 42478.78760606177, 42693.0, 294040.0, 301410.0, 302893.0, 303342.0, 303661.0, 25417.237482875542, 25512.489750205263, 25568.10511632084, 25773.484530309663, 25854.482910342063, 41560.376594351714, 42545.574544255396, 42699.0, 43223.783881080395, 43593.0, 37594.68418605336, 38052.809735951145, 38071.0, 38144.427833583075, 38423.80788096042, 37884.242315152995, 37958.43062354122, 38040.0, 38365.80817095897, 38378.61621383751, 31125.844370778002, 36123.63876361203, 36223.094422639646, 36259.81870090738, 36456.63543364532, 31975.840120799247, 33814.830925846196, 33887.49168762421, 33958.15104622404, 34299.485507716905, 25330.24009279651, 26017.219483415527, 26069.73930260749, 26126.86936565381, 26717.332066698487], "value": 16278.570255902803, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.0692210635507, 361.9077135330491, 372.8303621852058, 383.6815443182159, 389.07982621101087, 16080.678386432279, 16804.15979201041, 17963.91018044911, 17993.7300940486, 18018.369357072504, 17036.148192590354, 17537.736933946002, 18022.09889505526, 18037.639247215047, 18083.27666893326, 5177.430482646906, 5343.438938911417, 5361.758720857551, 5397.757100930448, 5406.8918621627545, 5271.65734227274, 5286.286351342558, 5336.0, 5345.492178243061, 5354.250404943311, 5144.922826157611, 5267.446918073604, 5300.363956325246, 5312.335958005249, 5317.069512835258, 5247.842564723064, 5259.76331065103, 5283.6037297202865, 5285.207218917155, 5323.813666521653, 4704.976475117637, 4731.810727570927, 4735.857924262277, 4757.048590281957, 4760.45254795696, 20576.279830206022, 21770.673439898415, 22001.449963750874, 22252.109915603356, 22468.55062898733, 1746.633207026526, 1781.4566557200048, 1889.4048374761906, 1904.1812020831037, 1910.770707515107, 13504.864951350557, 13592.660183495393, 13657.521986730417, 14009.299535023209, 14116.576502704935, 1751.8948863068129, 1778.0487439220085, 1786.7498550202981, 1807.9276828926827, 1822.334847780564, 46198.76900615509, 71358.28641713568, 71403.28596714018, 71553.0, 71629.64185179041, 9249.16757491829, 9695.272854535939, 9868.802623947624, 10026.548805303779, 10155.441450720133, 13716.245606491739, 13799.931000344934, 13809.51666691681, 13845.376958036912, 13846.446142154402, 7618.733344333033, 7636.427267954926, 7689.769306920802, 7816.374690024784, 7832.060152781589, 7459.0, 7491.10106787189, 7495.138059123271, 7627.389808815282, 7633.465657404039, 6164.229471316085, 6261.530385221126, 6287.528435367366, 6315.305316415191, 6404.534254312123, 1711.9400820971455, 1744.345870298638, 1772.3087995681694, 1793.5874748807848, 1832.862535309857, 873.868919662043, 875.2035647560689, 895.5746020640274, 913.9268858491305, 957.5020989085637, 17639.206235719423, 18070.18684159216, 18601.255949761857, 18707.15817788203, 18732.81267187338, 909.2771246858763, 914.3234006834895, 927.8566511358783, 943.0710749911332, 958.5878072428923, 10135.695929122137, 10495.737606559896, 10521.316114452537, 10568.207384446197, 10587.0, 361563.0, 363022.0, 364842.0, 366248.0, 377301.0, 40791.0, 49267.507324927006, 63973.36026639767, 64763.67618161879, 70887.0, 903.1600611431301, 922.8154369126202, 927.1423932862076, 950.2467946638441, 951.833429149896, 15429.61425964315, 15561.766573501633, 15675.0, 15913.0, 15945.0, 34642.48036279508, 36313.0, 37360.626393735714, 37750.811245943594, 38286.042848929, 48898.75550622224, 49521.50478495169, 49849.750751246014, 49991.25013124733, 50611.74694126506, 4384.430024096847, 4584.9312260315455, 6246.250449946036, 7256.346928776436, 7332.853342933005, 9694.272929530172, 9791.167750740982, 9877.209823213982, 9912.405255684682, 11481.885181148082, 9692.70921872345, 10097.495125243562, 10139.391636501834, 10314.587416503256, 10580.788384232426, 9586.95206523963, 9607.51962401863, 10062.195024397884, 10241.283110182216, 10329.32859364169, 10510.31682940637, 10606.204534659777, 10691.465426728788, 10785.245032847626, 11014.724631884266, 7376.4836461447185, 7535.321821035914, 7617.961910190414, 7672.232776722283, 7858.214178582096, 8208.0, 9837.360571562825, 10208.59165633396, 10406.687799365729, 10574.365538067741], "value": 8283.1944287306, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.4219028008235, 1426.3367534096642, 1499.3178103962691, 1683.335082642357, 1719.4927496388564, 6420.614763114217, 7375.37309328707, 7485.775426737193, 7794.961025194881, 7798.454108212427, 7631.122420921596, 7673.040869891263, 7708.30625243728, 7754.108277548084, 7761.844763104735, 2188.070070220154, 2216.900239489227, 2221.8111460525874, 2223.7109175807122, 2234.128689810975, 2195.879226642534, 2217.157480157538, 2263.60386932287, 2267.6031694453486, 2269.1377276634857, 2221.322496638533, 2233.452804062999, 2234.664800279963, 2251.2570851618925, 2259.0850705464313, 2199.9560008799813, 2204.0853045985896, 2208.536207396449, 2218.157100301891, 2222.922197723072, 2134.7224860768156, 2140.871547707143, 2145.216995796523, 2149.333706550974, 2158.7409510858643, 7720.575368354738, 7743.961280193563, 7774.378049756063, 7799.415043871732, 7863.803404914923, 4443.33349997503, 4557.521460246659, 4559.521250268707, 4560.498345182027, 4563.429571303587, 2773.6948935617065, 2788.4562510310498, 2849.401625658614, 2866.8423236721974, 2900.7389334959744, 811.5658122904218, 839.4040231435688, 848.6732607945924, 858.2661824140395, 883.1830556734994, 10062.547185376603, 10067.647632332833, 10097.0, 10102.39385636864, 10109.545070471846, 3962.445257663929, 4034.9394759078637, 4123.299039163349, 4150.522689890701, 4161.146964872194, 8656.047834738174, 8684.60919258635, 8700.30397568193, 8703.825923481494, 8716.302695784321, 4565.748883811356, 4578.175928332932, 4596.218642830727, 4603.148417542699, 4610.884727881829, 3550.751447398657, 4104.651104656137, 4206.158768246363, 4223.303154979394, 4226.070264541858, 3643.398839191557, 3656.74402791802, 3727.1800203955086, 3735.1595890924323, 3770.4344348347418, 1230.5816022552376, 1242.819791130299, 1246.9650190341995, 1250.7686078075585, 1251.268008215186, 755.4522970846093, 770.6994272233833, 775.352580595198, 787.6455594982281, 836.7531578184451, 4879.243717223836, 5079.545624616466, 5159.896802063938, 5213.661112027706, 5214.608904332114, 429.1674152144829, 434.71960585422227, 435.2383329173946, 937.6249500199974, 957.2198658093631, 3482.1294676330917, 3509.4384898416642, 3603.747737658391, 3617.5116359291687, 3654.8172591370326, 9129.589168487433, 9361.110694484014, 9380.296477764196, 9435.6697515588, 9466.148046675833, 9018.729438116867, 9366.62533498666, 9384.483853387992, 9426.293028022927, 9436.197923176469, 7222.386097181693, 7357.227491113356, 7394.11270647515, 7398.852022959511, 7427.517211381243, 5119.28330033803, 5217.556507696889, 5315.760790764502, 5326.786928522815, 5396.460353964572, 8550.82898342042, 8583.613737381707, 8726.389152759246, 8861.202491775772, 8862.955685221532, 8785.560721964004, 8816.338774591803, 8853.51305678194, 8892.33307501927, 9008.639654414012, 5817.0, 6315.55791094619, 6535.4444872184495, 6796.796096117125, 6922.446204303543, 7533.698652054076, 7570.05374328209, 7574.242575742602, 7605.087389513294, 7651.043619547557, 6753.797386078426, 6963.6866341013765, 6988.510804243654, 7050.612216328152, 7120.6795694194925, 6799.762008329685, 6886.827829304107, 6903.827404314932, 6909.654517274015, 6969.686364113526, 6023.849403764766, 6082.178905847831, 6114.144019837316, 6226.221722284715, 6265.8746825062335, 4354.238008348463, 4365.192439398721, 4406.192432691435, 4478.641708663365, 4479.776011199492, 4252.638525725348, 4325.7837108145095, 4343.154159482145, 4345.0, 4447.110577884371], "value": 4060.6172745395606, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.2119436479242, 305.87459141751884, 308.0, 308.0312417447128, 308.1326067121054, 5074.594032477402, 5115.439790863795, 5123.436421993582, 5135.512126347996, 5160.225966105086, 5050.722210278443, 5068.0, 5072.72100034498, 5095.0, 5095.490450954902, 3747.0445036515716, 3860.8455661773496, 3953.7430067045693, 3990.900227494307, 4000.639942405183, 3970.1662650843214, 3985.760854348734, 3998.6801055915603, 4006.13868018376, 4028.7784171870535, 3949.2693851637396, 3983.3228351180223, 3988.641022308006, 4009.8797036088818, 4027.2549578328103, 3709.9072523186865, 3948.881533553998, 3955.0, 4022.879313620596, 4028.5568587455355, 3428.422925454294, 3429.605595356541, 3433.296174284266, 3434.6737059979264, 3439.329330780499, 5029.497050294978, 5041.420236672793, 5047.545720885138, 5059.06407314648, 5097.672931786292, 4377.409049778271, 4531.886702832423, 4539.205639013159, 4540.228161212602, 4548.863534093983, 5383.596230282745, 5390.5418039466695, 5402.864928376783, 5419.268398766156, 5459.918101228484, 3905.882823515299, 3913.3934240192816, 3922.097917478996, 3925.568187499373, 3937.6652984496354, 5304.761285742113, 5716.771329146829, 5722.0, 5727.684977326246, 5734.913976290317, 3786.3718601001283, 3817.1602247505502, 3823.483829682957, 3825.713071519647, 3834.0, 3880.690988861679, 3886.2810380079777, 3890.910545047391, 3891.2217556488818, 3892.727509074394, 4452.243118669834, 4462.0104529965, 4466.821327146943, 4473.172463094338, 4493.618042466362, 5138.4604616514725, 5280.9207861882105, 5291.894162116736, 5316.973415132899, 5364.785408583613, 1371.3828777050367, 1380.7859781733848, 1382.384838746768, 1392.2968900705282, 1401.3133564553295, 890.7060669978891, 898.8292224477459, 905.6060613633091, 920.3189639666598, 925.1581061234244, 4544.795484203219, 4569.428821397325, 4581.679282450196, 4583.4041574595085, 4583.891409951393, 5441.510264076173, 5462.180672899097, 5470.671759694431, 5471.23402723619, 5503.449655034545, 4478.298246666312, 4499.482559505634, 4585.853536615846, 4595.1039547287955, 4604.654650901196, 2877.8704958276926, 2923.181509177434, 2931.750801181881, 2933.823970561773, 2943.617329747162, 4984.152694042022, 5050.368703912011, 5113.130767769489, 5125.359330083739, 5127.66670166438, 5277.604179686539, 5544.279243698374, 5571.749271282802, 5588.888222235532, 5607.345832979281, 5031.622628302892, 5037.4458809530925, 5046.167382381939, 5046.697198168122, 5057.875692209281, 5433.646812957145, 5441.183822426668, 5464.153056276284, 5468.179773034077, 5504.394516603251, 5117.8464646060675, 5329.653572517774, 5425.755840987086, 5449.782008719607, 5482.738970036834, 5185.196294574347, 5195.19474481456, 5195.818146364859, 5197.428282888804, 5214.165733482625, 3768.3217020936495, 3794.317022935898, 3802.9239415210986, 3807.2004878975727, 3815.427685847034, 5267.0, 5554.2779438672715, 5578.3584887738425, 5616.315105468261, 5653.717314134359, 5384.7576859040655, 5414.648047876875, 5436.656456279439, 5444.50999410055, 5467.5625949923115, 5204.687718736888, 5390.946090539202, 5394.514493695587, 5410.1343784994215, 5476.589255805751, 5300.337457817773, 5303.223420154137, 5304.761285742074, 5315.282436871127, 5340.679559226459, 5168.793248270027, 5225.268462415341, 5388.434214407587, 5398.0, 5402.189671549142, 5266.131088370376, 5302.973485132549, 5328.8401347959625, 5345.625806193529, 5375.596830237826], "value": 4013.6762643554994, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.291610892454, 674.376202013138, 686.4096876686052, 705.6189657584904, 739.866823971685, 13253.403596838141, 13689.247091409981, 13693.657658558528, 13707.588772336821, 14923.776143357858, 14535.345909434074, 14670.706585868276, 14680.706385872303, 14688.632784180401, 14729.92635036826, 632.1497585747163, 780.637003793236, 803.1566854802463, 808.4017826808179, 810.2262339465825, 773.8955241042472, 794.5749024272016, 796.2714116583319, 802.458340620082, 804.16768644453, 836.2682652678906, 843.3464065349342, 843.4686147726924, 843.6203708331245, 844.586152785137, 827.6234313387395, 837.4933165434916, 838.5807096451774, 839.0267289943636, 840.436907272123, 601.8284788835161, 605.1346574398608, 608.3976862905736, 609.1259043272873, 611.5199568338877, 13634.045616806827, 13647.86352136476, 13710.24593647349, 13720.862791372158, 13741.519046833413, 13528.729425411535, 13616.387262573207, 13786.172829630254, 13903.235322057282, 13957.162570245717, 10018.59925602975, 10142.645007424704, 10164.542595583216, 10287.074163325336, 10327.380357178594, 3255.755818313636, 3267.591551056118, 3314.1880239341276, 3323.7507186961075, 3393.372226138172, 60946.695266523384, 62037.37962620361, 63561.999999999534, 64032.3596764031, 64190.358096419375, 10643.946780266204, 10647.84028239577, 10723.0, 10781.730456738487, 10821.83767243492, 18148.727769083474, 18721.157547910378, 18805.62388752217, 19406.12672429716, 19542.70685939712, 7179.317964793337, 7182.60495672743, 7213.963930180315, 7301.050863387832, 7354.96322518384, 3728.3289007978283, 3798.810059497014, 3802.923941521154, 3805.7906815125434, 3831.2529056834205, 2968.228260652246, 3079.707427794356, 3080.2299425143715, 3080.2761351082477, 3082.3372974810522, 530.5887936848973, 540.1330863963361, 541.0180522351918, 547.975341109651, 551.7903196785196, 571.7684337843181, 601.1583782704249, 608.2305883057935, 627.6391075131726, 636.7771280051945, 7921.0, 8132.512049277062, 8173.632186551619, 8291.419600628018, 8345.54099524532, 493.64704236471096, 500.38968839820865, 552.1937970562943, 566.3119310038323, 573.5554944917723, 3756.4553139794575, 4153.480814898137, 4190.099128687347, 4207.305794543927, 4227.281362168439, 90258.54870725605, 91016.0, 93507.53246233861, 94082.529587353, 96819.51590242004, 81029.0, 81712.0, 82160.0, 83113.58443207745, 83914.16085839186, 72973.27026729664, 73977.0, 75674.24325756672, 75880.0, 76851.99999999888, 7961.681532738626, 8615.827683446421, 8708.477491350539, 8847.336449766164, 8922.152395522415, 40694.79652601718, 41197.382039270036, 41531.792341038104, 43951.340729889715, 44256.67229983106, 61228.69385653043, 61879.6906015467, 62465.37534624596, 65191.0, 65375.34624653692, 12120.068150547479, 12225.816612750637, 12226.694332641398, 12428.75142497127, 12555.623331300076, 12825.551105711254, 13104.0, 13386.397612107285, 13459.596212113653, 14026.01817872739, 11020.173486988348, 11288.32270063766, 11301.604443844426, 11312.773744525228, 11337.489812958273, 11625.18623696333, 11906.880931190577, 11944.343061131722, 12000.219985700902, 12041.759164816829, 10671.092957098423, 11353.205275630626, 11654.592089276835, 11819.468123934272, 12004.519819207135, 9760.707178784647, 9779.0, 10100.646477373257, 10471.183434004854, 10548.0, 9719.708408747749, 10227.54491017964, 10319.742006449898, 10349.327293725884, 10360.792784144425], "value": 6692.104609667807, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 110.0, 116.0, 115.0, 117.0, 115.0, 114.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 128.0, 147.0, 177.0, 124.0, 157.0, 150.0, 127.0, 183.0, 123.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 166.0, 170.0, 164.0, 163.0, 164.0, 164.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 151.0, 78.0, 78.0, 76.0, 78.0, 164.0, 77.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 140.0, 86.0, 87.0, 85.0, 138.0, 86.0, 86.0, 139.0], "value": 101.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 119.0, 118.0, 118.0, 118.0, 117.0, 120.0, 119.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 68.0, 66.0, 65.0, 68.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 81.0, 79.0, 81.0, 78.0, 80.0, 88.0, 89.0, 80.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 133.0, 137.0, 143.0, 134.0, 134.0, 132.0, 169.0, 136.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 166.0, 172.0, 167.0, 173.0, 166.0, 166.0, 170.0, 164.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 72.0, 67.0, 71.0, 70.0, 67.0, 68.0, 70.0, 68.0], "value": 69.4, "unit": "score"}]}]} 18:16:47 INFO - Return code: 0 18:16:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:16:47 ERROR - # TBPL SUCCESS # 18:16:47 INFO - Running post-action listener: _resource_record_post_action 18:16:47 INFO - ##### 18:16:47 INFO - ##### Finished run-tests step (success) 18:16:47 INFO - ##### 18:16:47 INFO - Running post-run listener: _resource_record_post_run 18:16:47 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 20480; Write bytes: 534700032; Read time: 296; Write time: 415884 18:16:47 INFO - TinderboxPrint: CPU usage
13.3% 18:16:47 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 296 18:16:47 INFO - TinderboxPrint: I/O write bytes / time
534,700,032 / 415,884 18:16:47 INFO - TinderboxPrint: CPU idle
8,280.4 (86.7%) 18:16:47 INFO - TinderboxPrint: CPU user
1,218.5 (12.8%) 18:16:47 INFO - TinderboxPrint: Swap in / out
0 / 0 18:16:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 8192; Write bytes: 245903360; Read time: 168; Write time: 207868 18:16:47 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288055296; Read time: 116; Write time: 207988 18:16:48 INFO - Running post-run listener: _upload_blobber_files 18:16:48 INFO - Blob upload gear active. 18:16:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:16:48 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 18:16:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:16:48 INFO - (blobuploader) - INFO - Open directory for files ... 18:16:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:16:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:16:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:52 INFO - (blobuploader) - INFO - Done attempting. 18:16:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:16:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:16:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:53 INFO - (blobuploader) - INFO - Done attempting. 18:16:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:16:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:16:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:54 INFO - (blobuploader) - INFO - Done attempting. 18:16:54 INFO - (blobuploader) - INFO - Iteration through files over. 18:16:54 INFO - Return code: 0 18:16:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:16:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:16:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d299f45c981414e66e3494f87b6a62e9c5a7deaf699464c76a01da0813c44f4df7b99ad8fb6c2200df8c13787b5c45783bbb8d299541ade614301eedb0b23d9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7fa77622fcde1f98ee565c1bda2db6b578b69df1dad57d3af369e0e369997f8bc8872a3afc3f58b4692c451516f4eea7b680f3ac21d18eedead1ed675a14997", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f83c14ed51e5289df0ae10119942a9999bcc6fd335b0c92403f911aa2a76d1734e3c5f81e4eff92e536bd5e1c1dd12be6145c0f23838d10a647d2db03872749e"} 18:16:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:16:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:16:54 INFO - Contents: 18:16:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d299f45c981414e66e3494f87b6a62e9c5a7deaf699464c76a01da0813c44f4df7b99ad8fb6c2200df8c13787b5c45783bbb8d299541ade614301eedb0b23d9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7fa77622fcde1f98ee565c1bda2db6b578b69df1dad57d3af369e0e369997f8bc8872a3afc3f58b4692c451516f4eea7b680f3ac21d18eedead1ed675a14997", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f83c14ed51e5289df0ae10119942a9999bcc6fd335b0c92403f911aa2a76d1734e3c5f81e4eff92e536bd5e1c1dd12be6145c0f23838d10a647d2db03872749e"} 18:16:54 INFO - Running post-run listener: copy_logs_to_upload_dir 18:16:54 INFO - Copying logs to upload dir... 18:16:54 INFO - mkdir: /builds/slave/test/build/upload/logs 18:16:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.558222 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-07 18:16:54.385268) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 18:16:54.389063) ========= 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=03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d299f45c981414e66e3494f87b6a62e9c5a7deaf699464c76a01da0813c44f4df7b99ad8fb6c2200df8c13787b5c45783bbb8d299541ade614301eedb0b23d9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7fa77622fcde1f98ee565c1bda2db6b578b69df1dad57d3af369e0e369997f8bc8872a3afc3f58b4692c451516f4eea7b680f3ac21d18eedead1ed675a14997", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f83c14ed51e5289df0ae10119942a9999bcc6fd335b0c92403f911aa2a76d1734e3c5f81e4eff92e536bd5e1c1dd12be6145c0f23838d10a647d2db03872749e"} build_url:https://queue.taskcluster.net/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011433 build_url: 'https://queue.taskcluster.net/v1/task/LSn2p32sSQOeTDLFemWHBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d299f45c981414e66e3494f87b6a62e9c5a7deaf699464c76a01da0813c44f4df7b99ad8fb6c2200df8c13787b5c45783bbb8d299541ade614301eedb0b23d9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7fa77622fcde1f98ee565c1bda2db6b578b69df1dad57d3af369e0e369997f8bc8872a3afc3f58b4692c451516f4eea7b680f3ac21d18eedead1ed675a14997", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f83c14ed51e5289df0ae10119942a9999bcc6fd335b0c92403f911aa2a76d1734e3c5f81e4eff92e536bd5e1c1dd12be6145c0f23838d10a647d2db03872749e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 18:16:54.414630) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:16:54.414980) ========= 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=03627c79f6bb3d1578c4a402000001ba-1467939044.572441-2140631549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:16:54.498454) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 18:16:54.498781) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 18:16:54.499086) ========= ========= Total master_lag: 0.21 =========