builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-057 starttime: 1468338453.56 results: success (0) buildid: 20160712072926 builduid: 2a755032168f4c49823b29fbd3de34fb revision: 965a291ce94981239d55bb1cf45e1279faa788a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 08:47:33.560763) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 08:47:33.561395) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 08:47:33.561681) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 08:47:33.718315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 08:47:33.718757) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 08:47:33-- 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% 46.5M=0s 2016-07-12 08:47:34 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077741 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 08:47:33.824816) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 08:47:33.825119) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019412 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 08:47:33.893670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 08:47:33.893981) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 965a291ce94981239d55bb1cf45e1279faa788a9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 965a291ce94981239d55bb1cf45e1279faa788a9 --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=934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 08:47:34,191 truncating revision to first 12 chars 2016-07-12 08:47:34,191 Setting DEBUG logging. 2016-07-12 08:47:34,191 attempt 1/10 2016-07-12 08:47:34,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/965a291ce949?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 08:47:34,514 unpacking tar archive at: mozilla-central-965a291ce949/testing/mozharness/ program finished with exit code 0 elapsedTime=0.696396 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 08:47:34.605178) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 08:47:34.605657) ========= script_repo_revision: 965a291ce94981239d55bb1cf45e1279faa788a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 08:47:34.606276) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 08:47:34.606704) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 08:47:34.618000) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-12 08:47:34.618611) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:47:34 INFO - MultiFileLogger online at 20160712 08:47:34 in /builds/slave/test 08:47:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:47:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:47:35 INFO - {'append_to_log': False, 08:47:35 INFO - 'base_work_dir': '/builds/slave/test', 08:47:35 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:47:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:47:35 INFO - 'branch': 'Firefox-Non-PGO', 08:47:35 INFO - 'buildbot_json_path': 'buildprops.json', 08:47:35 INFO - 'config_files': ('talos/linux_config.py',), 08:47:35 INFO - 'default_actions': ('clobber', 08:47:35 INFO - 'read-buildbot-config', 08:47:35 INFO - 'download-and-extract', 08:47:35 INFO - 'populate-webroot', 08:47:35 INFO - 'create-virtualenv', 08:47:35 INFO - 'install', 08:47:35 INFO - 'run-tests'), 08:47:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:47:35 INFO - 'download_minidump_stackwalk': True, 08:47:35 INFO - 'download_symbols': 'ondemand', 08:47:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:47:35 INFO - 'tooltool.py': '/tools/tooltool.py', 08:47:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:47:35 INFO - '/tools/misc-python/virtualenv.py')}, 08:47:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:47:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:47:35 INFO - 'installer_path': 'installer.exe', 08:47:35 INFO - 'log_level': 'info', 08:47:35 INFO - 'log_name': 'talos', 08:47:35 INFO - 'log_to_console': True, 08:47:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:47:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:47:35 INFO - 'opt_config_files': (), 08:47:35 INFO - 'pip_index': False, 08:47:35 INFO - 'sps_profile': False, 08:47:35 INFO - 'sps_profile_interval': 0, 08:47:35 INFO - 'suite': 'dromaeojs-e10s', 08:47:35 INFO - 'system_bits': '32', 08:47:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:47:35 INFO - 'title': 'talos-linux64-ix-057', 08:47:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:47:35 INFO - 'use_talos_json': True, 08:47:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:47:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:47:35 INFO - 'work_dir': 'build'} 08:47:35 INFO - ##### 08:47:35 INFO - ##### Running clobber step. 08:47:35 INFO - ##### 08:47:35 INFO - Running pre-action listener: _resource_record_pre_action 08:47:35 INFO - Running main action method: clobber 08:47:35 INFO - rmtree: /builds/slave/test/build 08:47:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:47:36 INFO - Running post-action listener: _resource_record_post_action 08:47:36 INFO - ##### 08:47:36 INFO - ##### Finished clobber step (success) 08:47:36 INFO - ##### 08:47:36 INFO - ##### 08:47:36 INFO - ##### Running read-buildbot-config step. 08:47:36 INFO - ##### 08:47:36 INFO - Running pre-action listener: _resource_record_pre_action 08:47:36 INFO - Running main action method: read_buildbot_config 08:47:36 INFO - Using buildbot properties: 08:47:36 INFO - { 08:47:36 INFO - "project": "", 08:47:36 INFO - "product": "firefox", 08:47:36 INFO - "script_repo_revision": "production", 08:47:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:47:36 INFO - "repository": "", 08:47:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:47:36 INFO - "buildid": "20160712072926", 08:47:36 INFO - "pgo_build": "False", 08:47:36 INFO - "basedir": "/builds/slave/test", 08:47:36 INFO - "buildnumber": 396, 08:47:36 INFO - "slavename": "talos-linux64-ix-057", 08:47:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:47:36 INFO - "platform": "ubuntu64_hw", 08:47:36 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:47:36 INFO - "branch": "mozilla-central", 08:47:36 INFO - "repo_path": "mozilla-central", 08:47:36 INFO - "revision": "965a291ce94981239d55bb1cf45e1279faa788a9", 08:47:36 INFO - "stage_platform": "linux64", 08:47:36 INFO - "builduid": "2a755032168f4c49823b29fbd3de34fb", 08:47:36 INFO - "slavebuilddir": "test" 08:47:36 INFO - } 08:47:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:47:36 INFO - Running post-action listener: _resource_record_post_action 08:47:36 INFO - ##### 08:47:36 INFO - ##### Finished read-buildbot-config step (success) 08:47:36 INFO - ##### 08:47:36 INFO - ##### 08:47:36 INFO - ##### Running download-and-extract step. 08:47:36 INFO - ##### 08:47:36 INFO - Running pre-action listener: _resource_record_pre_action 08:47:36 INFO - Running main action method: download_and_extract 08:47:36 INFO - mkdir: /builds/slave/test/build/tests 08:47: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')]} 08:47:36 INFO - https://queue.taskcluster.net/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:47:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:47:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:47:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/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 08:47:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/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 08:47:40 INFO - Downloaded 1361 bytes. 08:47:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:47:40 INFO - Using the following test package requirements: 08:47:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:47:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:47:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:47:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:40 INFO - u'jsshell-linux-x86_64.zip'], 08:47:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:47:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:47:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:47:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:47:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:47:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:47:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:47:40 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')]} 08:47:40 INFO - https://queue.taskcluster.net/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:47:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:47:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:47:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/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 08:47:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/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 08:47:41 INFO - Downloaded 22700490 bytes. 08:47:41 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'] 08:47:41 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 08:47:42 INFO - Return code: 0 08:47:42 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 08:47:42 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')]} 08:47:42 INFO - https://queue.taskcluster.net/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:47:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:47:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:47:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/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 08:47:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/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 08:47:43 INFO - Downloaded 22700490 bytes. 08:47:43 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'] 08:47:43 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 08:47:45 INFO - Return code: 0 08:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:45 INFO - https://queue.taskcluster.net/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:47:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:47:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:47:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/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 08:47:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/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 08:47:46 INFO - Downloaded 14403317 bytes. 08:47:46 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'] 08:47:46 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 08:47:46 INFO - Return code: 0 08:47: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')]} 08:47:46 INFO - https://queue.taskcluster.net/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:47:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:47:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:47:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/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 08:47:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/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 08:47:47 INFO - Downloaded 56655879 bytes. 08:47:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:47:47 INFO - mkdir: /builds/slave/test/properties 08:47:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:47:47 INFO - Writing to file /builds/slave/test/properties/build_url 08:47:47 INFO - Contents: 08:47:47 INFO - build_url:https://queue.taskcluster.net/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:47:48 INFO - Running post-action listener: _resource_record_post_action 08:47:48 INFO - Running post-action listener: set_extra_try_arguments 08:47:48 INFO - ##### 08:47:48 INFO - ##### Finished download-and-extract step (success) 08:47:48 INFO - ##### 08:47:48 INFO - ##### 08:47:48 INFO - ##### Running populate-webroot step. 08:47:48 INFO - ##### 08:47:48 INFO - Running pre-action listener: _resource_record_pre_action 08:47:48 INFO - Running main action method: populate_webroot 08:47:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:47:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:47:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:47:48 INFO - '--tppagecycles', 08:47:48 INFO - '7'], 08:47:48 INFO - 'tests': ['tsvgm']}}, 08:47:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:47:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:47:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:47:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:47:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:47:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:47:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:48 INFO - 'talos_options': ['--disable-e10s'], 08:47:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:48 INFO - 'talos_options': ['--disable-e10s'], 08:47:48 INFO - 'tests': ['damp', 'tps']}, 08:47:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:48 INFO - 'tests': ['damp', 'tps']}, 08:47:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:47:48 INFO - 'tests': ['dromaeo_dom']}, 08:47:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:47:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:47:48 INFO - 'tests': ['basic_compositor_video']}, 08:47:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:47:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:47:48 INFO - 'tests': ['a11yr', 08:47:48 INFO - 'ts_paint', 08:47:48 INFO - 'tpaint', 08:47:48 INFO - 'sessionrestore', 08:47:48 INFO - 'sessionrestore_no_auto_restore', 08:47:48 INFO - 'tabpaint']}, 08:47:48 INFO - 'other-e10s': {'tests': ['a11yr', 08:47:48 INFO - 'ts_paint', 08:47:48 INFO - 'tpaint', 08:47:48 INFO - 'sessionrestore', 08:47:48 INFO - 'sessionrestore_no_auto_restore', 08:47:48 INFO - 'tabpaint']}, 08:47:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:47:48 INFO - 'ts_paint', 08:47:48 INFO - 'tpaint', 08:47:48 INFO - 'sessionrestore', 08:47:48 INFO - 'sessionrestore_no_auto_restore', 08:47:48 INFO - 'tabpaint']}, 08:47:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:47:48 INFO - 'ts_paint', 08:47:48 INFO - 'tpaint', 08:47:48 INFO - 'sessionrestore', 08:47:48 INFO - 'sessionrestore_no_auto_restore', 08:47:48 INFO - 'tabpaint']}, 08:47:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:47:48 INFO - 'tests': ['a11yr', 08:47:48 INFO - 'ts_paint', 08:47:48 INFO - 'tpaint', 08:47:48 INFO - 'sessionrestore', 08:47:48 INFO - 'sessionrestore_no_auto_restore', 08:47:48 INFO - 'tabpaint']}, 08:47:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:47:48 INFO - 'tests': ['a11yr', 08:47:48 INFO - 'ts_paint', 08:47:48 INFO - 'tpaint', 08:47:48 INFO - 'sessionrestore', 08:47:48 INFO - 'sessionrestore_no_auto_restore', 08:47:48 INFO - 'tabpaint']}, 08:47:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:47:48 INFO - 'tests': ['tsvgx', 08:47:48 INFO - 'tsvgr_opacity', 08:47:48 INFO - 'tart', 08:47:48 INFO - 'tscrollx', 08:47:48 INFO - 'cart']}, 08:47:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:47:48 INFO - 'tsvgr_opacity', 08:47:48 INFO - 'tart', 08:47:48 INFO - 'tscrollx', 08:47:48 INFO - 'cart']}, 08:47:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:48 INFO - 'talos_options': ['--disable-e10s'], 08:47:48 INFO - 'tests': ['tp5o']}, 08:47:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:48 INFO - 'tests': ['tp5o']}, 08:47:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:48 INFO - 'talos_options': ['--disable-e10s', 08:47:48 INFO - '--xperf_path', 08:47:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:48 INFO - 'tests': ['tp5n']}, 08:47:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:48 INFO - 'talos_options': ['--xperf_path', 08:47:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:48 INFO - 'tests': ['tp5n']}}, 08:47:48 INFO - 'talos.zip': {'path': '', 08:47:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:47:48 INFO - Running post-action listener: _resource_record_post_action 08:47:48 INFO - ##### 08:47:48 INFO - ##### Finished populate-webroot step (success) 08:47:48 INFO - ##### 08:47:48 INFO - ##### 08:47:48 INFO - ##### Running create-virtualenv step. 08:47:48 INFO - ##### 08:47:48 INFO - Running pre-action listener: _resource_record_pre_action 08:47:48 INFO - Running main action method: create_virtualenv 08:47:48 INFO - Creating virtualenv /builds/slave/test/build/venv 08:47:48 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 08:47:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:47:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:47:48 INFO - Using real prefix '/usr' 08:47:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:47:49 INFO - Installing distribute.............................................................................................................................................................................................done. 08:47:51 INFO - Installing pip.................done. 08:47:51 INFO - Return code: 0 08:47:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:47:51 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')]} 08:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:51 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')]} 08:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:51 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 0xc9b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf59570>, '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 0xf5a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', '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 08:47:51 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 08:47:51 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 08:47:51 INFO - Using env: {'DISPLAY': ':0', 08:47:51 INFO - 'HOME': '/home/cltbld', 08:47:51 INFO - 'LANG': 'en_US.UTF-8', 08:47:51 INFO - 'LANGUAGE': 'en_US:en', 08:47:51 INFO - 'LOGNAME': 'cltbld', 08:47:51 INFO - 'MAIL': '/var/mail/cltbld', 08:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:51 INFO - 'MOZ_NO_REMOTE': '1', 08:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:51 INFO - 'NO_EM_RESTART': '1', 08:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:51 INFO - 'PWD': '/builds/slave/test', 08:47:51 INFO - 'SHELL': '/bin/bash', 08:47:51 INFO - 'SHLVL': '1', 08:47:51 INFO - 'TERM': 'linux', 08:47:51 INFO - 'TMOUT': '86400', 08:47:51 INFO - 'USER': 'cltbld', 08:47:51 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', 08:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:51 INFO - '_': '/tools/buildbot/bin/python'} 08:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:51 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 08:47:51 INFO - Cleaning up... 08:47:51 INFO - Return code: 0 08:47:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:47:51 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')]} 08:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:51 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')]} 08:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:51 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 0xc9b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf59570>, '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 0xf5a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', '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 08:47:51 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 08:47:51 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 08:47:51 INFO - Using env: {'DISPLAY': ':0', 08:47:51 INFO - 'HOME': '/home/cltbld', 08:47:51 INFO - 'LANG': 'en_US.UTF-8', 08:47:51 INFO - 'LANGUAGE': 'en_US:en', 08:47:51 INFO - 'LOGNAME': 'cltbld', 08:47:51 INFO - 'MAIL': '/var/mail/cltbld', 08:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:51 INFO - 'MOZ_NO_REMOTE': '1', 08:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:51 INFO - 'NO_EM_RESTART': '1', 08:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:51 INFO - 'PWD': '/builds/slave/test', 08:47:51 INFO - 'SHELL': '/bin/bash', 08:47:51 INFO - 'SHLVL': '1', 08:47:51 INFO - 'TERM': 'linux', 08:47:51 INFO - 'TMOUT': '86400', 08:47:51 INFO - 'USER': 'cltbld', 08:47:51 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', 08:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:51 INFO - '_': '/tools/buildbot/bin/python'} 08:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:51 INFO - Downloading/unpacking psutil>=3.1.1 08:47:51 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 08:47:51 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 08:47:51 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 08:47:51 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 08:47:51 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 08:47:51 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 08:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:47:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:47:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:47:53 INFO - Installing collected packages: psutil 08:47:53 INFO - Running setup.py install for psutil 08:47:53 INFO - building 'psutil._psutil_linux' extension 08:47:53 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 08:47:54 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 08:47:54 INFO - building 'psutil._psutil_posix' extension 08:47:54 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 08:47:54 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 08:47:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:47:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:47:54 INFO - Successfully installed psutil 08:47:54 INFO - Cleaning up... 08:47:54 INFO - Return code: 0 08:47:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:54 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 0xc9b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf59570>, '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 0xf5a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', '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 08:47:54 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 08:47:54 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 08:47:54 INFO - Using env: {'DISPLAY': ':0', 08:47:54 INFO - 'HOME': '/home/cltbld', 08:47:54 INFO - 'LANG': 'en_US.UTF-8', 08:47:54 INFO - 'LANGUAGE': 'en_US:en', 08:47:54 INFO - 'LOGNAME': 'cltbld', 08:47:54 INFO - 'MAIL': '/var/mail/cltbld', 08:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:54 INFO - 'MOZ_NO_REMOTE': '1', 08:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:54 INFO - 'NO_EM_RESTART': '1', 08:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:54 INFO - 'PWD': '/builds/slave/test', 08:47:54 INFO - 'SHELL': '/bin/bash', 08:47:54 INFO - 'SHLVL': '1', 08:47:54 INFO - 'TERM': 'linux', 08:47:54 INFO - 'TMOUT': '86400', 08:47:54 INFO - 'USER': 'cltbld', 08:47:54 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', 08:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:54 INFO - '_': '/tools/buildbot/bin/python'} 08:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:47:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:47:56 INFO - Installing collected packages: mozsystemmonitor 08:47:56 INFO - Running setup.py install for mozsystemmonitor 08:47:56 INFO - Successfully installed mozsystemmonitor 08:47:56 INFO - Cleaning up... 08:47:56 INFO - Return code: 0 08:47:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:56 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 0xc9b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf59570>, '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 0xf5a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', '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 08:47:56 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 08:47:56 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 08:47:56 INFO - Using env: {'DISPLAY': ':0', 08:47:56 INFO - 'HOME': '/home/cltbld', 08:47:56 INFO - 'LANG': 'en_US.UTF-8', 08:47:56 INFO - 'LANGUAGE': 'en_US:en', 08:47:56 INFO - 'LOGNAME': 'cltbld', 08:47:56 INFO - 'MAIL': '/var/mail/cltbld', 08:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:56 INFO - 'MOZ_NO_REMOTE': '1', 08:47:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:56 INFO - 'NO_EM_RESTART': '1', 08:47:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:56 INFO - 'PWD': '/builds/slave/test', 08:47:56 INFO - 'SHELL': '/bin/bash', 08:47:56 INFO - 'SHLVL': '1', 08:47:56 INFO - 'TERM': 'linux', 08:47:56 INFO - 'TMOUT': '86400', 08:47:56 INFO - 'USER': 'cltbld', 08:47:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', 08:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:56 INFO - '_': '/tools/buildbot/bin/python'} 08:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:56 INFO - Downloading/unpacking jsonschema==2.5.1 08:47:56 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 08:47:56 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 08:47:56 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 08:47:56 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 08:47:56 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 08:47:56 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 08:47:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:47:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:47:58 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 08:47:58 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 08:47:58 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 08:47:58 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 08:47:58 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 08:47:58 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 08:47:59 INFO - Downloading functools32-3.2.3-2.tar.gz 08:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:47:59 INFO - warning: no files found matching '*.txt' 08:47:59 INFO - no previously-included directories found matching 'build' 08:47:59 INFO - no previously-included directories found matching 'dist' 08:47:59 INFO - no previously-included directories found matching '.git*' 08:47:59 INFO - Installing collected packages: jsonschema, functools32 08:47:59 INFO - Running setup.py install for functools32 08:47:59 INFO - warning: no files found matching '*.txt' 08:47:59 INFO - no previously-included directories found matching 'build' 08:47:59 INFO - no previously-included directories found matching 'dist' 08:47:59 INFO - no previously-included directories found matching '.git*' 08:47:59 INFO - Successfully installed jsonschema functools32 08:47:59 INFO - Cleaning up... 08:47:59 INFO - Return code: 0 08:47:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:59 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 0xc9b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf59570>, '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 0xf5a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', '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 08:47:59 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 08:47:59 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 08:47:59 INFO - Using env: {'DISPLAY': ':0', 08:47:59 INFO - 'HOME': '/home/cltbld', 08:47:59 INFO - 'LANG': 'en_US.UTF-8', 08:47:59 INFO - 'LANGUAGE': 'en_US:en', 08:47:59 INFO - 'LOGNAME': 'cltbld', 08:47:59 INFO - 'MAIL': '/var/mail/cltbld', 08:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:59 INFO - 'MOZ_NO_REMOTE': '1', 08:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:59 INFO - 'NO_EM_RESTART': '1', 08:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:59 INFO - 'PWD': '/builds/slave/test', 08:47:59 INFO - 'SHELL': '/bin/bash', 08:47:59 INFO - 'SHLVL': '1', 08:47:59 INFO - 'TERM': 'linux', 08:47:59 INFO - 'TMOUT': '86400', 08:47:59 INFO - 'USER': 'cltbld', 08:47:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', 08:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:59 INFO - '_': '/tools/buildbot/bin/python'} 08:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:59 INFO - Downloading/unpacking blobuploader==1.2.4 08:47:59 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 08:47:59 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 08:47:59 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 08:47:59 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 08:47:59 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 08:47:59 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 08:48:01 INFO - Downloading blobuploader-1.2.4.tar.gz 08:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:48:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:48:01 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 08:48:01 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 08:48:01 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 08:48:01 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 08:48:01 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 08:48:01 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 08:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:48:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:48:01 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 08:48:01 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 08:48:01 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 08:48:01 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 08:48:01 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 08:48:01 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 08:48:02 INFO - Downloading docopt-0.6.1.tar.gz 08:48:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:48:02 INFO - Installing collected packages: blobuploader, requests, docopt 08:48:02 INFO - Running setup.py install for blobuploader 08:48:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:48:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:48:02 INFO - Running setup.py install for requests 08:48:02 INFO - Running setup.py install for docopt 08:48:02 INFO - Successfully installed blobuploader requests docopt 08:48:02 INFO - Cleaning up... 08:48:02 INFO - Return code: 0 08:48:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48: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')]} 08:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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')]} 08:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:02 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 0xc9b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf59570>, '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 0xf5a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', '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 08:48:02 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 08:48:02 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 08:48:02 INFO - Using env: {'DISPLAY': ':0', 08:48:02 INFO - 'HOME': '/home/cltbld', 08:48:02 INFO - 'LANG': 'en_US.UTF-8', 08:48:02 INFO - 'LANGUAGE': 'en_US:en', 08:48:02 INFO - 'LOGNAME': 'cltbld', 08:48:02 INFO - 'MAIL': '/var/mail/cltbld', 08:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:02 INFO - 'MOZ_NO_REMOTE': '1', 08:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:02 INFO - 'NO_EM_RESTART': '1', 08:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:02 INFO - 'PWD': '/builds/slave/test', 08:48:02 INFO - 'SHELL': '/bin/bash', 08:48:02 INFO - 'SHLVL': '1', 08:48:02 INFO - 'TERM': 'linux', 08:48:02 INFO - 'TMOUT': '86400', 08:48:02 INFO - 'USER': 'cltbld', 08:48:02 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', 08:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:02 INFO - '_': '/tools/buildbot/bin/python'} 08:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:03 INFO - Running setup.py (path:/tmp/pip-fJc2ZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:03 INFO - Running setup.py (path:/tmp/pip-vH2UsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:03 INFO - Running setup.py (path:/tmp/pip-8hURkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:03 INFO - Running setup.py (path:/tmp/pip-dJnemI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:03 INFO - Running setup.py (path:/tmp/pip-gwtP2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:03 INFO - Running setup.py (path:/tmp/pip-qPoiwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:03 INFO - Running setup.py (path:/tmp/pip-5xR_ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:03 INFO - Running setup.py (path:/tmp/pip-HblcXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:03 INFO - Running setup.py (path:/tmp/pip-gFxqWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:03 INFO - Running setup.py (path:/tmp/pip-lOqywS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:03 INFO - Running setup.py (path:/tmp/pip-Kwu9D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:03 INFO - Running setup.py (path:/tmp/pip-ywpQkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:03 INFO - Running setup.py (path:/tmp/pip-Mof2dx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:03 INFO - Running setup.py (path:/tmp/pip-qsFGXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:04 INFO - Running setup.py (path:/tmp/pip-IKfOAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:04 INFO - Running setup.py (path:/tmp/pip-CfkqrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:04 INFO - Running setup.py (path:/tmp/pip-VV_RUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:48:04 INFO - Running setup.py install for manifestparser 08:48:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:48:04 INFO - Running setup.py install for mozcrash 08:48:04 INFO - Running setup.py install for mozdebug 08:48:04 INFO - Running setup.py install for mozdevice 08:48:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:48:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:48:04 INFO - Running setup.py install for mozfile 08:48:04 INFO - Running setup.py install for mozhttpd 08:48:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:48:04 INFO - Running setup.py install for mozinfo 08:48:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:48:04 INFO - Running setup.py install for mozInstall 08:48:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:48:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:48:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:48:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:48:05 INFO - Running setup.py install for mozleak 08:48:05 INFO - Running setup.py install for mozlog 08:48:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:48:05 INFO - Running setup.py install for moznetwork 08:48:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:48:05 INFO - Running setup.py install for mozprocess 08:48:05 INFO - Running setup.py install for mozprofile 08:48:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:48:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:48:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:48:05 INFO - Running setup.py install for mozrunner 08:48:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:48:05 INFO - Running setup.py install for mozscreenshot 08:48:05 INFO - Running setup.py install for moztest 08:48:05 INFO - Running setup.py install for mozversion 08:48:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:48:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:48:06 INFO - Cleaning up... 08:48:06 INFO - Return code: 0 08:48:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:06 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')]} 08:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:06 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')]} 08:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:06 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 0xc9b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf59570>, '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 0xf5a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', '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 08:48:06 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 08:48:06 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 08:48:06 INFO - Using env: {'DISPLAY': ':0', 08:48:06 INFO - 'HOME': '/home/cltbld', 08:48:06 INFO - 'LANG': 'en_US.UTF-8', 08:48:06 INFO - 'LANGUAGE': 'en_US:en', 08:48:06 INFO - 'LOGNAME': 'cltbld', 08:48:06 INFO - 'MAIL': '/var/mail/cltbld', 08:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:06 INFO - 'MOZ_NO_REMOTE': '1', 08:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:06 INFO - 'NO_EM_RESTART': '1', 08:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:06 INFO - 'PWD': '/builds/slave/test', 08:48:06 INFO - 'SHELL': '/bin/bash', 08:48:06 INFO - 'SHLVL': '1', 08:48:06 INFO - 'TERM': 'linux', 08:48:06 INFO - 'TMOUT': '86400', 08:48:06 INFO - 'USER': 'cltbld', 08:48:06 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', 08:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:06 INFO - '_': '/tools/buildbot/bin/python'} 08:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:06 INFO - Running setup.py (path:/tmp/pip-3uz6v4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:06 INFO - Running setup.py (path:/tmp/pip-N6qGUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:06 INFO - Running setup.py (path:/tmp/pip-jDBtEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:06 INFO - Running setup.py (path:/tmp/pip-sx4xYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:06 INFO - Running setup.py (path:/tmp/pip-OvOwsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:06 INFO - Running setup.py (path:/tmp/pip-LDfP0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:06 INFO - Running setup.py (path:/tmp/pip-tCgjwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:06 INFO - Running setup.py (path:/tmp/pip-hDdz1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:06 INFO - Running setup.py (path:/tmp/pip-5FgHnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:06 INFO - Running setup.py (path:/tmp/pip-joMpWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:06 INFO - Running setup.py (path:/tmp/pip-dGJgZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:07 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)) 08:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:07 INFO - Running setup.py (path:/tmp/pip-3K39Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:07 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)) 08:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:07 INFO - Running setup.py (path:/tmp/pip-kJkCv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:07 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)) 08:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:07 INFO - Running setup.py (path:/tmp/pip-ntLDmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:07 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)) 08:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:07 INFO - Running setup.py (path:/tmp/pip-HkU4nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:07 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)) 08:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:07 INFO - Running setup.py (path:/tmp/pip-V5W7qf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:07 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)) 08:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:07 INFO - Running setup.py (path:/tmp/pip-lVePod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:07 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)) 08:48:07 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)) 08:48:07 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)) 08:48:07 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)) 08:48:07 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)) 08:48:07 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)) 08:48:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:07 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 08:48:07 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 08:48:07 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 08:48:07 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 08:48:07 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 08:48:07 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 08:48:09 INFO - Downloading blessings-1.6.tar.gz 08:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:48:09 INFO - Installing collected packages: blessings 08:48:09 INFO - Running setup.py install for blessings 08:48:09 INFO - Successfully installed blessings 08:48:09 INFO - Cleaning up... 08:48:09 INFO - Return code: 0 08:48:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:48:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:09 INFO - Reading from file tmpfile_stdout 08:48:09 INFO - Current package versions: 08:48:09 INFO - argparse == 1.2.1 08:48:09 INFO - blessings == 1.6 08:48:09 INFO - blobuploader == 1.2.4 08:48:09 INFO - docopt == 0.6.1 08:48:09 INFO - functools32 == 3.2.3-2 08:48:09 INFO - jsonschema == 2.5.1 08:48:09 INFO - manifestparser == 1.1 08:48:09 INFO - mozInstall == 1.12 08:48:09 INFO - mozcrash == 0.17 08:48:09 INFO - mozdebug == 0.1 08:48:09 INFO - mozdevice == 0.48 08:48:09 INFO - mozfile == 1.2 08:48:09 INFO - mozhttpd == 0.7 08:48:09 INFO - mozinfo == 0.9 08:48:09 INFO - mozleak == 0.1 08:48:09 INFO - mozlog == 3.2 08:48:09 INFO - moznetwork == 0.27 08:48:09 INFO - mozprocess == 0.23 08:48:09 INFO - mozprofile == 0.28 08:48:09 INFO - mozrunner == 6.12 08:48:09 INFO - mozscreenshot == 0.1 08:48:09 INFO - mozsystemmonitor == 0.3 08:48:09 INFO - moztest == 0.7 08:48:09 INFO - mozversion == 1.4 08:48:09 INFO - psutil == 3.1.1 08:48:09 INFO - requests == 1.2.3 08:48:09 INFO - wsgiref == 0.1.2 08:48:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:09 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')]} 08:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:09 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')]} 08:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:09 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 0xc9b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf59570>, '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 0xf5a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', '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 08:48:09 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 08:48:09 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 08:48:09 INFO - Using env: {'DISPLAY': ':0', 08:48:09 INFO - 'HOME': '/home/cltbld', 08:48:09 INFO - 'LANG': 'en_US.UTF-8', 08:48:09 INFO - 'LANGUAGE': 'en_US:en', 08:48:09 INFO - 'LOGNAME': 'cltbld', 08:48:09 INFO - 'MAIL': '/var/mail/cltbld', 08:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:09 INFO - 'MOZ_NO_REMOTE': '1', 08:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:09 INFO - 'NO_EM_RESTART': '1', 08:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:09 INFO - 'PWD': '/builds/slave/test', 08:48:09 INFO - 'SHELL': '/bin/bash', 08:48:09 INFO - 'SHLVL': '1', 08:48:09 INFO - 'TERM': 'linux', 08:48:09 INFO - 'TMOUT': '86400', 08:48:09 INFO - 'USER': 'cltbld', 08:48:09 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', 08:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:09 INFO - '_': '/tools/buildbot/bin/python'} 08:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:10 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)) 08:48:10 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)) 08:48:10 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)) 08:48:10 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)) 08:48:10 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)) 08:48:10 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)) 08:48:10 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)) 08:48:10 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)) 08:48:10 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)) 08:48:10 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)) 08:48:10 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)) 08:48:10 INFO - Cleaning up... 08:48:10 INFO - Return code: 0 08:48:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:48:10 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')]} 08:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:10 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')]} 08:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:10 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 0xc9b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeca400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf59570>, '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 0xf5a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', '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 08:48:10 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 08:48:10 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 08:48:10 INFO - Using env: {'DISPLAY': ':0', 08:48:10 INFO - 'HOME': '/home/cltbld', 08:48:10 INFO - 'LANG': 'en_US.UTF-8', 08:48:10 INFO - 'LANGUAGE': 'en_US:en', 08:48:10 INFO - 'LOGNAME': 'cltbld', 08:48:10 INFO - 'MAIL': '/var/mail/cltbld', 08:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:10 INFO - 'MOZ_NO_REMOTE': '1', 08:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:10 INFO - 'NO_EM_RESTART': '1', 08:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:10 INFO - 'PWD': '/builds/slave/test', 08:48:10 INFO - 'SHELL': '/bin/bash', 08:48:10 INFO - 'SHLVL': '1', 08:48:10 INFO - 'TERM': 'linux', 08:48:10 INFO - 'TMOUT': '86400', 08:48:10 INFO - 'USER': 'cltbld', 08:48:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', 08:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:10 INFO - '_': '/tools/buildbot/bin/python'} 08:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:48:10 INFO - Cleaning up... 08:48:10 INFO - Return code: 0 08:48:10 INFO - Running post-action listener: _resource_record_post_action 08:48:10 INFO - Running post-action listener: _start_resource_monitoring 08:48:10 INFO - Starting resource monitoring. 08:48:10 INFO - ##### 08:48:10 INFO - ##### Finished create-virtualenv step (success) 08:48:10 INFO - ##### 08:48:10 INFO - ##### 08:48:10 INFO - ##### Running install step. 08:48:10 INFO - ##### 08:48:10 INFO - Running pre-action listener: _resource_record_pre_action 08:48:10 INFO - Running main action method: install 08:48:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:10 INFO - Reading from file tmpfile_stdout 08:48:10 INFO - Detecting whether we're running mozinstall >=1.0... 08:48:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:48:10 INFO - Reading from file tmpfile_stdout 08:48:10 INFO - Output received: 08:48:10 INFO - Usage: mozinstall [options] installer 08:48:10 INFO - Options: 08:48:10 INFO - -h, --help show this help message and exit 08:48:10 INFO - -d DEST, --destination=DEST 08:48:10 INFO - Directory to install application into. [default: 08:48:10 INFO - "/builds/slave/test"] 08:48:10 INFO - --app=APP Application being installed. [default: firefox] 08:48:10 INFO - mkdir: /builds/slave/test/build/application 08:48:10 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'] 08:48:10 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 08:48:26 INFO - Reading from file tmpfile_stdout 08:48:26 INFO - Output received: 08:48:26 INFO - /builds/slave/test/build/application/firefox/firefox 08:48:26 INFO - Running post-action listener: _resource_record_post_action 08:48:26 INFO - ##### 08:48:26 INFO - ##### Finished install step (success) 08:48:26 INFO - ##### 08:48:26 INFO - ##### 08:48:26 INFO - ##### Running run-tests step. 08:48:26 INFO - ##### 08:48:26 INFO - Running pre-action listener: _resource_record_pre_action 08:48:26 INFO - Running main action method: run_tests 08:48:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:48:26 INFO - Python 2.7.3 08:48:26 INFO - Return code: 0 08:48:26 INFO - grabbing minidump binary from tooltool 08:48: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')]} 08:48:26 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 0xf59570>, '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 0xf5a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:48:26 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 08:48:26 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 08:48:26 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 08:48:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:48:26 INFO - Return code: 0 08:48:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:48:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:48:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:48:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:48:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:48:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 08:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 08:48:26 INFO - Using env: {'DISPLAY': ':0', 08:48:26 INFO - 'HOME': '/home/cltbld', 08:48:26 INFO - 'LANG': 'en_US.UTF-8', 08:48:26 INFO - 'LANGUAGE': 'en_US:en', 08:48:26 INFO - 'LOGNAME': 'cltbld', 08:48:26 INFO - 'MAIL': '/var/mail/cltbld', 08:48:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:48:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:26 INFO - 'MOZ_NO_REMOTE': '1', 08:48:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:26 INFO - 'NO_EM_RESTART': '1', 08:48:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:26 INFO - 'PWD': '/builds/slave/test', 08:48:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:48:26 INFO - 'SHELL': '/bin/bash', 08:48:26 INFO - 'SHLVL': '1', 08:48:26 INFO - 'TERM': 'linux', 08:48:26 INFO - 'TMOUT': '86400', 08:48:26 INFO - 'USER': 'cltbld', 08:48:26 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815', 08:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:26 INFO - '_': '/tools/buildbot/bin/python'} 08:48:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 08:48:27 INFO - mozversion application_buildid: 20160712072926 08:48:27 INFO - mozversion application_changeset: 965a291ce94981239d55bb1cf45e1279faa788a9 08:48:27 INFO - mozversion application_display_name: Nightly 08:48:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:48:27 INFO - mozversion application_name: Firefox 08:48:27 INFO - mozversion application_remotingname: firefox 08:48:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:48:27 INFO - mozversion application_vendor: Mozilla 08:48:27 INFO - mozversion application_version: 50.0a1 08:48:27 INFO - mozversion platform_buildid: 20160712072926 08:48:27 INFO - mozversion platform_changeset: 965a291ce94981239d55bb1cf45e1279faa788a9 08:48:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:48:27 INFO - mozversion platform_version: 50.0a1 08:48:27 INFO - using testdate: 1468338507 08:48:27 INFO - actual date: 1468338507 08:48:27 INFO - starting webserver on 'localhost:57577' 08:48:27 INFO - SUITE-START | Running 2 tests 08:48:27 INFO - TEST-START | dromaeo_css 08:48:27 INFO - operating with platform_type : linux_ 08:48:27 INFO - Initialising browser for dromaeo_css test... 08:48:27 INFO - TEST-INFO | started process 11410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOvj4sy/profile http://localhost:57577/getInfo.html) 08:48:32 INFO - PROCESS | 11410 | __metrics Screen width/height:1600/1200 08:48:32 INFO - PROCESS | 11410 | colorDepth:24 08:48:32 INFO - PROCESS | 11410 | Browser inner width/height: 1024/697 08:48:32 INFO - PROCESS | 11410 | __metrics 08:48:32 ERROR - PROCESS | 11410 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 08:48:33 INFO - TEST-INFO | 11410: exit 0 08:48:33 INFO - Browser initialized. 08:48:33 INFO - Running cycle 1/1 for dromaeo_css test... 08:48:33 INFO - TEST-INFO | started process 11532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOvj4sy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:48:45 INFO - PROCESS | 11532 | RSS: Main: 168259584 08:48:45 INFO - PROCESS | 11532 | 08:49:35 INFO - PROCESS | 11532 | 1468338575383 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] 08:51:48 INFO - PROCESS | 11532 | Cycle 1(1): loaded http://localhost:57577/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57577/tests/dromaeo/cssquery-ext.html) 08:51:49 INFO - PROCESS | 11532 | RSS: Main: 168951808 08:51:49 INFO - PROCESS | 11532 | 08:54:52 INFO - PROCESS | 11532 | Cycle 1(1): loaded http://localhost:57577/tests/dromaeo/cssquery-ext.html (next: http://localhost:57577/tests/dromaeo/cssquery-jquery.html) 08:54:52 INFO - PROCESS | 11532 | RSS: Main: 168169472 08:54:52 INFO - PROCESS | 11532 | 08:57:54 INFO - PROCESS | 11532 | Cycle 1(1): loaded http://localhost:57577/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57577/tests/dromaeo/cssquery-mootools.html) 08:57:55 INFO - PROCESS | 11532 | RSS: Main: 171622400 08:57:55 INFO - PROCESS | 11532 | 09:00:57 INFO - PROCESS | 11532 | Cycle 1(1): loaded http://localhost:57577/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57577/tests/dromaeo/cssquery-prototype.html) 09:00:57 INFO - PROCESS | 11532 | RSS: Main: 167636992 09:00:57 INFO - PROCESS | 11532 | 09:04:00 INFO - PROCESS | 11532 | Cycle 1(1): loaded http://localhost:57577/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57577/tests/dromaeo/cssquery-yui.html) 09:04:01 INFO - PROCESS | 11532 | RSS: Main: 169259008 09:04:01 INFO - PROCESS | 11532 | 09:07:04 INFO - PROCESS | 11532 | Cycle 1(1): loaded http://localhost:57577/tests/dromaeo/cssquery-yui.html (next: http://localhost:57577/tests/dromaeo/cssquery-dojo.html) 09:07:04 INFO - PROCESS | 11532 | RSS: Main: 170389504 09:07:04 INFO - PROCESS | 11532 | 09:07:04 INFO - PROCESS | 11532 | __start_tp_report 09:07:04 INFO - PROCESS | 11532 | _x_x_mozilla_page_load 09:07:04 INFO - PROCESS | 11532 | _x_x_mozilla_page_load_details 09:07:04 INFO - PROCESS | 11532 | |i|pagename|runs| 09:07:04 INFO - PROCESS | 11532 | |0;dojo.html;2623.3310505821014;2636.090548760677;2667.70655227925;2670.132207032714;2676.959845602315;4711.081339138869;4762.238041913294;4771.785269662865;4823.734694591796;4837.782299796509;4627.467841198263;4674.883127921804;4710.764461776915;4743.8814029649275;4748.121597504464;4340.197063543239;4415.558444155575;4491.618212451929;4499.865004049868;4562.84030058948;4464.508904020571;4480.843170489034;4482.170798402306;4543.182227199103;4545.977270113644;4458.910821783578;4516.41286632739;4567.543245675439;4580.862574122782;4599.563041511051;4284.507281662618;4327.37253098299;4423.51341352451;4439.911201775946;4447.977760111195;4342.240107981091;4359.978200108979;4363.607275345203;4365.279728844736;4386.210482113218;4805.231163013936;4822.541858523435;4824.445188803263;4838.032393521275;4891.070696567641;5119.769610367505;5179.507946745053;5186.429492755794;5187.040397526432;5211.739413029333;5218.843434696965;5221.477852214786;5236.581073514148;5250.632455728062;5256.816011439581;4882;4883.169861123618;4884.023195360942;4884.584810291094;4926.989967056745;5248.081585722483;5333.973330133324;5338.359396872323;5364.088105022156;5369.973150134224;4990.600751939836;4991.47589503097;5005.6996580205305;5015.749212539431;5064.366954130734;4886.560209581155;5115.616328775357;5118.513741194581;5118.718470484159;5123.180291153398;5122.718250496258;5143.8456846294675;5160.561352285098;5162.664426812245;5208.8958220835375;4884.511548845087;5076.162433198555;5142.434332223453;5168.328117344721;5168.53483186515;4228.175505776406;4423.756693381895;4426.800793964279;4437.733735975852;4478;3789.450529673182;3806.257779732981;3810.123671555558;3827.7129215308964;3854.0557563397147;4356.6514678825615;4391.978040109779;4399.318105693623;4399.714018588781;4434.312681534368;4890.657653964188;5035.169197082514;5157.767900444489;5161.200013997836;5241.42344342122;4293.785310734514;4314.697971142053;4318.956810431919;4355.346697995326;4371.628411584988;4557.225271703818;4560.1335746208115;4561.019380833137;4567.5432456754725;4603.516630753789;4764.856434455775;4778.546038126511;4796.856094317176;4875.1712208923855;4875.634327425528;5157.174852023658;5178.844634660966;5213.843584692465;5218.16509358516;5229.895402092013;4885.755712214304;4894.241392584155;4899.020195960751;4900.583450406612;4902.2156454967035;4967.751612419437;4994.600431965361;5033.119204139334;5050.191969284897;5059.519345662304;5074.5940324774665;5107.923381149211;5123.077845987758;5129.281900533853;5167.276581278549;4830.082284365959;4833.286288026187;4834.830780922651;4861.975690121527;4900.534449227318;4665.066986602761;4916.8770780730765;4920.704757714549;4926.162552366178;4948.307236986752;4708.552687494683;4726.621870250303;4777.784999674954;4798.184308667465;4802.087603355351;4705.76471176433;4846.636502262274;4850.393700787402;4972.602191824718;5008.499150084962;4743.83396581118;4752.952470475251;4761.142994261067;4799.208130658402;4816.34979277793 09:07:04 INFO - PROCESS | 11532 | |1;ext.html;554.947280008399;563.0793652378361;565.6464709556526;584.3163498706513;586.1559354529477;35138.648613513855;39362.01594960124;39464.210715785666;39553;39666.80166599167;40037;40656.59343406565;40677.59322406775;40724;40754.7962260189;7887.6056197190055;8035.236652518001;8044.919550804505;8052.033755949295;8072.919270807305;7850.882236766453;7910.52536847791;7948.801279967989;7961.442699011071;7989;7963.800904977364;7964.482308649948;7984.720534781284;8005.279524842763;8013.078495972979;7935.206479352077;7991.081025682063;7997.080335761404;8015.799605009863;8016.63925123365;7825.882611760771;7865.882011769828;7890.842183156362;7901.486403383819;7905.130435652074;37649.435258471145;38241.80879095587;38264.04339891497;38321.23357532862;38328.233435331415;3045.604071470717;3262.4943133814295;3346.8159251241173;3439.4324936385715;3523.242502861897;28985.420291594262;29541.113766586823;29875.70124298751;29920.95276665328;30633.78345273759;3231.1760501072313;3262.657420970788;3271.9182020449443;3381.898543043713;3386.204242003127;272893.63553182303;273349;273635;274470.3935362273;274528;51074;51722.224166637534;51786.74106629518;51806.74096629493;51875.22187167196;32623.51064734031;33388.666113339044;33394.332113357596;35283.4707479388;35367.64632353695;13349.866501335056;13369.398377072861;13399.330033498287;13421.194728316332;13436.395362208725;10947.686277646733;11043.39261340634;11120.277181983145;11122.110231181648;11135.33188008722;18304.816951830577;18397.632047358977;18429.90785046093;18506.722399164024;18576.65620188379;6685.39831415175;6750.493712971547;6927.757528486479;6972.965135174291;7040.788776336718;787.1105650614769;885.1237275097607;895.7939673875045;921.6728061538191;951.1154626197564;28219.858900705363;28849.85575072111;28853.422931541252;29341.266468338035;29500;931.8695382646434;970.1705042188968;1038.6209033702644;1071.5338827610015;1109.1182509904645;15044.473443429428;15122;15230.695386092217;15440.536783896276;15480.5355839325;428669;431389;432137;433948;435235;48626.75686621615;48920.51079489231;49018;49087.26369104466;49208.507914920396;1186.6143503361443;1210.709429736857;1212.2847519963263;1220.5850010996303;1254.3038613569374;27557.58663620007;28333.716662833107;28541.28646783764;28646;29052.56421153642;40695.1860962785;41080.58919410768;41337.58662413337;41369.79315103405;41393.1721365577;313955;316189;316891;317171;317600;22135.225267115573;22811.771882281628;22870.54258914779;22947.196848110238;25239.62140567856;40710;41015.589844101174;41381.79309103435;42117.1576568473;42800.35799463073;37383.81308093442;37556;37983.240335193696;38294.617053829104;38620.227595448494;37168.628313716516;37805;37844;38080.80959595184;38152.618473816015;31336.843315783277;36424.453633196055;36869.26261474809;37040.70357537473;37273.440898386005;31660;33969.32061358808;34266.657333426345;34335.484967726006;34604.307913841076;25405.61891571591;25437.87281063583;25583.616245755955;25712.87143564345;26160.476790464465 09:07:04 INFO - PROCESS | 11532 | |2;jquery.html;362.85848519077564;366.1468777747848;366.24005189232344;375.54558983629806;381.68510978442777;16280.83719162808;17306.39427620035;17318.393856215036;17677.381291654794;17845.107744612782;15858.603534911634;17361.392351267707;17987.4603761887;18023.459296221135;18039.278428862828;5220.269162317279;5356.437574054727;5401.4868587484125;5408.621396502246;5410.83767486976;3713.3316003119426;5217.686938783685;5930.970345148268;6258.5306102042305;6262.592931459463;6222.81331560054;6295.968520157416;6304.401081897213;6310.779122730705;6319.905201421982;6139.969300153493;6300.369963003709;6301.495880329586;6308.905366419507;6313.873722525546;5475.972620136914;5514.834554963358;5516.641418307797;5517.089680202762;5532.419095994903;20864.47838804027;21169.576608467898;21320.78679213219;21641.675374869388;21828;1932.4975506368446;1994.6509360861792;2084.739407574053;2296.5751336002895;2510.0336370497307;12282.815757763641;13374;13514.797278040838;13588.59234222975;13906.30468476572;1724.9564013771737;1741.6255505066345;1761.9207135678926;1820.4538638408558;1856.9535761605932;74347;75016.24983750147;75807.62096189483;75825.62087189584;76285.61857190734;10109.848352274721;10201.438920859424;10244.48777561119;10277.588896444207;10298.197815382428;13838.515651952133;13897.513587024405;13908.860911390959;13921.164730116225;13942.930285348712;7324.376424999701;7422.369098626569;7429.145648250413;7513.323800857949;7542.358899493494;6872.41584465316;6907.792766217021;7106.786796396116;7113.857722845514;7134.143902731602;4364.847230346986;4367.519572846984;4444.355568442557;4548.5906268436;4553.544645535486;1710.7091794394983;1754.7017007108823;1792.97310540342;1816.4641430777951;1849.8427633651022;799.384473955063;840.277361469136;899.1772528136681;901.2609660078673;978.3102912446708;16430.1784910754;16721.83278167227;16785.58036049084;16863.831361686225;17325.2203650836;847.2459511035183;857.7555396711907;860.3633311349556;921.4287141971886;929.3773171974793;9494.240460763122;9502.47736374506;9547.665831695856;9559.426434413957;9690.418574885389;361668;368657;370898;373313;382685;51322;52039.21941170885;54115.72942135264;72214.63892680503;79423;901.0493928905069;927.4481683398367;929.8837645294338;953.6233187890745;956.5886668732372;15983.120928349052;16118.597035074217;16198.433054843495;16522.09128497944;16826.074565898994;38584.80707596444;39741.20517589574;40848.59151408448;41048;41472.79263603783;55526.72236638953;55886.441135588124;56973.71513142408;57167;58121.4187858116;7278.781636550912;7884.1327453978865;7901.68393264286;8001.079875814356;8116.0260768705775;9887.653932112342;11243.887561124611;11872.16894817389;12345.382730863601;12483.812742808683;10937.617183398543;10950.507227174638;11074.5570177192;11128.499217535393;11159.888401115884;10129.240306977154;10219.642312519027;10771.515281812493;10837.566497340333;11101.333919964827;10713.785724285626;10914.18143639246;10996.28524145928;11131.944340278247;11132;8102.311303539265;8127.431079824356;8140;8170.305524030524;8174;10570.524326405177;10877.184211184034;10946.781064378827;11168.553257869919;11220.60727874553 09:07:04 INFO - PROCESS | 11532 | |3;mootools.html;1363.835900710352;1395.0792476965203;1484.6140003599062;1679.9832001679995;1702.812690604034;6257.155284036654;6993.965030174848;7052.3652871241575;7564.546127232363;7596.202398748128;7037.085178926745;7279.818004549889;7338.853222935538;7342.15565210001;7350.705971761136;2124.2671278409002;2139.5934772393275;2140.2937030779804;2143.07847625521;2159.4277516458073;2132.2430537159316;2143.110609097223;2199.14233448955;2201.8458707890454;2204.581129585382;2141.1328411993168;2146.2702681088426;2154.202944910385;2155.8706477611313;2157.072458842697;2102.3272552783114;2107.1571371451464;2113.0243222586932;2113.86259893108;2116.322776711453;2032.6950957356366;2057.7839326870762;2079.677649964258;2086.8539202255847;2096.2663067926255;7445.181030086686;7454.440916931252;7467.215942326032;7498.625068746595;7519.699212031567;4283.507396649363;4492.707973981681;4502.212112880233;4503.504614492404;4518.819247230107;2776.0422654184276;2778.166550035002;2851.81463204891;2887.956680649792;2894.82631042136;874.54960695242;918.8437965545806;918.9770255743593;931.59475628102;943.9433633981984;10058.396496210178;10082.395056296646;10083.394996300172;10086.596536138546;10188.949055254676;3996.460477835455;4084.081081756581;4128.1330920506425;4238.21593005295;4246.554111818215;8509.064002959669;8531.616077276538;8534.487930724177;8535.871961920577;8595.312375009984;4561.087782443525;4571.451425828922;4572.95427045732;4596.35651008859;4607.95392046082;3583.7849729016343;4017.7589344639414;4194.203101410783;4206.579342065769;4219.198352313051;3507.982460087734;3543.5216245807;3554.928901421957;3566.6968307694137;3646.854125834937;1119.7536541960756;1155.8959693627614;1157.8552680914886;1165.0504838556549;1171.6953592065954;832.3715594726065;832.9708460203864;842.2882664148784;866.1425189062783;872.5462759365222;4933.555979961749;4994.123102406812;5026.271190677331;5078.13671675816;5151.175811870157;403.243917654398;414.57713132604573;420.2372693561177;430.99784501077295;434.88910327866824;3282.6553211912883;3312.3706495765728;3332.9333413332083;3366.7306615471193;3383.8984830455124;8599.5700214989;8690.608922598498;8917.242034427147;8919.777005574782;9150.771230719152;9063.637454501877;9190.448573085636;9199.310051746146;9226.49254291007;9255.352125351295;6746;6835.111435513351;7096.893546596805;7101.183363913216;7108.218096009435;4923.359963204761;4982.302477653204;4998;5014;5133.589312855037;8458.492490450593;8615.526146062026;8615.741527754177;8670.176333248332;8691.348148888732;8518.275946544612;8723.956380218058;8745.081766414689;8772.736817895473;8778.604962776562;5725.5992080555625;6300.0234963580715;6390.5526613136635;6501.34986501365;6520.478361731145;7124.857502850017;7176.354128128493;7182.784516464514;7221.927780722125;7232.5660460370445;6374.113254511512;6507.577007494498;6520.967395162994;6699.028640846953;6782.660866956534;6305.747770089145;6462.4183823456115;6521.217453905561;6621;6642.202935647753;5739.167820666064;5834.854128646818;5872.265966754156;5891.116332550152;5907.143464197753;4174.519930208065;4321.762303073361;4357.215701173819;4369.60673539383;4374.518802931739;4320.114376552736;4527.479339875957;4541.523140070245;4588.678792484628;4590.931136033029 09:07:04 INFO - PROCESS | 11532 | |4;prototype.html;299.7197620225091;299.74970899299086;302.7895612549279;304.6298747022368;308.9011516314779;5110.233464980255;5127.820526281581;5131.435542090372;5133.6919784812935;5140.8971820563565;5038.823641172559;5041.798328066882;5045.268436076776;5048;5058.620603454738;3760.4735337052834;3866.729328946961;3970.642642162205;4008.198360327946;4011.7793521356316;3951.3875349320756;3962.6433620974108;3966.5438474575362;3979.9801000994953;4016.2369149861433;3966.900827479322;3979.1946677592227;3995.1610161865897;4012.779297138656;4037.8788636340955;3636.799976001319;3861.1891502784447;3865.5554611219786;4015.07653239755;4015.6185162409524;3339.833008349573;3342.7827191232736;3351.447011243142;3353.295807880348;3359.228636374976;4942.998085775267;4945.950540494585;4947.802087916479;4952.925706114411;5019.272205530177;4312.180685669744;4417.160739459492;4434.290513517822;4441.289393697025;4458.598726114666;5197.428282888879;5230.241614965847;5241.371035475768;5258.605604579634;5308.336457942757;3696.4270538066644;3710.499082623838;3727.422249551324;3733.1227161617;3736.794476303802;5347.732613369316;5480.739429931098;5490.3411590608985;5490.917636235459;5496.877341993505;3674.614165512636;3809.809509524568;3810.599887011879;3812.3606849054618;3837.196517636706;3806.7715937043868;3842.269968705993;3843.942340864889;3853.7687738735767;3858.7298889077497;4430.825831154747;4441.267190913528;4457.24226881431;4475.7985890635;4476.37330773692;5114.590832733373;5281.339832520935;5290.836016076457;5342.145256758978;5362.2224777407055;1302.3943866102309;1305.8694130587055;1310.5675127207999;1314.8553659097493;1315.3094625321783;845.6997765793055;855.3371137368589;857.5197889181953;867.700643278068;882.4661080046608;4538.367746706902;4543.636509079266;4545.113702827983;4565.08266528059;4573.314002899591;5422.972885135628;5437.972810135924;5448.482394172547;5458.235846981426;5462.972685136629;4363.694541382136;4535.501094879561;4537.319402089713;4537.705049171794;4562.1788078146255;2928.194746444702;2935.1341354300534;2943.617329747119;2946.6905974872757;2954.8670309836107;5080;5127.512886275797;5136.743162841843;5137.843985103322;5141.305923700253;5450.700211488327;5583.664980101207;5622.8313150605545;5626.915596266059;5731.140328950607;5116.641835071584;5116.692998420107;5133.230015497706;5141.460146684619;5169.353830771153;5513.476219759116;5513.58648101402;5530.170474428868;5531.502164805187;5566.582506311962;5230.311442179989;5316.362036555638;5393.298871146726;5412.675239485643;5440.319960004999;5155.479133655505;5181.37823461172;5190.378858676344;5200.375954885438;5205.037068142406;3862.0689655172414;3893.9221215576094;3894.6105389460827;3897.902552436212;3902.2780785554764;5241.371035475615;5555.666660000413;5556.638818476786;5558.916616250679;5585.916211256753;5188.429272779916;5216.9826883757305;5234.738263086754;5242.711650859239;5277.973610132079;5113.769880355468;5243.501867322599;5276.657017293864;5292.179712144623;5310.256564081109;5062.265971434048;5069.465267366317;5079.415867175322;5079.5428411443145;5105.642605017613;4919.409670839522;5137.434882163034;5224.7126408047925;5237.921431178612;5247.317848679647;5089.694618322913;5096.088966637511;5104.132297509506;5110.9233361500355;5113.64204505681 09:07:04 INFO - PROCESS | 11532 | |5;yui.html;665.2216906219724;678.8540463800285;709.9822504437385;735.1582438108366;752.4469514906543;11649.126315526337;12056.276623402591;12104.69738256543;13494.460221591125;14466.638334041654;14919;15129.848701512981;15149.772753408708;15158.469453569127;15229.69540609187;753.2204168685412;772.2740623813597;773.5745340062942;774.3727580659684;775.5269285735696;619.9411055949678;753.5328096580128;771.7376092128675;772.4669977715358;773.8220209351853;815.1237419773737;817.342039658075;817.9836403271931;818.5866137600533;821.2936874288107;802.1937952357902;808.1595141053298;810.2019510781846;811.0470197517893;812.25272749071;591.3879135095199;591.8076625096818;591.9082542205965;592.9614575052608;594.0999385930319;13721.862781372258;13797.793033104512;13802.792958105636;13825.10136841102;13842.377093030838;13105.737885242243;13133.540326088636;13246.536371226961;13325.86674133256;13344.2660653664;10530.736731581695;10655.200859935536;10672.839907401396;10675.252732308742;10849.566017359375;3230.5800245967876;3266.5753452051317;3284.1953721338186;3294.3081952789944;3303.8678452861855;62405;62492;62641.37358626401;62654.37345626531;63851.36148638501;10109.797804043877;10320.690379288633;10378.844317335246;10508.947455262827;10634.627788027537;17369.7394539082;18006.189721462564;18109.7283540747;18818.623627527373;19021.90489047546;7047.083879095787;7188.78433646981;7252.673629686677;7387.519811212254;7397.81505462357;3838.443425703257;3888.358420860526;3908.570057293752;3918.5101862267215;3941.5467221269346;2788.8187267827525;2885.7114288570974;2889.5376739721964;2889.7110288971353;2904.4771941050813;522.0628970997069;543.1282791120274;549.9752511137009;550.5045459086854;556.0713608274192;562.9268195134606;631.5105793010454;636.1729751323261;637.3594537489793;651.8174911024921;8464.873026904601;8982.281417486585;8986.370954033155;9142.725718228463;9198.770030749285;529.4123522889589;567.8069456384849;637.8214100051993;644.2880616918331;645.7901182115831;4102.610252026112;4432.3794668746405;4452.30989196675;4458.687891847604;4630.3748993886065;104303;104751;106032.46983765032;109037;109586;95111;97420;98815;99223.50388248157;99273;80151.59924200458;83407;83527;84667.15332846716;85684.99999999875;8319.958400207961;8321.54231517248;8514.191151840812;8517.829643407222;8519;49698.503014969385;50372;50518;51107.23339149841;51180;38667.2266554673;39521.80239098786;39632.2073558533;57499.71250143723;58506.414935850094;11553.364564949008;11753.529858805552;11995.940020299842;12028;12222.572209972608;12514.74970500603;12640.178388404724;12853.807192891927;12934.417951192407;13283.601491955256;11532.654020379403;11711.063114950954;11849.585264515701;11937.59959238942;12748.872511274769;12533.811992819932;12659.177153484994;12811;12846.229226246454;13088.934555327163;11229.101671866069;11604.709882253012;12340.259584424604;12596.30720310355;13218.47126114983;9866.309358344846;9906.950465247915;10015.84438620462;10058.446785426871;10102.184269484462;9491.572879220314;9787.804243915225;9832.24302092101;10497.79004419892;10521.105706015074 09:07:04 INFO - PROCESS | 11532 | __end_tp_report 09:07:04 INFO - PROCESS | 11532 | __start_cc_report 09:07:04 INFO - PROCESS | 11532 | _x_x_mozilla_cycle_collect,380 09:07:04 INFO - PROCESS | 11532 | __end_cc_report 09:07:04 INFO - PROCESS | 11532 | __startTimestamp1468339624324__endTimestamp 09:07:04 INFO - PROCESS | 11532 | 09:07:04 INFO - PROCESS | 11532 | ------- Summary: start ------- 09:07:04 INFO - PROCESS | 11532 | Number of tests: 6 09:07:04 INFO - PROCESS | 11532 | 09:07:04 INFO - PROCESS | 11532 | [#0] dojo.html Cycles:165 Average:4727.59 Median:4830.08 stddev:497.37 (10.3%) stddev-sans-first:470.71 09:07:04 INFO - PROCESS | 11532 | Values: 2623.3 2636.1 2667.7 2670.1 2677.0 4711.1 4762.2 4771.8 4823.7 4837.8 4627.5 4674.9 4710.8 4743.9 4748.1 4340.2 4415.6 4491.6 4499.9 4562.8 4464.5 4480.8 4482.2 4543.2 4546.0 4458.9 4516.4 4567.5 4580.9 4599.6 4284.5 4327.4 4423.5 4439.9 4448.0 4342.2 4360.0 4363.6 4365.3 4386.2 4805.2 4822.5 4824.4 4838.0 4891.1 5119.8 5179.5 5186.4 5187.0 5211.7 5218.8 5221.5 5236.6 5250.6 5256.8 4882.0 4883.2 4884.0 4884.6 4927.0 5248.1 5334.0 5338.4 5364.1 5370.0 4990.6 4991.5 5005.7 5015.7 5064.4 4886.6 5115.6 5118.5 5118.7 5123.2 5122.7 5143.8 5160.6 5162.7 5208.9 4884.5 5076.2 5142.4 5168.3 5168.5 4228.2 4423.8 4426.8 4437.7 4478.0 3789.5 3806.3 3810.1 3827.7 3854.1 4356.7 4392.0 4399.3 4399.7 4434.3 4890.7 5035.2 5157.8 5161.2 5241.4 4293.8 4314.7 4319.0 4355.3 4371.6 4557.2 4560.1 4561.0 4567.5 4603.5 4764.9 4778.5 4796.9 4875.2 4875.6 5157.2 5178.8 5213.8 5218.2 5229.9 4885.8 4894.2 4899.0 4900.6 4902.2 4967.8 4994.6 5033.1 5050.2 5059.5 5074.6 5107.9 5123.1 5129.3 5167.3 4830.1 4833.3 4834.8 4862.0 4900.5 4665.1 4916.9 4920.7 4926.2 4948.3 4708.6 4726.6 4777.8 4798.2 4802.1 4705.8 4846.6 4850.4 4972.6 5008.5 4743.8 4753.0 4761.1 4799.2 4816.3 09:07:04 INFO - PROCESS | 11532 | 09:07:04 INFO - PROCESS | 11532 | [#1] ext.html Cycles:180 Average:48715.27 Median:37469.91 stddev:91696.95 (244.7%) stddev-sans-first:91882.89 09:07:04 INFO - PROCESS | 11532 | Values: 554.9 563.1 565.6 584.3 586.2 35138.6 39362.0 39464.2 39553.0 39666.8 40037.0 40656.6 40677.6 40724.0 40754.8 7887.6 8035.2 8044.9 8052.0 8072.9 7850.9 7910.5 7948.8 7961.4 7989.0 7963.8 7964.5 7984.7 8005.3 8013.1 7935.2 7991.1 7997.1 8015.8 8016.6 7825.9 7865.9 7890.8 7901.5 7905.1 37649.4 38241.8 38264.0 38321.2 38328.2 3045.6 3262.5 3346.8 3439.4 3523.2 28985.4 29541.1 29875.7 29921.0 30633.8 3231.2 3262.7 3271.9 3381.9 3386.2 272893.6 273349.0 273635.0 274470.4 274528.0 51074.0 51722.2 51786.7 51806.7 51875.2 32623.5 33388.7 33394.3 35283.5 35367.6 13349.9 13369.4 13399.3 13421.2 13436.4 10947.7 11043.4 11120.3 11122.1 11135.3 18304.8 18397.6 18429.9 18506.7 18576.7 6685.4 6750.5 6927.8 6973.0 7040.8 787.1 885.1 895.8 921.7 951.1 28219.9 28849.9 28853.4 29341.3 29500.0 931.9 970.2 1038.6 1071.5 1109.1 15044.5 15122.0 15230.7 15440.5 15480.5 428669.0 431389.0 432137.0 433948.0 435235.0 48626.8 48920.5 49018.0 49087.3 49208.5 1186.6 1210.7 1212.3 1220.6 1254.3 27557.6 28333.7 28541.3 28646.0 29052.6 40695.2 41080.6 41337.6 41369.8 41393.2 313955.0 316189.0 316891.0 317171.0 317600.0 22135.2 22811.8 22870.5 22947.2 25239.6 40710.0 41015.6 41381.8 42117.2 42800.4 37383.8 37556.0 37983.2 38294.6 38620.2 37168.6 37805.0 37844.0 38080.8 38152.6 31336.8 36424.5 36869.3 37040.7 37273.4 31660.0 33969.3 34266.7 34335.5 34604.3 25405.6 25437.9 25583.6 25712.9 26160.5 09:07:04 INFO - PROCESS | 11532 | 09:07:04 INFO - PROCESS | 11532 | [#2] jquery.html Cycles:180 Average:24162.80 Median:39163.01 stddev:61345.18 (156.6%) stddev-sans-first:61491.24 09:07:04 INFO - PROCESS | 11532 | Values: 362.9 366.1 366.2 375.5 381.7 16280.8 17306.4 17318.4 17677.4 17845.1 15858.6 17361.4 17987.5 18023.5 18039.3 5220.3 5356.4 5401.5 5408.6 5410.8 3713.3 5217.7 5931.0 6258.5 6262.6 6222.8 6296.0 6304.4 6310.8 6319.9 6140.0 6300.4 6301.5 6308.9 6313.9 5476.0 5514.8 5516.6 5517.1 5532.4 20864.5 21169.6 21320.8 21641.7 21828.0 1932.5 1994.7 2084.7 2296.6 2510.0 12282.8 13374.0 13514.8 13588.6 13906.3 1725.0 1741.6 1761.9 1820.5 1857.0 74347.0 75016.2 75807.6 75825.6 76285.6 10109.8 10201.4 10244.5 10277.6 10298.2 13838.5 13897.5 13908.9 13921.2 13942.9 7324.4 7422.4 7429.1 7513.3 7542.4 6872.4 6907.8 7106.8 7113.9 7134.1 4364.8 4367.5 4444.4 4548.6 4553.5 1710.7 1754.7 1793.0 1816.5 1849.8 799.4 840.3 899.2 901.3 978.3 16430.2 16721.8 16785.6 16863.8 17325.2 847.2 857.8 860.4 921.4 929.4 9494.2 9502.5 9547.7 9559.4 9690.4 361668.0 368657.0 370898.0 373313.0 382685.0 51322.0 52039.2 54115.7 72214.6 79423.0 901.0 927.4 929.9 953.6 956.6 15983.1 16118.6 16198.4 16522.1 16826.1 38584.8 39741.2 40848.6 41048.0 41472.8 55526.7 55886.4 56973.7 57167.0 58121.4 7278.8 7884.1 7901.7 8001.1 8116.0 9887.7 11243.9 11872.2 12345.4 12483.8 10937.6 10950.5 11074.6 11128.5 11159.9 10129.2 10219.6 10771.5 10837.6 11101.3 10713.8 10914.2 10996.3 11131.9 11132.0 8102.3 8127.4 8140.0 8170.3 8174.0 10570.5 10877.2 10946.8 11168.6 11220.6 09:07:04 INFO - PROCESS | 11532 | 09:07:04 INFO - PROCESS | 11532 | [#3] mootools.html Cycles:180 Average:4905.27 Median:4928.46 stddev:2719.48 (55.2%) stddev-sans-first:2714.09 09:07:04 INFO - PROCESS | 11532 | Values: 1363.8 1395.1 1484.6 1680.0 1702.8 6257.2 6994.0 7052.4 7564.5 7596.2 7037.1 7279.8 7338.9 7342.2 7350.7 2124.3 2139.6 2140.3 2143.1 2159.4 2132.2 2143.1 2199.1 2201.8 2204.6 2141.1 2146.3 2154.2 2155.9 2157.1 2102.3 2107.2 2113.0 2113.9 2116.3 2032.7 2057.8 2079.7 2086.9 2096.3 7445.2 7454.4 7467.2 7498.6 7519.7 4283.5 4492.7 4502.2 4503.5 4518.8 2776.0 2778.2 2851.8 2888.0 2894.8 874.5 918.8 919.0 931.6 943.9 10058.4 10082.4 10083.4 10086.6 10188.9 3996.5 4084.1 4128.1 4238.2 4246.6 8509.1 8531.6 8534.5 8535.9 8595.3 4561.1 4571.5 4573.0 4596.4 4608.0 3583.8 4017.8 4194.2 4206.6 4219.2 3508.0 3543.5 3554.9 3566.7 3646.9 1119.8 1155.9 1157.9 1165.1 1171.7 832.4 833.0 842.3 866.1 872.5 4933.6 4994.1 5026.3 5078.1 5151.2 403.2 414.6 420.2 431.0 434.9 3282.7 3312.4 3332.9 3366.7 3383.9 8599.6 8690.6 8917.2 8919.8 9150.8 9063.6 9190.4 9199.3 9226.5 9255.4 6746.0 6835.1 7096.9 7101.2 7108.2 4923.4 4982.3 4998.0 5014.0 5133.6 8458.5 8615.5 8615.7 8670.2 8691.3 8518.3 8724.0 8745.1 8772.7 8778.6 5725.6 6300.0 6390.6 6501.3 6520.5 7124.9 7176.4 7182.8 7221.9 7232.6 6374.1 6507.6 6521.0 6699.0 6782.7 6305.7 6462.4 6521.2 6621.0 6642.2 5739.2 5834.9 5872.3 5891.1 5907.1 4174.5 4321.8 4357.2 4369.6 4374.5 4320.1 4527.5 4541.5 4588.7 4590.9 09:07:04 INFO - PROCESS | 11532 | 09:07:04 INFO - PROCESS | 11532 | [#4] prototype.html Cycles:180 Average:4376.01 Median:5060.44 stddev:1282.73 (25.3%) stddev-sans-first:1249.31 09:07:04 INFO - PROCESS | 11532 | Values: 299.7 299.7 302.8 304.6 308.9 5110.2 5127.8 5131.4 5133.7 5140.9 5038.8 5041.8 5045.3 5048.0 5058.6 3760.5 3866.7 3970.6 4008.2 4011.8 3951.4 3962.6 3966.5 3980.0 4016.2 3966.9 3979.2 3995.2 4012.8 4037.9 3636.8 3861.2 3865.6 4015.1 4015.6 3339.8 3342.8 3351.4 3353.3 3359.2 4943.0 4946.0 4947.8 4952.9 5019.3 4312.2 4417.2 4434.3 4441.3 4458.6 5197.4 5230.2 5241.4 5258.6 5308.3 3696.4 3710.5 3727.4 3733.1 3736.8 5347.7 5480.7 5490.3 5490.9 5496.9 3674.6 3809.8 3810.6 3812.4 3837.2 3806.8 3842.3 3843.9 3853.8 3858.7 4430.8 4441.3 4457.2 4475.8 4476.4 5114.6 5281.3 5290.8 5342.1 5362.2 1302.4 1305.9 1310.6 1314.9 1315.3 845.7 855.3 857.5 867.7 882.5 4538.4 4543.6 4545.1 4565.1 4573.3 5423.0 5438.0 5448.5 5458.2 5463.0 4363.7 4535.5 4537.3 4537.7 4562.2 2928.2 2935.1 2943.6 2946.7 2954.9 5080.0 5127.5 5136.7 5137.8 5141.3 5450.7 5583.7 5622.8 5626.9 5731.1 5116.6 5116.7 5133.2 5141.5 5169.4 5513.5 5513.6 5530.2 5531.5 5566.6 5230.3 5316.4 5393.3 5412.7 5440.3 5155.5 5181.4 5190.4 5200.4 5205.0 3862.1 3893.9 3894.6 3897.9 3902.3 5241.4 5555.7 5556.6 5558.9 5585.9 5188.4 5217.0 5234.7 5242.7 5278.0 5113.8 5243.5 5276.7 5292.2 5310.3 5062.3 5069.5 5079.4 5079.5 5105.6 4919.4 5137.4 5224.7 5237.9 5247.3 5089.7 5096.1 5104.1 5110.9 5113.6 09:07:04 INFO - PROCESS | 11532 | 09:07:04 INFO - PROCESS | 11532 | [#5] yui.html Cycles:180 Average:18600.38 Median:4455.50 stddev:27376.79 (614.4%) stddev-sans-first:27420.47 09:07:04 INFO - PROCESS | 11532 | Values: 665.2 678.9 710.0 735.2 752.4 11649.1 12056.3 12104.7 13494.5 14466.6 14919.0 15129.8 15149.8 15158.5 15229.7 753.2 772.3 773.6 774.4 775.5 619.9 753.5 771.7 772.5 773.8 815.1 817.3 818.0 818.6 821.3 802.2 808.2 810.2 811.0 812.3 591.4 591.8 591.9 593.0 594.1 13721.9 13797.8 13802.8 13825.1 13842.4 13105.7 13133.5 13246.5 13325.9 13344.3 10530.7 10655.2 10672.8 10675.3 10849.6 3230.6 3266.6 3284.2 3294.3 3303.9 62405.0 62492.0 62641.4 62654.4 63851.4 10109.8 10320.7 10378.8 10508.9 10634.6 17369.7 18006.2 18109.7 18818.6 19021.9 7047.1 7188.8 7252.7 7387.5 7397.8 3838.4 3888.4 3908.6 3918.5 3941.5 2788.8 2885.7 2889.5 2889.7 2904.5 522.1 543.1 550.0 550.5 556.1 562.9 631.5 636.2 637.4 651.8 8464.9 8982.3 8986.4 9142.7 9198.8 529.4 567.8 637.8 644.3 645.8 4102.6 4432.4 4452.3 4458.7 4630.4 104303.0 104751.0 106032.5 109037.0 109586.0 95111.0 97420.0 98815.0 99223.5 99273.0 80151.6 83407.0 83527.0 84667.2 85685.0 8320.0 8321.5 8514.2 8517.8 8519.0 49698.5 50372.0 50518.0 51107.2 51180.0 38667.2 39521.8 39632.2 57499.7 58506.4 11553.4 11753.5 11995.9 12028.0 12222.6 12514.7 12640.2 12853.8 12934.4 13283.6 11532.7 11711.1 11849.6 11937.6 12748.9 12533.8 12659.2 12811.0 12846.2 13088.9 11229.1 11604.7 12340.3 12596.3 13218.5 9866.3 9907.0 10015.8 10058.4 10102.2 9491.6 9787.8 9832.2 10497.8 10521.1 09:07:04 INFO - PROCESS | 11532 | -------- Summary: end -------- 09:07:04 INFO - PROCESS | 11532 | 09:07:05 INFO - TEST-INFO | 11532: exit 0 09:07:05 INFO - TEST-OK | dromaeo_css | took 1117919ms 09:07:05 INFO - TEST-START | kraken 09:07:05 INFO - operating with platform_type : linux_ 09:07:05 INFO - Initialising browser for kraken test... 09:07:05 INFO - TEST-INFO | started process 11771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqfSDjz/profile http://localhost:57577/getInfo.html) 09:07:10 INFO - PROCESS | 11771 | __metrics Screen width/height:1600/1200 09:07:10 INFO - PROCESS | 11771 | colorDepth:24 09:07:10 INFO - PROCESS | 11771 | Browser inner width/height: 1024/697 09:07:10 INFO - PROCESS | 11771 | __metrics 09:07:10 ERROR - PROCESS | 11771 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 09:07:11 INFO - TEST-INFO | 11771: exit 0 09:07:11 INFO - Browser initialized. 09:07:11 INFO - Running cycle 1/1 for kraken test... 09:07:11 INFO - TEST-INFO | started process 11892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqfSDjz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:23 INFO - PROCESS | 11892 | RSS: Main: 168538112 09:07:23 INFO - PROCESS | 11892 | 09:07:26 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:57577/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57577/tests/kraken/driver.html?testName=audio-beat-detection) 09:07:27 INFO - PROCESS | 11892 | RSS: Main: 173883392 09:07:27 INFO - PROCESS | 11892 | 09:07:29 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:57577/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57577/tests/kraken/driver.html?testName=audio-dft) 09:07:30 INFO - PROCESS | 11892 | RSS: Main: 173240320 09:07:30 INFO - PROCESS | 11892 | 09:07:33 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:57577/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57577/tests/kraken/driver.html?testName=audio-fft) 09:07:34 INFO - PROCESS | 11892 | RSS: Main: 168284160 09:07:34 INFO - PROCESS | 11892 | 09:07:36 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:57577/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57577/tests/kraken/driver.html?testName=audio-oscillator) 09:07:36 INFO - PROCESS | 11892 | RSS: Main: 169013248 09:07:36 INFO - PROCESS | 11892 | 09:07:39 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:57577/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57577/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:07:39 INFO - PROCESS | 11892 | RSS: Main: 169127936 09:07:39 INFO - PROCESS | 11892 | 09:07:42 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:57577/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57577/tests/kraken/driver.html?testName=imaging-darkroom) 09:07:43 INFO - PROCESS | 11892 | RSS: Main: 169496576 09:07:43 INFO - PROCESS | 11892 | 09:07:47 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:57577/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57577/tests/kraken/driver.html?testName=imaging-desaturate) 09:07:47 INFO - PROCESS | 11892 | RSS: Main: 167092224 09:07:47 INFO - PROCESS | 11892 | 09:07:50 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:57577/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57577/tests/kraken/driver.html?testName=json-parse-financial) 09:07:51 INFO - PROCESS | 11892 | RSS: Main: 168550400 09:07:51 INFO - PROCESS | 11892 | 09:07:52 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:57577/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57577/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:07:53 INFO - PROCESS | 11892 | RSS: Main: 169086976 09:07:53 INFO - PROCESS | 11892 | 09:07:55 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:57577/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57577/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:07:56 INFO - PROCESS | 11892 | RSS: Main: 169414656 09:07:56 INFO - PROCESS | 11892 | 09:07:58 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:57577/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57577/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:07:59 INFO - PROCESS | 11892 | RSS: Main: 169857024 09:07:59 INFO - PROCESS | 11892 | 09:08:01 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:57577/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:08:02 INFO - PROCESS | 11892 | RSS: Main: 169689088 09:08:02 INFO - PROCESS | 11892 | 09:08:05 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:57577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:08:05 INFO - PROCESS | 11892 | RSS: Main: 169709568 09:08:05 INFO - PROCESS | 11892 | 09:08:07 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:57577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57577/tests/kraken/driver.html?testName=ai-astar) 09:08:07 INFO - PROCESS | 11892 | RSS: Main: 170684416 09:08:07 INFO - PROCESS | 11892 | 09:08:07 INFO - PROCESS | 11892 | __start_tp_report 09:08:07 INFO - PROCESS | 11892 | _x_x_mozilla_page_load 09:08:07 INFO - PROCESS | 11892 | _x_x_mozilla_page_load_details 09:08:07 INFO - PROCESS | 11892 | |i|pagename|runs| 09:08:07 INFO - PROCESS | 11892 | |0;ai-astar;106;114;109;113;116;117;120;116;115;114 09:08:07 INFO - PROCESS | 11892 | |1;audio-beat-detection;158;128;147;176;123;160;153;126;184;123 09:08:07 INFO - PROCESS | 11892 | |2;audio-dft;162;163;162;165;177;164;163;166;162;165 09:08:07 INFO - PROCESS | 11892 | |3;audio-fft;75;76;77;146;77;77;77;76;159;78 09:08:07 INFO - PROCESS | 11892 | |4;audio-oscillator;86;86;148;85;85;86;148;85;85;133 09:08:07 INFO - PROCESS | 11892 | |5;imaging-gaussian-blur;117;118;117;118;118;119;118;118;121;118 09:08:07 INFO - PROCESS | 11892 | |6;imaging-darkroom;148;147;149;149;148;148;148;147;149;147 09:08:07 INFO - PROCESS | 11892 | |7;imaging-desaturate;95;96;97;96;95;95;96;96;96;96 09:08:07 INFO - PROCESS | 11892 | |8;json-parse-financial;64;67;63;63;63;63;63;64;64;63 09:08:07 INFO - PROCESS | 11892 | |9;json-stringify-tinderbox;64;64;64;65;65;65;65;66;69;66 09:08:07 INFO - PROCESS | 11892 | |10;stanford-crypto-aes;82;82;79;79;85;79;82;80;86;80 09:08:07 INFO - PROCESS | 11892 | |11;stanford-crypto-ccm;132;143;132;151;130;133;134;133;166;134 09:08:07 INFO - PROCESS | 11892 | |12;stanford-crypto-pbkdf2;172;171;171;170;167;164;168;170;171;169 09:08:07 INFO - PROCESS | 11892 | |13;stanford-crypto-sha256-iterative;67;68;72;68;67;68;68;70;68;68 09:08:07 INFO - PROCESS | 11892 | __end_tp_report 09:08:07 INFO - PROCESS | 11892 | __start_cc_report 09:08:07 INFO - PROCESS | 11892 | _x_x_mozilla_cycle_collect,989 09:08:07 INFO - PROCESS | 11892 | __end_cc_report 09:08:07 INFO - PROCESS | 11892 | __startTimestamp1468339687937__endTimestamp 09:08:07 INFO - PROCESS | 11892 | 09:08:07 INFO - PROCESS | 11892 | ------- Summary: start ------- 09:08:07 INFO - PROCESS | 11892 | Number of tests: 14 09:08:07 INFO - PROCESS | 11892 | 09:08:07 INFO - PROCESS | 11892 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.50 stddev:4.00 (3.5%) stddev-sans-first:3.02 09:08:07 INFO - PROCESS | 11892 | Values: 106.0 114.0 109.0 113.0 116.0 117.0 120.0 116.0 115.0 114.0 09:08:07 INFO - PROCESS | 11892 | 09:08:07 INFO - PROCESS | 11892 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:155.50 stddev:22.32 (14.4%) stddev-sans-first:23.37 09:08:07 INFO - PROCESS | 11892 | Values: 158.0 128.0 147.0 176.0 123.0 160.0 153.0 126.0 184.0 123.0 09:08:07 INFO - PROCESS | 11892 | 09:08:07 INFO - PROCESS | 11892 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:4.48 (2.7%) stddev-sans-first:4.63 09:08:07 INFO - PROCESS | 11892 | Values: 162.0 163.0 162.0 165.0 177.0 164.0 163.0 166.0 162.0 165.0 09:08:07 INFO - PROCESS | 11892 | 09:08:07 INFO - PROCESS | 11892 | [#3] audio-fft Cycles:10 Average:91.80 Median:77.00 stddev:32.15 (41.8%) stddev-sans-first:33.52 09:08:07 INFO - PROCESS | 11892 | Values: 75.0 76.0 77.0 146.0 77.0 77.0 77.0 76.0 159.0 78.0 09:08:07 INFO - PROCESS | 11892 | 09:08:07 INFO - PROCESS | 11892 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:85.00 stddev:28.11 (33.1%) stddev-sans-first:29.16 09:08:07 INFO - PROCESS | 11892 | Values: 86.0 86.0 148.0 85.0 85.0 86.0 148.0 85.0 85.0 133.0 09:08:07 INFO - PROCESS | 11892 | 09:08:07 INFO - PROCESS | 11892 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.14 (1.0%) stddev-sans-first:1.12 09:08:07 INFO - PROCESS | 11892 | Values: 117.0 118.0 117.0 118.0 118.0 119.0 118.0 118.0 121.0 118.0 09:08:07 INFO - PROCESS | 11892 | 09:08:07 INFO - PROCESS | 11892 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 09:08:07 INFO - PROCESS | 11892 | Values: 148.0 147.0 149.0 149.0 148.0 148.0 148.0 147.0 149.0 147.0 09:08:07 INFO - PROCESS | 11892 | 09:08:07 INFO - PROCESS | 11892 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 09:08:07 INFO - PROCESS | 11892 | Values: 95.0 96.0 97.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 09:08:07 INFO - PROCESS | 11892 | 09:08:07 INFO - PROCESS | 11892 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:63.50 stddev:1.25 (2.0%) stddev-sans-first:1.32 09:08:07 INFO - PROCESS | 11892 | Values: 64.0 67.0 63.0 63.0 63.0 63.0 63.0 64.0 64.0 63.0 09:08:07 INFO - PROCESS | 11892 | 09:08:07 INFO - PROCESS | 11892 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:1.49 (2.3%) stddev-sans-first:1.51 09:08:07 INFO - PROCESS | 11892 | Values: 64.0 64.0 64.0 65.0 65.0 65.0 65.0 66.0 69.0 66.0 09:08:07 INFO - PROCESS | 11892 | 09:08:07 INFO - PROCESS | 11892 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:82.00 stddev:2.50 (3.1%) stddev-sans-first:2.65 09:08:07 INFO - PROCESS | 11892 | Values: 82.0 82.0 79.0 79.0 85.0 79.0 82.0 80.0 86.0 80.0 09:08:07 INFO - PROCESS | 11892 | 09:08:07 INFO - PROCESS | 11892 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:134.00 stddev:11.50 (8.6%) stddev-sans-first:11.93 09:08:07 INFO - PROCESS | 11892 | Values: 132.0 143.0 132.0 151.0 130.0 133.0 134.0 133.0 166.0 134.0 09:08:07 INFO - PROCESS | 11892 | 09:08:07 INFO - PROCESS | 11892 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:170.50 stddev:2.41 (1.4%) stddev-sans-first:2.35 09:08:07 INFO - PROCESS | 11892 | Values: 172.0 171.0 171.0 170.0 167.0 164.0 168.0 170.0 171.0 169.0 09:08:07 INFO - PROCESS | 11892 | 09:08:07 INFO - PROCESS | 11892 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:1.51 (2.2%) stddev-sans-first:1.51 09:08:07 INFO - PROCESS | 11892 | Values: 67.0 68.0 72.0 68.0 67.0 68.0 68.0 70.0 68.0 68.0 09:08:07 INFO - PROCESS | 11892 | -------- Summary: end -------- 09:08:07 INFO - PROCESS | 11892 | 09:08:08 INFO - TEST-INFO | 11892: exit 0 09:08:08 INFO - TEST-OK | kraken | took 63899ms 09:08:08 INFO - SUITE-END | took 1181s 09:08:09 INFO - Completed test suite (00:19:41) 09:08:09 INFO - javascript benchmark 09:08:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6476.877209827171, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.3310505821014, 2636.090548760677, 2667.70655227925, 2670.132207032714, 2676.959845602315, 4711.081339138869, 4762.238041913294, 4771.785269662865, 4823.734694591796, 4837.782299796509, 4627.467841198263, 4674.883127921804, 4710.764461776915, 4743.8814029649275, 4748.121597504464, 4340.197063543239, 4415.558444155575, 4491.618212451929, 4499.865004049868, 4562.84030058948, 4464.508904020571, 4480.843170489034, 4482.170798402306, 4543.182227199103, 4545.977270113644, 4458.910821783578, 4516.41286632739, 4567.543245675439, 4580.862574122782, 4599.563041511051, 4284.507281662618, 4327.37253098299, 4423.51341352451, 4439.911201775946, 4447.977760111195, 4342.240107981091, 4359.978200108979, 4363.607275345203, 4365.279728844736, 4386.210482113218, 4805.231163013936, 4822.541858523435, 4824.445188803263, 4838.032393521275, 4891.070696567641, 5119.769610367505, 5179.507946745053, 5186.429492755794, 5187.040397526432, 5211.739413029333, 5218.843434696965, 5221.477852214786, 5236.581073514148, 5250.632455728062, 5256.816011439581, 4882.0, 4883.169861123618, 4884.023195360942, 4884.584810291094, 4926.989967056745, 5248.081585722483, 5333.973330133324, 5338.359396872323, 5364.088105022156, 5369.973150134224, 4990.600751939836, 4991.47589503097, 5005.6996580205305, 5015.749212539431, 5064.366954130734, 4886.560209581155, 5115.616328775357, 5118.513741194581, 5118.718470484159, 5123.180291153398, 5122.718250496258, 5143.8456846294675, 5160.561352285098, 5162.664426812245, 5208.8958220835375, 4884.511548845087, 5076.162433198555, 5142.434332223453, 5168.328117344721, 5168.53483186515, 4228.175505776406, 4423.756693381895, 4426.800793964279, 4437.733735975852, 4478.0, 3789.450529673182, 3806.257779732981, 3810.123671555558, 3827.7129215308964, 3854.0557563397147, 4356.6514678825615, 4391.978040109779, 4399.318105693623, 4399.714018588781, 4434.312681534368, 4890.657653964188, 5035.169197082514, 5157.767900444489, 5161.200013997836, 5241.42344342122, 4293.785310734514, 4314.697971142053, 4318.956810431919, 4355.346697995326, 4371.628411584988, 4557.225271703818, 4560.1335746208115, 4561.019380833137, 4567.5432456754725, 4603.516630753789, 4764.856434455775, 4778.546038126511, 4796.856094317176, 4875.1712208923855, 4875.634327425528, 5157.174852023658, 5178.844634660966, 5213.843584692465, 5218.16509358516, 5229.895402092013, 4885.755712214304, 4894.241392584155, 4899.020195960751, 4900.583450406612, 4902.2156454967035, 4967.751612419437, 4994.600431965361, 5033.119204139334, 5050.191969284897, 5059.519345662304, 5074.5940324774665, 5107.923381149211, 5123.077845987758, 5129.281900533853, 5167.276581278549, 4830.082284365959, 4833.286288026187, 4834.830780922651, 4861.975690121527, 4900.534449227318, 4665.066986602761, 4916.8770780730765, 4920.704757714549, 4926.162552366178, 4948.307236986752, 4708.552687494683, 4726.621870250303, 4777.784999674954, 4798.184308667465, 4802.087603355351, 4705.76471176433, 4846.636502262274, 4850.393700787402, 4972.602191824718, 5008.499150084962, 4743.83396581118, 4752.952470475251, 4761.142994261067, 4799.208130658402, 4816.34979277793], "value": 4695.787096730184, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.947280008399, 563.0793652378361, 565.6464709556526, 584.3163498706513, 586.1559354529477, 35138.648613513855, 39362.01594960124, 39464.210715785666, 39553.0, 39666.80166599167, 40037.0, 40656.59343406565, 40677.59322406775, 40724.0, 40754.7962260189, 7887.6056197190055, 8035.236652518001, 8044.919550804505, 8052.033755949295, 8072.919270807305, 7850.882236766453, 7910.52536847791, 7948.801279967989, 7961.442699011071, 7989.0, 7963.800904977364, 7964.482308649948, 7984.720534781284, 8005.279524842763, 8013.078495972979, 7935.206479352077, 7991.081025682063, 7997.080335761404, 8015.799605009863, 8016.63925123365, 7825.882611760771, 7865.882011769828, 7890.842183156362, 7901.486403383819, 7905.130435652074, 37649.435258471145, 38241.80879095587, 38264.04339891497, 38321.23357532862, 38328.233435331415, 3045.604071470717, 3262.4943133814295, 3346.8159251241173, 3439.4324936385715, 3523.242502861897, 28985.420291594262, 29541.113766586823, 29875.70124298751, 29920.95276665328, 30633.78345273759, 3231.1760501072313, 3262.657420970788, 3271.9182020449443, 3381.898543043713, 3386.204242003127, 272893.63553182303, 273349.0, 273635.0, 274470.3935362273, 274528.0, 51074.0, 51722.224166637534, 51786.74106629518, 51806.74096629493, 51875.22187167196, 32623.51064734031, 33388.666113339044, 33394.332113357596, 35283.4707479388, 35367.64632353695, 13349.866501335056, 13369.398377072861, 13399.330033498287, 13421.194728316332, 13436.395362208725, 10947.686277646733, 11043.39261340634, 11120.277181983145, 11122.110231181648, 11135.33188008722, 18304.816951830577, 18397.632047358977, 18429.90785046093, 18506.722399164024, 18576.65620188379, 6685.39831415175, 6750.493712971547, 6927.757528486479, 6972.965135174291, 7040.788776336718, 787.1105650614769, 885.1237275097607, 895.7939673875045, 921.6728061538191, 951.1154626197564, 28219.858900705363, 28849.85575072111, 28853.422931541252, 29341.266468338035, 29500.0, 931.8695382646434, 970.1705042188968, 1038.6209033702644, 1071.5338827610015, 1109.1182509904645, 15044.473443429428, 15122.0, 15230.695386092217, 15440.536783896276, 15480.5355839325, 428669.0, 431389.0, 432137.0, 433948.0, 435235.0, 48626.75686621615, 48920.51079489231, 49018.0, 49087.26369104466, 49208.507914920396, 1186.6143503361443, 1210.709429736857, 1212.2847519963263, 1220.5850010996303, 1254.3038613569374, 27557.58663620007, 28333.716662833107, 28541.28646783764, 28646.0, 29052.56421153642, 40695.1860962785, 41080.58919410768, 41337.58662413337, 41369.79315103405, 41393.1721365577, 313955.0, 316189.0, 316891.0, 317171.0, 317600.0, 22135.225267115573, 22811.771882281628, 22870.54258914779, 22947.196848110238, 25239.62140567856, 40710.0, 41015.589844101174, 41381.79309103435, 42117.1576568473, 42800.35799463073, 37383.81308093442, 37556.0, 37983.240335193696, 38294.617053829104, 38620.227595448494, 37168.628313716516, 37805.0, 37844.0, 38080.80959595184, 38152.618473816015, 31336.843315783277, 36424.453633196055, 36869.26261474809, 37040.70357537473, 37273.440898386005, 31660.0, 33969.32061358808, 34266.657333426345, 34335.484967726006, 34604.307913841076, 25405.61891571591, 25437.87281063583, 25583.616245755955, 25712.87143564345, 26160.476790464465], "value": 17476.964742942466, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.85848519077564, 366.1468777747848, 366.24005189232344, 375.54558983629806, 381.68510978442777, 16280.83719162808, 17306.39427620035, 17318.393856215036, 17677.381291654794, 17845.107744612782, 15858.603534911634, 17361.392351267707, 17987.4603761887, 18023.459296221135, 18039.278428862828, 5220.269162317279, 5356.437574054727, 5401.4868587484125, 5408.621396502246, 5410.83767486976, 3713.3316003119426, 5217.686938783685, 5930.970345148268, 6258.5306102042305, 6262.592931459463, 6222.81331560054, 6295.968520157416, 6304.401081897213, 6310.779122730705, 6319.905201421982, 6139.969300153493, 6300.369963003709, 6301.495880329586, 6308.905366419507, 6313.873722525546, 5475.972620136914, 5514.834554963358, 5516.641418307797, 5517.089680202762, 5532.419095994903, 20864.47838804027, 21169.576608467898, 21320.78679213219, 21641.675374869388, 21828.0, 1932.4975506368446, 1994.6509360861792, 2084.739407574053, 2296.5751336002895, 2510.0336370497307, 12282.815757763641, 13374.0, 13514.797278040838, 13588.59234222975, 13906.30468476572, 1724.9564013771737, 1741.6255505066345, 1761.9207135678926, 1820.4538638408558, 1856.9535761605932, 74347.0, 75016.24983750147, 75807.62096189483, 75825.62087189584, 76285.61857190734, 10109.848352274721, 10201.438920859424, 10244.48777561119, 10277.588896444207, 10298.197815382428, 13838.515651952133, 13897.513587024405, 13908.860911390959, 13921.164730116225, 13942.930285348712, 7324.376424999701, 7422.369098626569, 7429.145648250413, 7513.323800857949, 7542.358899493494, 6872.41584465316, 6907.792766217021, 7106.786796396116, 7113.857722845514, 7134.143902731602, 4364.847230346986, 4367.519572846984, 4444.355568442557, 4548.5906268436, 4553.544645535486, 1710.7091794394983, 1754.7017007108823, 1792.97310540342, 1816.4641430777951, 1849.8427633651022, 799.384473955063, 840.277361469136, 899.1772528136681, 901.2609660078673, 978.3102912446708, 16430.1784910754, 16721.83278167227, 16785.58036049084, 16863.831361686225, 17325.2203650836, 847.2459511035183, 857.7555396711907, 860.3633311349556, 921.4287141971886, 929.3773171974793, 9494.240460763122, 9502.47736374506, 9547.665831695856, 9559.426434413957, 9690.418574885389, 361668.0, 368657.0, 370898.0, 373313.0, 382685.0, 51322.0, 52039.21941170885, 54115.72942135264, 72214.63892680503, 79423.0, 901.0493928905069, 927.4481683398367, 929.8837645294338, 953.6233187890745, 956.5886668732372, 15983.120928349052, 16118.597035074217, 16198.433054843495, 16522.09128497944, 16826.074565898994, 38584.80707596444, 39741.20517589574, 40848.59151408448, 41048.0, 41472.79263603783, 55526.72236638953, 55886.441135588124, 56973.71513142408, 57167.0, 58121.4187858116, 7278.781636550912, 7884.1327453978865, 7901.68393264286, 8001.079875814356, 8116.0260768705775, 9887.653932112342, 11243.887561124611, 11872.16894817389, 12345.382730863601, 12483.812742808683, 10937.617183398543, 10950.507227174638, 11074.5570177192, 11128.499217535393, 11159.888401115884, 10129.240306977154, 10219.642312519027, 10771.515281812493, 10837.566497340333, 11101.333919964827, 10713.785724285626, 10914.18143639246, 10996.28524145928, 11131.944340278247, 11132.0, 8102.311303539265, 8127.431079824356, 8140.0, 8170.305524030524, 8174.0, 10570.524326405177, 10877.184211184034, 10946.781064378827, 11168.553257869919, 11220.60727874553], "value": 8558.552728344066, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.835900710352, 1395.0792476965203, 1484.6140003599062, 1679.9832001679995, 1702.812690604034, 6257.155284036654, 6993.965030174848, 7052.3652871241575, 7564.546127232363, 7596.202398748128, 7037.085178926745, 7279.818004549889, 7338.853222935538, 7342.15565210001, 7350.705971761136, 2124.2671278409002, 2139.5934772393275, 2140.2937030779804, 2143.07847625521, 2159.4277516458073, 2132.2430537159316, 2143.110609097223, 2199.14233448955, 2201.8458707890454, 2204.581129585382, 2141.1328411993168, 2146.2702681088426, 2154.202944910385, 2155.8706477611313, 2157.072458842697, 2102.3272552783114, 2107.1571371451464, 2113.0243222586932, 2113.86259893108, 2116.322776711453, 2032.6950957356366, 2057.7839326870762, 2079.677649964258, 2086.8539202255847, 2096.2663067926255, 7445.181030086686, 7454.440916931252, 7467.215942326032, 7498.625068746595, 7519.699212031567, 4283.507396649363, 4492.707973981681, 4502.212112880233, 4503.504614492404, 4518.819247230107, 2776.0422654184276, 2778.166550035002, 2851.81463204891, 2887.956680649792, 2894.82631042136, 874.54960695242, 918.8437965545806, 918.9770255743593, 931.59475628102, 943.9433633981984, 10058.396496210178, 10082.395056296646, 10083.394996300172, 10086.596536138546, 10188.949055254676, 3996.460477835455, 4084.081081756581, 4128.1330920506425, 4238.21593005295, 4246.554111818215, 8509.064002959669, 8531.616077276538, 8534.487930724177, 8535.871961920577, 8595.312375009984, 4561.087782443525, 4571.451425828922, 4572.95427045732, 4596.35651008859, 4607.95392046082, 3583.7849729016343, 4017.7589344639414, 4194.203101410783, 4206.579342065769, 4219.198352313051, 3507.982460087734, 3543.5216245807, 3554.928901421957, 3566.6968307694137, 3646.854125834937, 1119.7536541960756, 1155.8959693627614, 1157.8552680914886, 1165.0504838556549, 1171.6953592065954, 832.3715594726065, 832.9708460203864, 842.2882664148784, 866.1425189062783, 872.5462759365222, 4933.555979961749, 4994.123102406812, 5026.271190677331, 5078.13671675816, 5151.175811870157, 403.243917654398, 414.57713132604573, 420.2372693561177, 430.99784501077295, 434.88910327866824, 3282.6553211912883, 3312.3706495765728, 3332.9333413332083, 3366.7306615471193, 3383.8984830455124, 8599.5700214989, 8690.608922598498, 8917.242034427147, 8919.777005574782, 9150.771230719152, 9063.637454501877, 9190.448573085636, 9199.310051746146, 9226.49254291007, 9255.352125351295, 6746.0, 6835.111435513351, 7096.893546596805, 7101.183363913216, 7108.218096009435, 4923.359963204761, 4982.302477653204, 4998.0, 5014.0, 5133.589312855037, 8458.492490450593, 8615.526146062026, 8615.741527754177, 8670.176333248332, 8691.348148888732, 8518.275946544612, 8723.956380218058, 8745.081766414689, 8772.736817895473, 8778.604962776562, 5725.5992080555625, 6300.0234963580715, 6390.5526613136635, 6501.34986501365, 6520.478361731145, 7124.857502850017, 7176.354128128493, 7182.784516464514, 7221.927780722125, 7232.5660460370445, 6374.113254511512, 6507.577007494498, 6520.967395162994, 6699.028640846953, 6782.660866956534, 6305.747770089145, 6462.4183823456115, 6521.217453905561, 6621.0, 6642.202935647753, 5739.167820666064, 5834.854128646818, 5872.265966754156, 5891.116332550152, 5907.143464197753, 4174.519930208065, 4321.762303073361, 4357.215701173819, 4369.60673539383, 4374.518802931739, 4320.114376552736, 4527.479339875957, 4541.523140070245, 4588.678792484628, 4590.931136033029], "value": 3921.297521940166, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.7197620225091, 299.74970899299086, 302.7895612549279, 304.6298747022368, 308.9011516314779, 5110.233464980255, 5127.820526281581, 5131.435542090372, 5133.6919784812935, 5140.8971820563565, 5038.823641172559, 5041.798328066882, 5045.268436076776, 5048.0, 5058.620603454738, 3760.4735337052834, 3866.729328946961, 3970.642642162205, 4008.198360327946, 4011.7793521356316, 3951.3875349320756, 3962.6433620974108, 3966.5438474575362, 3979.9801000994953, 4016.2369149861433, 3966.900827479322, 3979.1946677592227, 3995.1610161865897, 4012.779297138656, 4037.8788636340955, 3636.799976001319, 3861.1891502784447, 3865.5554611219786, 4015.07653239755, 4015.6185162409524, 3339.833008349573, 3342.7827191232736, 3351.447011243142, 3353.295807880348, 3359.228636374976, 4942.998085775267, 4945.950540494585, 4947.802087916479, 4952.925706114411, 5019.272205530177, 4312.180685669744, 4417.160739459492, 4434.290513517822, 4441.289393697025, 4458.598726114666, 5197.428282888879, 5230.241614965847, 5241.371035475768, 5258.605604579634, 5308.336457942757, 3696.4270538066644, 3710.499082623838, 3727.422249551324, 3733.1227161617, 3736.794476303802, 5347.732613369316, 5480.739429931098, 5490.3411590608985, 5490.917636235459, 5496.877341993505, 3674.614165512636, 3809.809509524568, 3810.599887011879, 3812.3606849054618, 3837.196517636706, 3806.7715937043868, 3842.269968705993, 3843.942340864889, 3853.7687738735767, 3858.7298889077497, 4430.825831154747, 4441.267190913528, 4457.24226881431, 4475.7985890635, 4476.37330773692, 5114.590832733373, 5281.339832520935, 5290.836016076457, 5342.145256758978, 5362.2224777407055, 1302.3943866102309, 1305.8694130587055, 1310.5675127207999, 1314.8553659097493, 1315.3094625321783, 845.6997765793055, 855.3371137368589, 857.5197889181953, 867.700643278068, 882.4661080046608, 4538.367746706902, 4543.636509079266, 4545.113702827983, 4565.08266528059, 4573.314002899591, 5422.972885135628, 5437.972810135924, 5448.482394172547, 5458.235846981426, 5462.972685136629, 4363.694541382136, 4535.501094879561, 4537.319402089713, 4537.705049171794, 4562.1788078146255, 2928.194746444702, 2935.1341354300534, 2943.617329747119, 2946.6905974872757, 2954.8670309836107, 5080.0, 5127.512886275797, 5136.743162841843, 5137.843985103322, 5141.305923700253, 5450.700211488327, 5583.664980101207, 5622.8313150605545, 5626.915596266059, 5731.140328950607, 5116.641835071584, 5116.692998420107, 5133.230015497706, 5141.460146684619, 5169.353830771153, 5513.476219759116, 5513.58648101402, 5530.170474428868, 5531.502164805187, 5566.582506311962, 5230.311442179989, 5316.362036555638, 5393.298871146726, 5412.675239485643, 5440.319960004999, 5155.479133655505, 5181.37823461172, 5190.378858676344, 5200.375954885438, 5205.037068142406, 3862.0689655172414, 3893.9221215576094, 3894.6105389460827, 3897.902552436212, 3902.2780785554764, 5241.371035475615, 5555.666660000413, 5556.638818476786, 5558.916616250679, 5585.916211256753, 5188.429272779916, 5216.9826883757305, 5234.738263086754, 5242.711650859239, 5277.973610132079, 5113.769880355468, 5243.501867322599, 5276.657017293864, 5292.179712144623, 5310.256564081109, 5062.265971434048, 5069.465267366317, 5079.415867175322, 5079.5428411443145, 5105.642605017613, 4919.409670839522, 5137.434882163034, 5224.7126408047925, 5237.921431178612, 5247.317848679647, 5089.694618322913, 5096.088966637511, 5104.132297509506, 5110.9233361500355, 5113.64204505681], "value": 3962.502576777018, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.2216906219724, 678.8540463800285, 709.9822504437385, 735.1582438108366, 752.4469514906543, 11649.126315526337, 12056.276623402591, 12104.69738256543, 13494.460221591125, 14466.638334041654, 14919.0, 15129.848701512981, 15149.772753408708, 15158.469453569127, 15229.69540609187, 753.2204168685412, 772.2740623813597, 773.5745340062942, 774.3727580659684, 775.5269285735696, 619.9411055949678, 753.5328096580128, 771.7376092128675, 772.4669977715358, 773.8220209351853, 815.1237419773737, 817.342039658075, 817.9836403271931, 818.5866137600533, 821.2936874288107, 802.1937952357902, 808.1595141053298, 810.2019510781846, 811.0470197517893, 812.25272749071, 591.3879135095199, 591.8076625096818, 591.9082542205965, 592.9614575052608, 594.0999385930319, 13721.862781372258, 13797.793033104512, 13802.792958105636, 13825.10136841102, 13842.377093030838, 13105.737885242243, 13133.540326088636, 13246.536371226961, 13325.86674133256, 13344.2660653664, 10530.736731581695, 10655.200859935536, 10672.839907401396, 10675.252732308742, 10849.566017359375, 3230.5800245967876, 3266.5753452051317, 3284.1953721338186, 3294.3081952789944, 3303.8678452861855, 62405.0, 62492.0, 62641.37358626401, 62654.37345626531, 63851.36148638501, 10109.797804043877, 10320.690379288633, 10378.844317335246, 10508.947455262827, 10634.627788027537, 17369.7394539082, 18006.189721462564, 18109.7283540747, 18818.623627527373, 19021.90489047546, 7047.083879095787, 7188.78433646981, 7252.673629686677, 7387.519811212254, 7397.81505462357, 3838.443425703257, 3888.358420860526, 3908.570057293752, 3918.5101862267215, 3941.5467221269346, 2788.8187267827525, 2885.7114288570974, 2889.5376739721964, 2889.7110288971353, 2904.4771941050813, 522.0628970997069, 543.1282791120274, 549.9752511137009, 550.5045459086854, 556.0713608274192, 562.9268195134606, 631.5105793010454, 636.1729751323261, 637.3594537489793, 651.8174911024921, 8464.873026904601, 8982.281417486585, 8986.370954033155, 9142.725718228463, 9198.770030749285, 529.4123522889589, 567.8069456384849, 637.8214100051993, 644.2880616918331, 645.7901182115831, 4102.610252026112, 4432.3794668746405, 4452.30989196675, 4458.687891847604, 4630.3748993886065, 104303.0, 104751.0, 106032.46983765032, 109037.0, 109586.0, 95111.0, 97420.0, 98815.0, 99223.50388248157, 99273.0, 80151.59924200458, 83407.0, 83527.0, 84667.15332846716, 85684.99999999875, 8319.958400207961, 8321.54231517248, 8514.191151840812, 8517.829643407222, 8519.0, 49698.503014969385, 50372.0, 50518.0, 51107.23339149841, 51180.0, 38667.2266554673, 39521.80239098786, 39632.2073558533, 57499.71250143723, 58506.414935850094, 11553.364564949008, 11753.529858805552, 11995.940020299842, 12028.0, 12222.572209972608, 12514.74970500603, 12640.178388404724, 12853.807192891927, 12934.417951192407, 13283.601491955256, 11532.654020379403, 11711.063114950954, 11849.585264515701, 11937.59959238942, 12748.872511274769, 12533.811992819932, 12659.177153484994, 12811.0, 12846.229226246454, 13088.934555327163, 11229.101671866069, 11604.709882253012, 12340.259584424604, 12596.30720310355, 13218.47126114983, 9866.309358344846, 9906.950465247915, 10015.84438620462, 10058.446785426871, 10102.184269484462, 9491.572879220314, 9787.804243915225, 9832.24302092101, 10497.79004419892, 10521.105706015074], "value": 6763.4701730754905, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1570.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 109.0, 113.0, 116.0, 117.0, 120.0, 116.0, 115.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 128.0, 147.0, 176.0, 123.0, 160.0, 153.0, 126.0, 184.0, 123.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 165.0, 177.0, 164.0, 163.0, 166.0, 162.0, 165.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 146.0, 77.0, 77.0, 77.0, 76.0, 159.0, 78.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 148.0, 85.0, 85.0, 86.0, 148.0, 85.0, 85.0, 133.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 119.0, 118.0, 118.0, 121.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 149.0, 148.0, 148.0, 148.0, 147.0, 149.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 64.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 66.0, 69.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 79.0, 79.0, 85.0, 79.0, 82.0, 80.0, 86.0, 80.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 143.0, 132.0, 151.0, 130.0, 133.0, 134.0, 133.0, 166.0, 134.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 171.0, 170.0, 167.0, 164.0, 168.0, 170.0, 171.0, 169.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 72.0, 68.0, 67.0, 68.0, 68.0, 70.0, 68.0, 68.0], "value": 68.4, "unit": "score"}]}]} 09:08:09 INFO - Return code: 0 09:08:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:08:09 ERROR - # TBPL SUCCESS # 09:08:09 INFO - Running post-action listener: _resource_record_post_action 09:08:09 INFO - ##### 09:08:09 INFO - ##### Finished run-tests step (success) 09:08:09 INFO - ##### 09:08:09 INFO - Running post-run listener: _resource_record_post_run 09:08:09 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 552681472; Read time: 20; Write time: 449632 09:08:09 INFO - TinderboxPrint: CPU usage
13.3% 09:08:09 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 09:08:09 INFO - TinderboxPrint: I/O write bytes / time
552,681,472 / 449,632 09:08:09 INFO - TinderboxPrint: CPU idle
8,285.5 (86.7%) 09:08:09 INFO - TinderboxPrint: CPU user
1,220.0 (12.8%) 09:08:09 INFO - TinderboxPrint: Swap in / out
0 / 0 09:08:09 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 264601600; Read time: 0; Write time: 277272 09:08:09 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288079872; Read time: 0; Write time: 172360 09:08:09 INFO - Running post-run listener: _upload_blobber_files 09:08:09 INFO - Blob upload gear active. 09:08:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:08:09 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 09:08:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:08:10 INFO - (blobuploader) - INFO - Open directory for files ... 09:08:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:08:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:08:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:13 INFO - (blobuploader) - INFO - Done attempting. 09:08:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:08:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:08:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:14 INFO - (blobuploader) - INFO - Done attempting. 09:08:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:08:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:08:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:15 INFO - (blobuploader) - INFO - Done attempting. 09:08:15 INFO - (blobuploader) - INFO - Iteration through files over. 09:08:15 INFO - Return code: 0 09:08:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:08:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:08:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85bdc0df1c6082df63bdc6e46ee775640a75e5d3c4ed2ede4cf4cf68b449bf5a3faaa41838b2cc1fd6d589db94f133eca054fa493a4a1785ebe3271971734407", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d89bcfbdf8a8cae284ee23af151323f611a87d52132fa9d3f03bdff605b2858a2a2f1ebbddcc52f8a67388b9d5163b43d95702e472c41d300b769d61b989f048", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce42d8689e88f805aafb228f90a6a1e1aa7d4775505501abbdde13e655314b909ddf28547c1ea30b733db3647f7dbfe94493681c88335b5d77c9afcd82cfbaa8"} 09:08:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:08:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:08:15 INFO - Contents: 09:08:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85bdc0df1c6082df63bdc6e46ee775640a75e5d3c4ed2ede4cf4cf68b449bf5a3faaa41838b2cc1fd6d589db94f133eca054fa493a4a1785ebe3271971734407", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d89bcfbdf8a8cae284ee23af151323f611a87d52132fa9d3f03bdff605b2858a2a2f1ebbddcc52f8a67388b9d5163b43d95702e472c41d300b769d61b989f048", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce42d8689e88f805aafb228f90a6a1e1aa7d4775505501abbdde13e655314b909ddf28547c1ea30b733db3647f7dbfe94493681c88335b5d77c9afcd82cfbaa8"} 09:08:15 INFO - Running post-run listener: copy_logs_to_upload_dir 09:08:15 INFO - Copying logs to upload dir... 09:08:15 INFO - mkdir: /builds/slave/test/build/upload/logs 09:08:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.471368 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-12 09:08:15.103579) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 09:08:15.107454) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85bdc0df1c6082df63bdc6e46ee775640a75e5d3c4ed2ede4cf4cf68b449bf5a3faaa41838b2cc1fd6d589db94f133eca054fa493a4a1785ebe3271971734407", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d89bcfbdf8a8cae284ee23af151323f611a87d52132fa9d3f03bdff605b2858a2a2f1ebbddcc52f8a67388b9d5163b43d95702e472c41d300b769d61b989f048", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce42d8689e88f805aafb228f90a6a1e1aa7d4775505501abbdde13e655314b909ddf28547c1ea30b733db3647f7dbfe94493681c88335b5d77c9afcd82cfbaa8"} build_url:https://queue.taskcluster.net/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/G0cBUYnlTgOKWlmIj2ihKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85bdc0df1c6082df63bdc6e46ee775640a75e5d3c4ed2ede4cf4cf68b449bf5a3faaa41838b2cc1fd6d589db94f133eca054fa493a4a1785ebe3271971734407", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d89bcfbdf8a8cae284ee23af151323f611a87d52132fa9d3f03bdff605b2858a2a2f1ebbddcc52f8a67388b9d5163b43d95702e472c41d300b769d61b989f048", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce42d8689e88f805aafb228f90a6a1e1aa7d4775505501abbdde13e655314b909ddf28547c1ea30b733db3647f7dbfe94493681c88335b5d77c9afcd82cfbaa8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 09:08:15.133224) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:08:15.133589) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1468337073.77684-1803274815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:08:15.218207) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 09:08:15.218568) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 09:08:15.219229) ========= ========= Total master_lag: 0.20 =========