builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1467781541.39 results: success (0) buildid: 20160705193024 builduid: 36ea3d2beeb44349b0858343de4675a8 revision: 70e05c6832e831374604ac3ce7433971368dffe0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 22:05:41.387518) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 22:05:41.387998) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 22:05:41.388289) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 22:05:41.402828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:05:41.403395) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 22:05:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-07-05 22:05:42 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115515 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:05:41.534553) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:05:41.534866) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018042 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:05:41.584039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:05:41.584393) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 70e05c6832e831374604ac3ce7433971368dffe0 --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 70e05c6832e831374604ac3ce7433971368dffe0 --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=3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 22:05:42,737 truncating revision to first 12 chars 2016-07-05 22:05:42,738 Setting DEBUG logging. 2016-07-05 22:05:42,738 attempt 1/10 2016-07-05 22:05:42,738 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/70e05c6832e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 22:05:43,065 unpacking tar archive at: mozilla-central-70e05c6832e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.629808 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:05:42.227750) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 22:05:42.228118) ========= script_repo_revision: 70e05c6832e831374604ac3ce7433971368dffe0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 22:05:42.228523) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 22:05:42.228816) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 22:05:42.238353) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-07-05 22:05:42.238705) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:05:43 INFO - MultiFileLogger online at 20160705 22:05:43 in /builds/slave/test 22:05:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:05:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:05:43 INFO - {'append_to_log': False, 22:05:43 INFO - 'base_work_dir': '/builds/slave/test', 22:05:43 INFO - 'blob_upload_branch': 'Firefox', 22:05:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:05:43 INFO - 'branch': 'Firefox', 22:05:43 INFO - 'buildbot_json_path': 'buildprops.json', 22:05:43 INFO - 'config_files': ('talos/linux_config.py',), 22:05:43 INFO - 'default_actions': ('clobber', 22:05:43 INFO - 'read-buildbot-config', 22:05:43 INFO - 'download-and-extract', 22:05:43 INFO - 'populate-webroot', 22:05:43 INFO - 'create-virtualenv', 22:05:43 INFO - 'install', 22:05:43 INFO - 'run-tests'), 22:05:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:05:43 INFO - 'download_minidump_stackwalk': True, 22:05:43 INFO - 'download_symbols': 'ondemand', 22:05:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:05:43 INFO - 'tooltool.py': '/tools/tooltool.py', 22:05:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:05:43 INFO - '/tools/misc-python/virtualenv.py')}, 22:05:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:05:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:05:43 INFO - 'installer_path': 'installer.exe', 22:05:43 INFO - 'log_level': 'info', 22:05:43 INFO - 'log_name': 'talos', 22:05:43 INFO - 'log_to_console': True, 22:05:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:05:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:05:43 INFO - 'opt_config_files': (), 22:05:43 INFO - 'pip_index': False, 22:05:43 INFO - 'sps_profile': False, 22:05:43 INFO - 'sps_profile_interval': 0, 22:05:43 INFO - 'suite': 'dromaeojs-e10s', 22:05:43 INFO - 'system_bits': '32', 22:05:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:05:43 INFO - 'title': 'talos-linux64-ix-059', 22:05:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:05:43 INFO - 'use_talos_json': True, 22:05:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:05:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:05:43 INFO - 'work_dir': 'build'} 22:05:43 INFO - ##### 22:05:43 INFO - ##### Running clobber step. 22:05:43 INFO - ##### 22:05:43 INFO - Running pre-action listener: _resource_record_pre_action 22:05:43 INFO - Running main action method: clobber 22:05:43 INFO - rmtree: /builds/slave/test/build 22:05:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:05:43 INFO - Running post-action listener: _resource_record_post_action 22:05:43 INFO - ##### 22:05:43 INFO - ##### Finished clobber step (success) 22:05:43 INFO - ##### 22:05:43 INFO - ##### 22:05:43 INFO - ##### Running read-buildbot-config step. 22:05:43 INFO - ##### 22:05:43 INFO - Running pre-action listener: _resource_record_pre_action 22:05:43 INFO - Running main action method: read_buildbot_config 22:05:43 INFO - Using buildbot properties: 22:05:43 INFO - { 22:05:43 INFO - "project": "", 22:05:43 INFO - "product": "firefox", 22:05:43 INFO - "script_repo_revision": "production", 22:05:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:05:43 INFO - "repository": "", 22:05:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 22:05:43 INFO - "buildid": "20160705193024", 22:05:43 INFO - "pgo_build": "True", 22:05:43 INFO - "basedir": "/builds/slave/test", 22:05:43 INFO - "buildnumber": 764, 22:05:43 INFO - "slavename": "talos-linux64-ix-059", 22:05:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:05:44 INFO - "platform": "ubuntu64_hw", 22:05:44 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:05:44 INFO - "branch": "mozilla-central", 22:05:44 INFO - "repo_path": "mozilla-central", 22:05:44 INFO - "revision": "70e05c6832e831374604ac3ce7433971368dffe0", 22:05:44 INFO - "stage_platform": "linux64-pgo", 22:05:44 INFO - "builduid": "36ea3d2beeb44349b0858343de4675a8", 22:05:44 INFO - "slavebuilddir": "test" 22:05:44 INFO - } 22:05:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:05:44 INFO - Running post-action listener: _resource_record_post_action 22:05:44 INFO - ##### 22:05:44 INFO - ##### Finished read-buildbot-config step (success) 22:05:44 INFO - ##### 22:05:44 INFO - ##### 22:05:44 INFO - ##### Running download-and-extract step. 22:05:44 INFO - ##### 22:05:44 INFO - Running pre-action listener: _resource_record_pre_action 22:05:44 INFO - Running main action method: download_and_extract 22:05:44 INFO - mkdir: /builds/slave/test/build/tests 22:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:05:44 INFO - https://queue.taskcluster.net/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:05:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:05:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:05:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/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 22:05:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/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 22:05:44 INFO - Downloaded 1361 bytes. 22:05:44 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:05:44 INFO - Using the following test package requirements: 22:05:44 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:05:44 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:05:44 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:05:44 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:44 INFO - u'jsshell-linux-x86_64.zip'], 22:05:44 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:05:44 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:05:44 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:05:44 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:05:44 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:05:44 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:05:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:05:44 INFO - https://queue.taskcluster.net/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:05:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:05:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:05:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/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 22:05:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/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 22:05:45 INFO - Downloaded 24300728 bytes. 22:05:45 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'] 22:05:45 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 22:05:46 INFO - Return code: 0 22:05:46 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 22:05: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')]} 22:05:46 INFO - https://queue.taskcluster.net/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:05:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:05:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:05:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/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 22:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/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 22:05:48 INFO - Downloaded 24300728 bytes. 22:05:48 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'] 22:05:48 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 22:05:49 INFO - Return code: 0 22:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:05:49 INFO - https://queue.taskcluster.net/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:05:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:05:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:05:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/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 22:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/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 22:05:50 INFO - Downloaded 14403333 bytes. 22:05:50 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'] 22:05:50 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 22:05:50 INFO - Return code: 0 22:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:05:50 INFO - https://queue.taskcluster.net/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:05:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:05:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:05:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/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 22:05:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/agJ7V28tTBmw0OC7XmFigA/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 22:05:52 INFO - Downloaded 60359270 bytes. 22:05:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:05:52 INFO - mkdir: /builds/slave/test/properties 22:05:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:05:52 INFO - Writing to file /builds/slave/test/properties/build_url 22:05:52 INFO - Contents: 22:05:52 INFO - build_url:https://queue.taskcluster.net/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:05:52 INFO - Running post-action listener: _resource_record_post_action 22:05:52 INFO - Running post-action listener: set_extra_try_arguments 22:05:52 INFO - ##### 22:05:52 INFO - ##### Finished download-and-extract step (success) 22:05:52 INFO - ##### 22:05:52 INFO - ##### 22:05:52 INFO - ##### Running populate-webroot step. 22:05:52 INFO - ##### 22:05:52 INFO - Running pre-action listener: _resource_record_pre_action 22:05:52 INFO - Running main action method: populate_webroot 22:05:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:05:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:05:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:05:52 INFO - '--tppagecycles', 22:05:52 INFO - '7'], 22:05:52 INFO - 'tests': ['tsvgm']}}, 22:05:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:05:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:05:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:05:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:05:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:05:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:05:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:52 INFO - 'talos_options': ['--disable-e10s'], 22:05:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:05:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:05:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:52 INFO - 'talos_options': ['--disable-e10s'], 22:05:52 INFO - 'tests': ['damp', 'tps']}, 22:05:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:52 INFO - 'tests': ['damp', 'tps']}, 22:05:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:05:52 INFO - 'tests': ['dromaeo_dom']}, 22:05:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:05:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:05:52 INFO - 'tests': ['basic_compositor_video']}, 22:05:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:05:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:05:52 INFO - 'tests': ['a11yr', 22:05:52 INFO - 'ts_paint', 22:05:52 INFO - 'tpaint', 22:05:52 INFO - 'sessionrestore', 22:05:52 INFO - 'sessionrestore_no_auto_restore', 22:05:52 INFO - 'tabpaint']}, 22:05:52 INFO - 'other-e10s': {'tests': ['a11yr', 22:05:52 INFO - 'ts_paint', 22:05:52 INFO - 'tpaint', 22:05:52 INFO - 'sessionrestore', 22:05:52 INFO - 'sessionrestore_no_auto_restore', 22:05:52 INFO - 'tabpaint']}, 22:05:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:05:52 INFO - 'ts_paint', 22:05:52 INFO - 'tpaint', 22:05:52 INFO - 'sessionrestore', 22:05:52 INFO - 'sessionrestore_no_auto_restore', 22:05:52 INFO - 'tabpaint']}, 22:05:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:05:52 INFO - 'ts_paint', 22:05:52 INFO - 'tpaint', 22:05:52 INFO - 'sessionrestore', 22:05:52 INFO - 'sessionrestore_no_auto_restore', 22:05:52 INFO - 'tabpaint']}, 22:05:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:05:52 INFO - 'tests': ['a11yr', 22:05:52 INFO - 'ts_paint', 22:05:52 INFO - 'tpaint', 22:05:52 INFO - 'sessionrestore', 22:05:52 INFO - 'sessionrestore_no_auto_restore', 22:05:52 INFO - 'tabpaint']}, 22:05:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:05:52 INFO - 'tests': ['a11yr', 22:05:52 INFO - 'ts_paint', 22:05:52 INFO - 'tpaint', 22:05:52 INFO - 'sessionrestore', 22:05:52 INFO - 'sessionrestore_no_auto_restore', 22:05:52 INFO - 'tabpaint']}, 22:05:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:05:52 INFO - 'tests': ['tsvgx', 22:05:52 INFO - 'tsvgr_opacity', 22:05:52 INFO - 'tart', 22:05:52 INFO - 'tscrollx', 22:05:52 INFO - 'cart']}, 22:05:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:05:52 INFO - 'tsvgr_opacity', 22:05:52 INFO - 'tart', 22:05:52 INFO - 'tscrollx', 22:05:52 INFO - 'cart']}, 22:05:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:52 INFO - 'talos_options': ['--disable-e10s'], 22:05:52 INFO - 'tests': ['tp5o']}, 22:05:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:52 INFO - 'tests': ['tp5o']}, 22:05:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:52 INFO - 'talos_options': ['--disable-e10s', 22:05:52 INFO - '--xperf_path', 22:05:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:05:52 INFO - 'tests': ['tp5n']}, 22:05:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:52 INFO - 'talos_options': ['--xperf_path', 22:05:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:05:52 INFO - 'tests': ['tp5n']}}, 22:05:52 INFO - 'talos.zip': {'path': '', 22:05:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:05:52 INFO - Running post-action listener: _resource_record_post_action 22:05:52 INFO - ##### 22:05:52 INFO - ##### Finished populate-webroot step (success) 22:05:52 INFO - ##### 22:05:52 INFO - ##### 22:05:52 INFO - ##### Running create-virtualenv step. 22:05:52 INFO - ##### 22:05:52 INFO - Running pre-action listener: _resource_record_pre_action 22:05:52 INFO - Running main action method: create_virtualenv 22:05:52 INFO - Creating virtualenv /builds/slave/test/build/venv 22:05:52 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 22:05:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:05:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:05:52 INFO - Using real prefix '/usr' 22:05:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:05:53 INFO - Installing distribute.............................................................................................................................................................................................done. 22:05:55 INFO - Installing pip.................done. 22:05:55 INFO - Return code: 0 22:05:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:05:55 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')]} 22:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:55 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')]} 22:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:55 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 0xf24030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e33b0>, '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 0x11e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4740>, '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': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', '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 22:05:55 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 22:05:55 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 22:05:55 INFO - Using env: {'DISPLAY': ':0', 22:05:55 INFO - 'HOME': '/home/cltbld', 22:05:55 INFO - 'LANG': 'en_US.UTF-8', 22:05:55 INFO - 'LANGUAGE': 'en_US:en', 22:05:55 INFO - 'LOGNAME': 'cltbld', 22:05:55 INFO - 'MAIL': '/var/mail/cltbld', 22:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:55 INFO - 'MOZ_NO_REMOTE': '1', 22:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:55 INFO - 'NO_EM_RESTART': '1', 22:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:55 INFO - 'PWD': '/builds/slave/test', 22:05:55 INFO - 'SHELL': '/bin/bash', 22:05:55 INFO - 'SHLVL': '1', 22:05:55 INFO - 'TERM': 'linux', 22:05:55 INFO - 'TMOUT': '86400', 22:05:55 INFO - 'USER': 'cltbld', 22:05:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', 22:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:55 INFO - '_': '/tools/buildbot/bin/python'} 22:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:55 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 22:05:55 INFO - Cleaning up... 22:05:55 INFO - Return code: 0 22:05:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:05:55 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')]} 22:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:55 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')]} 22:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:55 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 0xf24030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e33b0>, '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 0x11e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4740>, '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': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', '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 22:05:55 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 22:05:55 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 22:05:55 INFO - Using env: {'DISPLAY': ':0', 22:05:55 INFO - 'HOME': '/home/cltbld', 22:05:55 INFO - 'LANG': 'en_US.UTF-8', 22:05:55 INFO - 'LANGUAGE': 'en_US:en', 22:05:55 INFO - 'LOGNAME': 'cltbld', 22:05:55 INFO - 'MAIL': '/var/mail/cltbld', 22:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:55 INFO - 'MOZ_NO_REMOTE': '1', 22:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:55 INFO - 'NO_EM_RESTART': '1', 22:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:55 INFO - 'PWD': '/builds/slave/test', 22:05:55 INFO - 'SHELL': '/bin/bash', 22:05:55 INFO - 'SHLVL': '1', 22:05:55 INFO - 'TERM': 'linux', 22:05:55 INFO - 'TMOUT': '86400', 22:05:55 INFO - 'USER': 'cltbld', 22:05:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', 22:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:55 INFO - '_': '/tools/buildbot/bin/python'} 22:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:55 INFO - Downloading/unpacking psutil>=3.1.1 22:05:55 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 22:05:55 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 22:05:55 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 22:05:55 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 22:05:55 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 22:05:55 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 22:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:05:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:05:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:05:57 INFO - Installing collected packages: psutil 22:05:57 INFO - Running setup.py install for psutil 22:05:57 INFO - building 'psutil._psutil_linux' extension 22:05:57 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 22:05:58 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 22:05:58 INFO - building 'psutil._psutil_posix' extension 22:05:58 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 22:05:58 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 22:05:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:05:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:05:58 INFO - Successfully installed psutil 22:05:58 INFO - Cleaning up... 22:05:58 INFO - Return code: 0 22:05:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:05:58 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')]} 22:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:58 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')]} 22:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:58 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 0xf24030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e33b0>, '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 0x11e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4740>, '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': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', '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 22:05:58 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 22:05:58 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 22:05:58 INFO - Using env: {'DISPLAY': ':0', 22:05:58 INFO - 'HOME': '/home/cltbld', 22:05:58 INFO - 'LANG': 'en_US.UTF-8', 22:05:58 INFO - 'LANGUAGE': 'en_US:en', 22:05:58 INFO - 'LOGNAME': 'cltbld', 22:05:58 INFO - 'MAIL': '/var/mail/cltbld', 22:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:58 INFO - 'MOZ_NO_REMOTE': '1', 22:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:58 INFO - 'NO_EM_RESTART': '1', 22:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:58 INFO - 'PWD': '/builds/slave/test', 22:05:58 INFO - 'SHELL': '/bin/bash', 22:05:58 INFO - 'SHLVL': '1', 22:05:58 INFO - 'TERM': 'linux', 22:05:58 INFO - 'TMOUT': '86400', 22:05:58 INFO - 'USER': 'cltbld', 22:05:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', 22:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:58 INFO - '_': '/tools/buildbot/bin/python'} 22:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:05: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 22:05: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 22:05: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 22:05: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 22:05: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 22:05: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 22:06:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:06:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:06:00 INFO - Installing collected packages: mozsystemmonitor 22:06:00 INFO - Running setup.py install for mozsystemmonitor 22:06:00 INFO - Successfully installed mozsystemmonitor 22:06:00 INFO - Cleaning up... 22:06:00 INFO - Return code: 0 22:06:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:06:00 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')]} 22:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:00 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')]} 22:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:00 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 0xf24030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e33b0>, '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 0x11e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4740>, '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': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', '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 22:06:00 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 22:06:00 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 22:06:00 INFO - Using env: {'DISPLAY': ':0', 22:06:00 INFO - 'HOME': '/home/cltbld', 22:06:00 INFO - 'LANG': 'en_US.UTF-8', 22:06:00 INFO - 'LANGUAGE': 'en_US:en', 22:06:00 INFO - 'LOGNAME': 'cltbld', 22:06:00 INFO - 'MAIL': '/var/mail/cltbld', 22:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:00 INFO - 'MOZ_NO_REMOTE': '1', 22:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:00 INFO - 'NO_EM_RESTART': '1', 22:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:00 INFO - 'PWD': '/builds/slave/test', 22:06:00 INFO - 'SHELL': '/bin/bash', 22:06:00 INFO - 'SHLVL': '1', 22:06:00 INFO - 'TERM': 'linux', 22:06:00 INFO - 'TMOUT': '86400', 22:06:00 INFO - 'USER': 'cltbld', 22:06:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', 22:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:00 INFO - '_': '/tools/buildbot/bin/python'} 22:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:00 INFO - Downloading/unpacking jsonschema==2.5.1 22:06:00 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 22:06:00 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 22:06:00 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 22:06:00 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 22:06:00 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 22:06:00 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 22:06:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:06:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:06:02 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 22:06:02 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 22:06:02 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 22:06:02 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 22:06:02 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 22:06:02 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 22:06:03 INFO - Downloading functools32-3.2.3-2.tar.gz 22:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:06:03 INFO - warning: no files found matching '*.txt' 22:06:03 INFO - no previously-included directories found matching 'build' 22:06:03 INFO - no previously-included directories found matching 'dist' 22:06:03 INFO - no previously-included directories found matching '.git*' 22:06:03 INFO - Installing collected packages: jsonschema, functools32 22:06:03 INFO - Running setup.py install for functools32 22:06:03 INFO - warning: no files found matching '*.txt' 22:06:03 INFO - no previously-included directories found matching 'build' 22:06:03 INFO - no previously-included directories found matching 'dist' 22:06:03 INFO - no previously-included directories found matching '.git*' 22:06:03 INFO - Successfully installed jsonschema functools32 22:06:03 INFO - Cleaning up... 22:06:03 INFO - Return code: 0 22:06:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:06:03 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')]} 22:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:03 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')]} 22:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:03 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 0xf24030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e33b0>, '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 0x11e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4740>, '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': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', '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 22:06:03 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 22:06:03 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 22:06:03 INFO - Using env: {'DISPLAY': ':0', 22:06:03 INFO - 'HOME': '/home/cltbld', 22:06:03 INFO - 'LANG': 'en_US.UTF-8', 22:06:03 INFO - 'LANGUAGE': 'en_US:en', 22:06:03 INFO - 'LOGNAME': 'cltbld', 22:06:03 INFO - 'MAIL': '/var/mail/cltbld', 22:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:03 INFO - 'MOZ_NO_REMOTE': '1', 22:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:03 INFO - 'NO_EM_RESTART': '1', 22:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:03 INFO - 'PWD': '/builds/slave/test', 22:06:03 INFO - 'SHELL': '/bin/bash', 22:06:03 INFO - 'SHLVL': '1', 22:06:03 INFO - 'TERM': 'linux', 22:06:03 INFO - 'TMOUT': '86400', 22:06:03 INFO - 'USER': 'cltbld', 22:06:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', 22:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:03 INFO - '_': '/tools/buildbot/bin/python'} 22:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:03 INFO - Downloading/unpacking blobuploader==1.2.4 22:06:03 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 22:06:03 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 22:06:03 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 22:06:03 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 22:06:03 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 22:06:03 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 22:06:05 INFO - Downloading blobuploader-1.2.4.tar.gz 22:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:06:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:06:05 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 22:06:05 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 22:06:05 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 22:06:05 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 22:06:05 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 22:06:05 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 22:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:06:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:06:05 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 22:06:05 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 22:06:05 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 22:06:05 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 22:06:05 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 22:06:05 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 22:06:06 INFO - Downloading docopt-0.6.1.tar.gz 22:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:06:06 INFO - Installing collected packages: blobuploader, requests, docopt 22:06:06 INFO - Running setup.py install for blobuploader 22:06:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:06:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:06:06 INFO - Running setup.py install for requests 22:06:06 INFO - Running setup.py install for docopt 22:06:06 INFO - Successfully installed blobuploader requests docopt 22:06:06 INFO - Cleaning up... 22:06:06 INFO - Return code: 0 22:06:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:06: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')]} 22:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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')]} 22:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:06 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 0xf24030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e33b0>, '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 0x11e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4740>, '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': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', '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 22:06:06 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 22:06:06 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 22:06:06 INFO - Using env: {'DISPLAY': ':0', 22:06:06 INFO - 'HOME': '/home/cltbld', 22:06:06 INFO - 'LANG': 'en_US.UTF-8', 22:06:06 INFO - 'LANGUAGE': 'en_US:en', 22:06:06 INFO - 'LOGNAME': 'cltbld', 22:06:06 INFO - 'MAIL': '/var/mail/cltbld', 22:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:06 INFO - 'MOZ_NO_REMOTE': '1', 22:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:06 INFO - 'NO_EM_RESTART': '1', 22:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:06 INFO - 'PWD': '/builds/slave/test', 22:06:06 INFO - 'SHELL': '/bin/bash', 22:06:06 INFO - 'SHLVL': '1', 22:06:06 INFO - 'TERM': 'linux', 22:06:06 INFO - 'TMOUT': '86400', 22:06:06 INFO - 'USER': 'cltbld', 22:06:06 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', 22:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:06 INFO - '_': '/tools/buildbot/bin/python'} 22:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:06:07 INFO - Running setup.py (path:/tmp/pip-SoD5i9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:06:07 INFO - Running setup.py (path:/tmp/pip-wNBQBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:06:07 INFO - Running setup.py (path:/tmp/pip-DFgPqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:06:07 INFO - Running setup.py (path:/tmp/pip-0En8s1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:06:07 INFO - Running setup.py (path:/tmp/pip-VAbqe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:06:07 INFO - Running setup.py (path:/tmp/pip-Gu8ySx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:06:07 INFO - Running setup.py (path:/tmp/pip-AiBTsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:06:07 INFO - Running setup.py (path:/tmp/pip-Gl0J90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:06:07 INFO - Running setup.py (path:/tmp/pip-zcjAep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:06:07 INFO - Running setup.py (path:/tmp/pip-Z9WJSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:06:07 INFO - Running setup.py (path:/tmp/pip-Rbbx5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:06:07 INFO - Running setup.py (path:/tmp/pip-hQpLx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:06:07 INFO - Running setup.py (path:/tmp/pip-fIAqHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:06:08 INFO - Running setup.py (path:/tmp/pip-xohleb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:08 INFO - Running setup.py (path:/tmp/pip-xrFVZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:06:08 INFO - Running setup.py (path:/tmp/pip-Mtweca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:06:08 INFO - Running setup.py (path:/tmp/pip-pHmf0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:06:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:06:08 INFO - Running setup.py install for manifestparser 22:06:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:06:08 INFO - Running setup.py install for mozcrash 22:06:08 INFO - Running setup.py install for mozdebug 22:06:08 INFO - Running setup.py install for mozdevice 22:06:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:06:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:06:08 INFO - Running setup.py install for mozfile 22:06:08 INFO - Running setup.py install for mozhttpd 22:06:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:06:08 INFO - Running setup.py install for mozinfo 22:06:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:06:09 INFO - Running setup.py install for mozInstall 22:06:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:06:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:06:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:06:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:06:09 INFO - Running setup.py install for mozleak 22:06:09 INFO - Running setup.py install for mozlog 22:06:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:06:09 INFO - Running setup.py install for moznetwork 22:06:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:06:09 INFO - Running setup.py install for mozprocess 22:06:09 INFO - Running setup.py install for mozprofile 22:06:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:06:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:06:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:06:09 INFO - Running setup.py install for mozrunner 22:06:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:06:09 INFO - Running setup.py install for mozscreenshot 22:06:09 INFO - Running setup.py install for moztest 22:06:09 INFO - Running setup.py install for mozversion 22:06:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:06:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:06:10 INFO - Cleaning up... 22:06:10 INFO - Return code: 0 22:06:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:06: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')]} 22:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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')]} 22:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:10 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 0xf24030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e33b0>, '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 0x11e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4740>, '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': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', '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 22:06:10 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 22:06:10 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 22:06:10 INFO - Using env: {'DISPLAY': ':0', 22:06:10 INFO - 'HOME': '/home/cltbld', 22:06:10 INFO - 'LANG': 'en_US.UTF-8', 22:06:10 INFO - 'LANGUAGE': 'en_US:en', 22:06:10 INFO - 'LOGNAME': 'cltbld', 22:06:10 INFO - 'MAIL': '/var/mail/cltbld', 22:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:10 INFO - 'MOZ_NO_REMOTE': '1', 22:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:10 INFO - 'NO_EM_RESTART': '1', 22:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:10 INFO - 'PWD': '/builds/slave/test', 22:06:10 INFO - 'SHELL': '/bin/bash', 22:06:10 INFO - 'SHLVL': '1', 22:06:10 INFO - 'TERM': 'linux', 22:06:10 INFO - 'TMOUT': '86400', 22:06:10 INFO - 'USER': 'cltbld', 22:06:10 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', 22:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:10 INFO - '_': '/tools/buildbot/bin/python'} 22:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:06:10 INFO - Running setup.py (path:/tmp/pip-3NhA6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:06:10 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)) 22:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:06:10 INFO - Running setup.py (path:/tmp/pip-e_vfaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:06:10 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)) 22:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:06:10 INFO - Running setup.py (path:/tmp/pip-_JQGhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:06:10 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)) 22:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:06:10 INFO - Running setup.py (path:/tmp/pip-IQXBfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:06:10 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)) 22:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:06:10 INFO - Running setup.py (path:/tmp/pip-6sGz_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:06:10 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)) 22:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:06:10 INFO - Running setup.py (path:/tmp/pip-f4zmct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:06:10 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)) 22:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:06:10 INFO - Running setup.py (path:/tmp/pip-nBtoEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:06:10 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)) 22:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:06:10 INFO - Running setup.py (path:/tmp/pip-jf1QwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:06:10 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)) 22:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:06:10 INFO - Running setup.py (path:/tmp/pip-hUBG3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:06:10 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)) 22:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:06:10 INFO - Running setup.py (path:/tmp/pip-t2mnVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:06:11 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)) 22:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:06:11 INFO - Running setup.py (path:/tmp/pip-SLkxYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:06:11 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)) 22:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:06:11 INFO - Running setup.py (path:/tmp/pip-culFtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 22:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:06:11 INFO - Running setup.py (path:/tmp/pip-MeUwgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:06:11 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)) 22:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:06:11 INFO - Running setup.py (path:/tmp/pip-zpCdVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 22:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:11 INFO - Running setup.py (path:/tmp/pip-rQlvoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:11 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)) 22:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:06:11 INFO - Running setup.py (path:/tmp/pip-DCotae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:06:11 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)) 22:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:06:11 INFO - Running setup.py (path:/tmp/pip-uI8KX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:06:11 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)) 22:06:11 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)) 22:06:11 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)) 22:06:11 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)) 22:06:11 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)) 22:06:11 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)) 22:06:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:06:11 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 22:06:11 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 22:06:11 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 22:06:11 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 22:06:11 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 22:06:11 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 22:06:13 INFO - Downloading blessings-1.6.tar.gz 22:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:06:13 INFO - Installing collected packages: blessings 22:06:13 INFO - Running setup.py install for blessings 22:06:13 INFO - Successfully installed blessings 22:06:13 INFO - Cleaning up... 22:06:13 INFO - Return code: 0 22:06:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:06:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:06:13 INFO - Reading from file tmpfile_stdout 22:06:13 INFO - Current package versions: 22:06:13 INFO - argparse == 1.2.1 22:06:13 INFO - blessings == 1.6 22:06:13 INFO - blobuploader == 1.2.4 22:06:13 INFO - docopt == 0.6.1 22:06:13 INFO - functools32 == 3.2.3-2 22:06:13 INFO - jsonschema == 2.5.1 22:06:13 INFO - manifestparser == 1.1 22:06:13 INFO - mozInstall == 1.12 22:06:13 INFO - mozcrash == 0.17 22:06:13 INFO - mozdebug == 0.1 22:06:13 INFO - mozdevice == 0.48 22:06:13 INFO - mozfile == 1.2 22:06:13 INFO - mozhttpd == 0.7 22:06:13 INFO - mozinfo == 0.9 22:06:13 INFO - mozleak == 0.1 22:06:13 INFO - mozlog == 3.2 22:06:13 INFO - moznetwork == 0.27 22:06:13 INFO - mozprocess == 0.22 22:06:13 INFO - mozprofile == 0.28 22:06:13 INFO - mozrunner == 6.11 22:06:13 INFO - mozscreenshot == 0.1 22:06:13 INFO - mozsystemmonitor == 0.3 22:06:13 INFO - moztest == 0.7 22:06:13 INFO - mozversion == 1.4 22:06:13 INFO - psutil == 3.1.1 22:06:13 INFO - requests == 1.2.3 22:06:13 INFO - wsgiref == 0.1.2 22:06:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:13 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 0xf24030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e33b0>, '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 0x11e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4740>, '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': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', '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 22:06:13 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 22:06:13 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 22:06:13 INFO - Using env: {'DISPLAY': ':0', 22:06:13 INFO - 'HOME': '/home/cltbld', 22:06:13 INFO - 'LANG': 'en_US.UTF-8', 22:06:13 INFO - 'LANGUAGE': 'en_US:en', 22:06:13 INFO - 'LOGNAME': 'cltbld', 22:06:13 INFO - 'MAIL': '/var/mail/cltbld', 22:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:13 INFO - 'MOZ_NO_REMOTE': '1', 22:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:13 INFO - 'NO_EM_RESTART': '1', 22:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:13 INFO - 'PWD': '/builds/slave/test', 22:06:13 INFO - 'SHELL': '/bin/bash', 22:06:13 INFO - 'SHLVL': '1', 22:06:13 INFO - 'TERM': 'linux', 22:06:13 INFO - 'TMOUT': '86400', 22:06:13 INFO - 'USER': 'cltbld', 22:06:13 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', 22:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:13 INFO - '_': '/tools/buildbot/bin/python'} 22:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:14 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)) 22:06:14 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)) 22:06:14 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)) 22:06:14 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)) 22:06:14 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)) 22:06:14 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)) 22:06:14 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)) 22:06:14 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)) 22:06:14 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)) 22:06:14 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)) 22:06:14 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)) 22:06:14 INFO - Cleaning up... 22:06:14 INFO - Return code: 0 22:06:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:14 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 0xf24030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e33b0>, '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 0x11e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4740>, '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': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', '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 22:06:14 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 22:06:14 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 22:06:14 INFO - Using env: {'DISPLAY': ':0', 22:06:14 INFO - 'HOME': '/home/cltbld', 22:06:14 INFO - 'LANG': 'en_US.UTF-8', 22:06:14 INFO - 'LANGUAGE': 'en_US:en', 22:06:14 INFO - 'LOGNAME': 'cltbld', 22:06:14 INFO - 'MAIL': '/var/mail/cltbld', 22:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:14 INFO - 'MOZ_NO_REMOTE': '1', 22:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:14 INFO - 'NO_EM_RESTART': '1', 22:06:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:14 INFO - 'PWD': '/builds/slave/test', 22:06:14 INFO - 'SHELL': '/bin/bash', 22:06:14 INFO - 'SHLVL': '1', 22:06:14 INFO - 'TERM': 'linux', 22:06:14 INFO - 'TMOUT': '86400', 22:06:14 INFO - 'USER': 'cltbld', 22:06:14 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', 22:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:14 INFO - '_': '/tools/buildbot/bin/python'} 22:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:06:14 INFO - Cleaning up... 22:06:14 INFO - Return code: 0 22:06:14 INFO - Running post-action listener: _resource_record_post_action 22:06:14 INFO - Running post-action listener: _start_resource_monitoring 22:06:14 INFO - Starting resource monitoring. 22:06:14 INFO - ##### 22:06:14 INFO - ##### Finished create-virtualenv step (success) 22:06:14 INFO - ##### 22:06:14 INFO - ##### 22:06:14 INFO - ##### Running install step. 22:06:14 INFO - ##### 22:06:14 INFO - Running pre-action listener: _resource_record_pre_action 22:06:14 INFO - Running main action method: install 22:06:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:06:14 INFO - Reading from file tmpfile_stdout 22:06:14 INFO - Detecting whether we're running mozinstall >=1.0... 22:06:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:06:14 INFO - Reading from file tmpfile_stdout 22:06:14 INFO - Output received: 22:06:14 INFO - Usage: mozinstall [options] installer 22:06:14 INFO - Options: 22:06:14 INFO - -h, --help show this help message and exit 22:06:14 INFO - -d DEST, --destination=DEST 22:06:14 INFO - Directory to install application into. [default: 22:06:14 INFO - "/builds/slave/test"] 22:06:14 INFO - --app=APP Application being installed. [default: firefox] 22:06:14 INFO - mkdir: /builds/slave/test/build/application 22:06:14 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'] 22:06:14 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 22:06:31 INFO - Reading from file tmpfile_stdout 22:06:31 INFO - Output received: 22:06:31 INFO - /builds/slave/test/build/application/firefox/firefox 22:06:31 INFO - Running post-action listener: _resource_record_post_action 22:06:31 INFO - ##### 22:06:31 INFO - ##### Finished install step (success) 22:06:31 INFO - ##### 22:06:31 INFO - ##### 22:06:31 INFO - ##### Running run-tests step. 22:06:31 INFO - ##### 22:06:31 INFO - Running pre-action listener: _resource_record_pre_action 22:06:31 INFO - Running main action method: run_tests 22:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:06:31 INFO - Python 2.7.3 22:06:31 INFO - Return code: 0 22:06:31 INFO - grabbing minidump binary from tooltool 22:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:31 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 0x11e33b0>, '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 0x11e42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:06:31 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 22:06:31 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 22:06:31 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 22:06:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:06:31 INFO - Return code: 0 22:06:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:06:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:06:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:06:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:06:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 22:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 22:06:31 INFO - Using env: {'DISPLAY': ':0', 22:06:31 INFO - 'HOME': '/home/cltbld', 22:06:31 INFO - 'LANG': 'en_US.UTF-8', 22:06:31 INFO - 'LANGUAGE': 'en_US:en', 22:06:31 INFO - 'LOGNAME': 'cltbld', 22:06:31 INFO - 'MAIL': '/var/mail/cltbld', 22:06:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:06:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:31 INFO - 'MOZ_NO_REMOTE': '1', 22:06:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:31 INFO - 'NO_EM_RESTART': '1', 22:06:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:31 INFO - 'PWD': '/builds/slave/test', 22:06:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:06:31 INFO - 'SHELL': '/bin/bash', 22:06:31 INFO - 'SHLVL': '1', 22:06:31 INFO - 'TERM': 'linux', 22:06:31 INFO - 'TMOUT': '86400', 22:06:31 INFO - 'USER': 'cltbld', 22:06:31 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549', 22:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:31 INFO - '_': '/tools/buildbot/bin/python'} 22:06:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 22:06:32 INFO - mozversion application_buildid: 20160705193024 22:06:32 INFO - mozversion application_changeset: 70e05c6832e831374604ac3ce7433971368dffe0 22:06:32 INFO - mozversion application_display_name: Nightly 22:06:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:06:32 INFO - mozversion application_name: Firefox 22:06:32 INFO - mozversion application_remotingname: firefox 22:06:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:06:32 INFO - mozversion application_vendor: Mozilla 22:06:32 INFO - mozversion application_version: 50.0a1 22:06:32 INFO - mozversion platform_buildid: 20160705193024 22:06:32 INFO - mozversion platform_changeset: 70e05c6832e831374604ac3ce7433971368dffe0 22:06:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:06:32 INFO - mozversion platform_version: 50.0a1 22:06:32 INFO - using testdate: 1467781592 22:06:32 INFO - actual date: 1467781592 22:06:32 INFO - starting webserver on 'localhost:56479' 22:06:32 INFO - SUITE-START | Running 2 tests 22:06:32 INFO - TEST-START | dromaeo_css 22:06:32 INFO - operating with platform_type : linux_ 22:06:32 INFO - Initialising browser for dromaeo_css test... 22:06:32 INFO - TEST-INFO | started process 3801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDfCxBS/profile http://localhost:56479/getInfo.html) 22:06:36 INFO - PROCESS | 3801 | __metrics Screen width/height:1600/1200 22:06:36 INFO - PROCESS | 3801 | colorDepth:24 22:06:36 INFO - PROCESS | 3801 | Browser inner width/height: 1024/697 22:06:36 INFO - PROCESS | 3801 | __metrics 22:06:36 ERROR - PROCESS | 3801 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 22:06:37 INFO - TEST-INFO | 3801: exit 0 22:06:37 INFO - Browser initialized. 22:06:37 INFO - Running cycle 1/1 for dromaeo_css test... 22:06:37 INFO - TEST-INFO | started process 3920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDfCxBS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:06:49 INFO - PROCESS | 3920 | RSS: Main: 168329216 22:06:49 INFO - PROCESS | 3920 | 22:07:39 INFO - PROCESS | 3920 | 1467781659098 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] 22:09:47 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:56479/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56479/tests/dromaeo/cssquery-ext.html) 22:09:48 INFO - PROCESS | 3920 | RSS: Main: 172199936 22:09:48 INFO - PROCESS | 3920 | 22:12:50 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:56479/tests/dromaeo/cssquery-ext.html (next: http://localhost:56479/tests/dromaeo/cssquery-jquery.html) 22:12:50 INFO - PROCESS | 3920 | RSS: Main: 168861696 22:12:50 INFO - PROCESS | 3920 | 22:15:52 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:56479/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56479/tests/dromaeo/cssquery-mootools.html) 22:15:53 INFO - PROCESS | 3920 | RSS: Main: 171995136 22:15:53 INFO - PROCESS | 3920 | 22:18:55 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:56479/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56479/tests/dromaeo/cssquery-prototype.html) 22:18:55 INFO - PROCESS | 3920 | RSS: Main: 167768064 22:18:55 INFO - PROCESS | 3920 | 22:21:58 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:56479/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56479/tests/dromaeo/cssquery-yui.html) 22:21:58 INFO - PROCESS | 3920 | RSS: Main: 169816064 22:21:58 INFO - PROCESS | 3920 | 22:25:01 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:56479/tests/dromaeo/cssquery-yui.html (next: http://localhost:56479/tests/dromaeo/cssquery-dojo.html) 22:25:01 INFO - PROCESS | 3920 | RSS: Main: 170766336 22:25:01 INFO - PROCESS | 3920 | 22:25:01 INFO - PROCESS | 3920 | __start_tp_report 22:25:01 INFO - PROCESS | 3920 | _x_x_mozilla_page_load 22:25:01 INFO - PROCESS | 3920 | _x_x_mozilla_page_load_details 22:25:01 INFO - PROCESS | 3920 | |i|pagename|runs| 22:25:01 INFO - PROCESS | 3920 | |0;dojo.html;3156.652768195498;3199.344134452439;3203.567518385017;3205.79162354447;3235.530848027036;5444;5487.341519017718;5513.3108361454815;5547.972260138704;5560.555155587554;5385.030694474993;5440.782368705257;5520.558355331564;5537.307836520435;5544.0575102232615;4993.850184494471;5019.247112933071;5122.410922743895;5191.610629202825;5229.686218826882;575.667125581566;4906.484819093979;4962.975185124069;5070.31550740649;5140;5020.221865610836;5024.5226703463295;5049.798008079672;5053.949460505403;5083.822066227683;5092.872678183038;5099.821506247264;5107.157319042391;5110.693358398508;5112.539871411591;4962.379702537183;5021.748912554394;5050.974745126287;5070.366204224472;5080.695158290514;5511.751971161268;5515.255440515519;5524.226608274845;5543.390227075019;5617.157426386034;5737.942620573783;5836.328822185461;5950.672713000783;5974.641521508724;5977.731002104916;5931.970340148272;5977.910331345033;5994.640321580676;5999.160117583542;6052.848678783022;5566.443355664401;5607.7476513556985;5611.326640803089;5612.494875461187;5632.436756324376;5914.112883067574;5947.1376650385455;5991.281046274475;6106.145139680449;6107.114468402056;5833.82498525045;5856.414358564195;5859.150423188614;5863.2670916135485;5895.970520147372;5927.851803704942;5929.911051334234;5933.961556727555;5939.13882487037;5944.821655350346;5724.570657200643;5852.824415267549;5876.941230587725;5914.905742437662;5925.555583331267;5936.7922122725495;5967.522598192221;5971.373005834412;5976.9402305977255;5995.970020149872;4513.954860451354;4517.706349087299;4520.52534483881;4521.11838191556;4522.525134860858;3907.96092039076;3953.5651078381356;3970.7419017763755;3992.540857801332;4043.211573743092;5529.949309631157;5544.500994910478;5549.19536667181;5558.249636299129;5619.381867994517;5931.199288096138;5936;5939.168516407706;5940.049592065336;5951;5522.585806064561;5545.500904918576;5644.9839028975175;5654.321481422256;5662.2639056922335;4918.065567542156;4945.530174633404;4956.752162391866;4961.975190124026;4976.726280054631;6149.754009839646;6187.195664563578;6211.751529938842;6227.221597300338;6228.813135605939;5822.388649191774;5889.52883769306;5906.232189815297;5976.820695379146;5993.760249589967;6121.4490695837585;6203.31763506005;6237.4698150657705;6250.156228909221;6251.499880009497;5861.706914654335;5872.500837428866;5899.764009439575;5901.1443340714495;5911.852203694942;5713.8285851424525;5777.653340799566;5777.9133313001175;5806;5915.763369465173;5655.066913959151;5703.001974654336;5712.143178523254;5725;5775.566832487496;5757.596968212185;5759.94240057594;5771.797987070432;5777.104548794943;5791.044477661138;5608.971955140361;5630;5697.601167918372;5724.313082430135;5783.306003279633;5790.884182316414;5806.158107074535;5836.562257830595;5858.9414105860105;5868.706564671835;5537.612367134262;5709.628874123168;5714.571407144564;5715.428457154418;5737.6557406554075 22:25:01 INFO - PROCESS | 3920 | |1;ext.html;580.6254965547222;611.7155522681952;639.1180171363518;640.378832532444;643.6266965160207;42343.36484952724;43519.56480435198;43536;43810.78094609526;47675.28487072688;45573;45849.541504584944;46022.309665354966;46312;46440.76779616105;8679.652813887453;8746.825063498727;8863.11368863115;8875.999999999967;8879.28965682747;8827.602757875911;8970.820583588324;8971.327150463709;8975.95512022439;8978.191962723353;8979.730608081769;9018.954905225464;9028.819423611523;9029.097090290985;9046;8951.283897288235;8988.775280618036;8990.64037438505;8998.68504602339;9002.234810041155;8845.159709827556;8905.332100092453;8912.06423325548;8915.73252802417;8929.464232146092;42873;43387.78306108449;43530.564694352965;43608.3458748119;43649.34525982113;3584.9641503585153;3674.81625918703;3724.366857634209;3778.0932576181517;3924.548676902136;32383;33713.83143084293;33759.831200844084;33851.322973540635;34415.655843441746;4407.140607581523;4420.381146639441;4423.402840616508;4500.09998000398;4551.544845515455;344217;345878;347630;347816.8264110744;351209;55166.448335516936;55233.72383138139;55273;55692.16461753077;55696.72151639297;35693.28613427717;36022.81988590093;36282.637173627925;38108.42837357442;65658;15179.316930738143;15493.380264789283;15532.767008494882;15555.611109722347;15648.217589120499;12649.87350126487;12744.80882786759;12860.807087893689;12946;12961.805572916413;19711.704324435144;19712.60574788525;19720.70418943717;19833.900830496044;19901.203951841766;6906.827329316808;7146.3568278855155;7154.534955227893;7393.186749457555;7411.66647500853;935.9859602105973;1003.0521157506232;1051.5163025008428;1077.9813076642497;1088.6516314779353;32216.19459513531;32273.193170170463;32693.50959735606;32991;33112.675492980496;1073.098597178374;1129.2095533126844;1167.1304877865875;1194.2177873492876;1233.1218318388617;16098.195090245441;16313.10277934725;16315.428959986344;16421.753673694904;16671.583210419838;556941;558914;559074;562915;566601;59578.63792258718;60448.39551604516;60645.69677151586;60857.391426086055;61498.0775288371;1306.7909134538618;1310.6199202231246;1331.8934485241157;1335.7061446481953;1364.2632978191864;30627.2343191422;32064.198395039377;32393.35213295768;32484.18789530186;32940;52073.218901717264;55607.44392556184;56337.15494267507;56612.716936415054;63208.36791632209;477106;478340;482875;484107;484851;44261;44603.776981116185;44910.77544612256;44931.32603011023;45707;48928.51071489239;49124.508754913426;49657.255141173635;49947.25079123889;50510.74744626253;42744.57255427406;43065;43163.78418108015;43346.349804752324;44623.77688111668;42970.35544466773;42984.57015429805;43263.35104973365;43468;43762.78118609387;36188.819055904554;42828.357574637026;44100;44416.55583444254;44611.55388446204;39732.801335993136;44809.775951120035;45155;45636.315455268865;45717.31424028709;34508.30983380369;35363.46954795629;35381.646183537836;35521.82239088891;35532.11169720778 22:25:01 INFO - PROCESS | 3920 | |2;jquery.html;391.24684981410775;396.14432825097794;401.25967589796824;402.4466358756708;419.33326011641503;19034.61930761384;20768.48078798031;20811.375658730245;20867.165313387482;21369.679454808153;19659.213631454724;19947.700784488206;20042.89978550109;20074;20170;5783.624064435809;6015.458608725214;6022.6687532185715;6023.036314189731;6026.819195424145;5357.49103835137;5901.144334071557;5916.437938395867;5942.465178133967;5949.137375080611;5654.858628534278;5684.943150568503;5714.114312281603;5741.081426971686;5748.310202775652;5663.603547751659;5665.631733937302;5729.742161602738;5743.741531631065;5803.187553742479;5533.335999680065;5574.136008918624;5581.665100094007;5600.52395546379;5633.183188437653;23410.531789364286;23502.882485587634;23767.76232237673;23849.88075059631;24189.51620967571;2366.6804981327473;2406.2781165650235;2499.7500249975037;2582.5480540905264;2744.643196384477;9822.361546499526;10013.89986100137;10180.389176649425;10420.478976051243;10481.475926203659;2017.4250338653412;2020.9393718188478;2047.825934795544;2059.7322348094654;2066.8863212523306;85022.57488712517;85421.57289213514;86507;89017;89521;11152.553897844158;11180.273282236629;11471.541138354372;11575.189736718517;11596.362200079077;15708.68582628341;15726.05643661384;15755.212239388215;15786.842131578767;15901.52295431139;8009.3192078673965;8271.586420678943;8363.749087527383;8417.158284171534;8430.747077587683;7858.8428231435055;7904.1700621435075;7955.602219888982;8033.1163572007035;8036.758897233092;4545.227311357077;4607.262837945913;4640;4699.130660827758;4749.95250047502;1854.5270955906158;2035.2062695548748;2035.39955713065;2047.9180832766522;2088.6762551804495;992.1566668332005;999.0627554988456;1000.7898341348252;1007.415698894654;1051.1958351860833;20183.697244541345;20319.492012699506;20623.896880515502;20807.1677132916;21043.894780526;910.6858133943779;1035.8601588785418;1035.9015893490107;1086.6196831109048;1093.2074246171462;10992.340459572451;11167.106631469464;11252.549898003988;11263.098952083814;11296.322220666621;494735;502407;522131;522203;523406;95361.52319238498;97228;98557.50721246348;98600;99409.50295248478;952.8570714392896;969.699393188114;980.6371642492323;997.0527998401548;999.9550020249106;17563;17587;18124.637507249518;18156.818431815514;18503.629927401646;41906;43194.784026079666;43705.997749475064;44694.77652611716;45520.317195241434;57565;58234.4176558229;61872.38127618846;62264;62946;8249.83500330002;8254.83490330202;8300.916990830014;8712.869306960274;8776.692815751418;8316.251537361666;11832.46753896094;12594.370281486072;13682.384292706653;14151.64620884486;11047.944760276469;11282.7743445129;11448.084153267551;11638.65084047446;11843.23019003762;12559;12655.93672031634;12683.682907927006;12863.485460581473;13072.934635327143;11597.826032609686;11846.289222646668;12076.818847717115;12091.274523528617;12108.636740897788;8394.832103358021;8403.537805420761;8444.66221351139;8480.872786908325;8986.730398088068;10638.255322127377;10828.549626696602;11700.824487632523;11845.881541184823;11929.105317101426 22:25:01 INFO - PROCESS | 3920 | |3;mootools.html;1511.7581187010078;1512.3043400035979;1670.7479464762187;1781.750554922312;1798.2896755781467;7943.007124109472;8483.27892129169;8620.956895215531;8763.211310982002;8871.955640221799;8754.86867696985;8898;8949.597268122934;8989.505577193251;9005.054469280713;2292.8280378971563;2297.954040919189;2327.72067351918;2339.4034521197073;2342.7774361435636;2253.6619507073906;2266.3654176830432;2304.043821813945;2308.7114110736156;2312.387217387394;2276.9544609107807;2288.347820871052;2294.4952110535655;2309.7343805462333;2311.7225932888077;2260.16373941641;2267.841251112423;2273.090763694527;2281.942951426211;2284.0749496453964;2283.9885800571055;2289.5878741826464;2291.049214575949;2300.574393737164;2302.228753367607;9056.592453339616;9112.31657625674;9117.22503587196;9118.133777291147;9130.680426185052;5065.366829146356;5079;5148.794048238066;5149.0731668299695;5246.65896716716;3234.91912702182;3263.9673603264137;3313.784604000732;3382.746294027958;3397.065806903097;1120.5741818109148;1138.6242539961875;1154.924929879555;1161.0479406886357;1167.9591214307459;11818.290902545874;11912.702182445422;11953.581624643095;11966.880331196664;11992.04063674904;4342.630876375543;4413.735175889393;4469.173202957463;4533.387992620954;4567.680262381601;10033.598656053822;10094.242931780145;10122.848157277647;10130.341527800669;10133.391996480235;5147.382314122329;5164.948350516522;5165.380154381423;5180.300659411007;5186.974065129726;4241.088166044254;4666.673332866734;4770.165221086296;4803.303520989507;4826.32431459596;3776.3202623527477;3852.24881148179;3929;3935.3506671399473;3970.861019864291;1180.403896032498;1183.46743965216;1186.4423720851187;1189.4647408666135;1198.0774803401507;969.3021024862088;989.124624707125;1018.7402212435782;1024.1908891975256;1028.0593257169605;6235.690504993911;6236.781712640036;6283.560150789493;6321.525885558602;6350.809475715736;437.06250093549795;443.97336159830513;444.42225107360304;448.31631761563875;450.5539515879256;4218.493780746268;4297.269464191095;4312.094460163401;4349.804258808361;4353.390525326457;10654.840177397346;10974.835377469344;10998.175136864607;11004.339739615649;11010.559577616805;10115.595376185018;10804.405757683402;10877.259638457808;10886.61896833607;10925.890741092488;8208.630611622491;8511.489310641382;8530.488170709777;8554.101819308882;8618.267447267053;5753.482186603226;6026.7589296429405;6059.424354686298;6069.939300606938;6200.100985357189;9757.121859032437;10021.699349019542;10048.145907597936;10055.296129271173;10184.694459166238;10041.447720375158;10135.898641013495;10144.949275253577;10155.339902906288;10199.439030853375;6887.035814986006;7569.735059272899;7849.4897831640765;7915.841683166189;8092.433529652868;8865.68970086044;8957.910420895969;8994.190522852712;9001.774955626162;9072.319576031692;7969.282764551218;8150.470219435955;8230.958845205974;8311.418200725891;8400.83198336042;7494.5128566643;7542.396608271435;7595.5442673439775;7719.807004824925;7890.132085470708;6905.102336696398;6940.757073502403;6999.4050505705545;7039.225685174729;7048.471364647775;5328.866778330573;5329.040772660958;5362.302900622894;5402.35171779389;5402.756875940513;5323.840284791462;5425.159100339453;5456.672599644034;5476.890462190813;5501.367342755634 22:25:01 INFO - PROCESS | 3920 | |4;prototype.html;318.6701763674596;321.2498815266353;324.51161002690947;327.4024904549198;327.67560115485674;5650.841577476618;5687.090065589501;5744.25324707788;5748.655080695161;5773.566982476321;5631.915521267184;5632.943670563293;5645.520130788888;5653.519450846673;5686.175504551838;4081.632653061228;4221.556736542665;4372.97813510932;4387.166438376714;4389.9561004390025;4335.393044973706;4345;4348.4999225089205;4349.391085248068;4377.321515165155;4360.912781744363;4367.388565600819;4369.410129632507;4376.102898905732;4397.61475135333;4324.178406102862;4325.178216138924;4349.717268377545;4356.6514678825615;4391.6486681065435;3830.4062870255157;3833.17586718854;3845.769253844778;3851.306764782338;3860.6911447084167;5510.476504732044;5524.254225679522;5541.806036788734;5550.778828657729;5559.8888022239325;4855.344528488679;4971.801127954877;4990.201567749143;5008.323876276692;5027.924581131286;5925.555583331225;5926.733297001602;5929.288485381781;5938.257717785277;5944.405559444064;4210.136921931027;4254.808533615995;4259.148170365908;4260.25445547028;4264.402983582301;6029.763898400817;6039.909401358983;6098.969505152446;6136.294326152505;6173.444390004921;4232.492100947906;4236.322188449833;4268.125034367947;4306.5262821089655;4317.352397140454;4333.371661109121;4354.716943398669;4357.891052723708;4361.171377438277;4363.47638283408;4897.7795999180125;4969.875753106201;4980.7509624518625;5005.174146265898;5018.824341148043;5944.881102377928;5960.910586341209;5981.102834574848;6045.667488288186;6063.787767428207;1485.2944851195596;1495.28973737476;1500.7748837674217;1503.59413947959;1521.3078049487456;950.4249928792981;952.8142012307673;972.6887396033202;993.7813680990171;1030.6341248856697;5669.829905102853;5683.403242659544;5702.258706368146;5744.971275143597;5775.942240577624;5987.700614969234;6027.336992930774;6033.577649564489;6090.969545152335;6108.205933228741;5535.723213839292;5657.886842263214;5732.684702341411;5743.310802703702;5745.971270143623;3230.578545439999;3248.187953011747;3254.267789747288;3255;3257.9674203257664;6108.480779133734;6238.220222472191;6294.65379404128;6308.558400911892;6325.841853953596;6074.845779301919;6145.078238264206;6181.876362472725;6193.473554747897;6201.7519299228425;5989.401059893976;6185.659788711574;6227.408396202444;6316.810495685045;6319.6208227506495;5995.91006134917;6013.278406591237;6034.2155519782145;6070.666113363807;6082.2093127893095;5976.133460648269;6001.639901605918;6012.226393213925;6023.728932197974;6037.607555508878;6118.510519158545;6306.180196574416;6402;6412.487001039813;6440.6135631862235;4257.510386305491;4273.658107351466;4297.882550536945;4299.634531064769;4312.792418122931;5834.591578589458;6124.142620033288;6141;6181.81454556364;6201.906971395523;5926.170336153028;5930.584859059824;5973.417044483303;5982.730777115127;6001.219841420588;5894.263217097863;5903.970480147744;5914.674692891932;5931.3772053935445;6029.186059881859;5691.943080569141;5856.472917437451;5866.178734977192;5904.261967254093;5912.763489460545;5945.186718051036;6004.189434426296;6050.425209605257;6050.757969681339;6064.818055458343;5679.438154507544;5882.058970514742;5900.852478688067;5902.026165682614;5912.320083190488 22:25:01 INFO - PROCESS | 3920 | |5;yui.html;757.7385801898347;779.6803310642638;797.3581267080001;812.4556547113433;901.7249738829656;15776;16126.677466450665;16497.17514124295;16515;16612.086335251555;13809.792853107212;15013.399464021426;15101.093934363946;15105.848941510609;15140.015898966587;668.6422763821356;804.8470790549806;810.2100452059254;811.0267678785451;815.7797394703456;811.4563242627424;829.1376967953321;833.1876420490004;835.0855812884881;837.1753822484848;864.2006144316514;868.4355169140077;868.7958329792493;870.8954925408959;871.9782005449852;859.4800145911696;865.1002956924791;867.9349048821332;868.053821334745;869.1091631078132;632.5730132160819;633.9936600633981;634.1597383466925;635.139386131794;635.2059925093633;15289.082655040622;15366.462173823862;15392.076475411512;15401.22993850303;15403.306851191723;15804.841951580453;15932.522024339289;15966;16144.59638509035;16241.593960150973;12156.635300940987;12165.878341216563;12187.878121218851;12417.317047562381;12725.809112863315;3937.251922134785;3995.440638310639;4000.6799456043445;4047.251258517184;4071.42999980003;67014.3298567013;69308.99999999949;69976.6501167496;75398;75720.62139689321;11698.410574363885;12162.270263784201;12211.267323960414;12221.694457638452;12340.691482712824;21677;21957.890210549165;21978.340649780213;22012.449688757908;22060.88969555174;8912.55437228136;9064.138906803842;9081.81836363269;9108.499032553273;9289.535523223813;4998.800047998039;5015.097282489187;5055.974720126449;5060.924086138711;5133.5379815816;3466.30673865228;3535.116220944764;3551.2542366103407;3557.0751604582993;3565.1978304881713;616.9907451388233;617.1206031405229;619.5632079384023;630.5397060146119;641.8042497038355;684.4114061906756;763.5304287862924;764.3503022431;777.1218523068897;784.9921500785033;9935.602575897028;10031.749206269902;10343.482825858828;10451.985847411112;10969.561217551209;682.7712716240115;722.8265216348038;735.9632018399059;755.6662490703912;763.9388848892075;4751.976240118777;4775.785089670973;4937.481564435754;4957.355543779286;4972.428170760337;106580;118504.40747796206;121765;122234;122257;73718;98261.50869245607;98288;98725;99812;54738.90522189534;90543.54728226448;90616;90720.38156375133;91588.54205728929;9190.954045229999;9205.171534561921;9357.251419886528;9403.81192376135;9498.620055197714;52813;53721;53905.46094539161;54693.453065468835;55154;50977.74511127569;75460;75685.62157189178;75776;76805.23194767981;11893.226940248856;11902.226355286879;12345.298107498786;12467.5012999479;12745.17156384832;14143.222122782934;14241.857581424054;14328.570142895729;14497.275136242935;14932.328045237773;13525.391357388744;13545.255010974492;13776.65558361049;13777.517786877412;14355.56933292003;12781.61655150347;12861.2926289055;13023;13335.66660833487;13589.456421743414;12698.555550555686;14210.573682789533;14368.784468233194;14554.563363099123;14733.705325893636;11679.416029198675;11906.880931190924;12099.274043557414;12427.93786031064;12452.688682783002;12166.837424087344;12895.935520322713;12913.677158071123;12917.160384574972;13076.869231307564 22:25:01 INFO - PROCESS | 3920 | __end_tp_report 22:25:01 INFO - PROCESS | 3920 | __start_cc_report 22:25:01 INFO - PROCESS | 3920 | _x_x_mozilla_cycle_collect,364 22:25:01 INFO - PROCESS | 3920 | __end_cc_report 22:25:01 INFO - PROCESS | 3920 | __startTimestamp1467782701626__endTimestamp 22:25:01 INFO - PROCESS | 3920 | 22:25:01 INFO - PROCESS | 3920 | ------- Summary: start ------- 22:25:01 INFO - PROCESS | 3920 | Number of tests: 6 22:25:01 INFO - PROCESS | 3920 | 22:25:01 INFO - PROCESS | 3920 | [#0] dojo.html Cycles:165 Average:5471.52 Median:5713.83 stddev:740.00 (13.0%) stddev-sans-first:719.64 22:25:01 INFO - PROCESS | 3920 | Values: 3156.7 3199.3 3203.6 3205.8 3235.5 5444.0 5487.3 5513.3 5548.0 5560.6 5385.0 5440.8 5520.6 5537.3 5544.1 4993.9 5019.2 5122.4 5191.6 5229.7 575.7 4906.5 4963.0 5070.3 5140.0 5020.2 5024.5 5049.8 5053.9 5083.8 5092.9 5099.8 5107.2 5110.7 5112.5 4962.4 5021.7 5051.0 5070.4 5080.7 5511.8 5515.3 5524.2 5543.4 5617.2 5737.9 5836.3 5950.7 5974.6 5977.7 5932.0 5977.9 5994.6 5999.2 6052.8 5566.4 5607.7 5611.3 5612.5 5632.4 5914.1 5947.1 5991.3 6106.1 6107.1 5833.8 5856.4 5859.2 5863.3 5896.0 5927.9 5929.9 5934.0 5939.1 5944.8 5724.6 5852.8 5876.9 5914.9 5925.6 5936.8 5967.5 5971.4 5976.9 5996.0 4514.0 4517.7 4520.5 4521.1 4522.5 3908.0 3953.6 3970.7 3992.5 4043.2 5529.9 5544.5 5549.2 5558.2 5619.4 5931.2 5936.0 5939.2 5940.0 5951.0 5522.6 5545.5 5645.0 5654.3 5662.3 4918.1 4945.5 4956.8 4962.0 4976.7 6149.8 6187.2 6211.8 6227.2 6228.8 5822.4 5889.5 5906.2 5976.8 5993.8 6121.4 6203.3 6237.5 6250.2 6251.5 5861.7 5872.5 5899.8 5901.1 5911.9 5713.8 5777.7 5777.9 5806.0 5915.8 5655.1 5703.0 5712.1 5725.0 5775.6 5757.6 5759.9 5771.8 5777.1 5791.0 5609.0 5630.0 5697.6 5724.3 5783.3 5790.9 5806.2 5836.6 5858.9 5868.7 5537.6 5709.6 5714.6 5715.4 5737.7 22:25:01 INFO - PROCESS | 3920 | 22:25:01 INFO - PROCESS | 3920 | [#1] ext.html Cycles:180 Average:63016.68 Median:24260.19 stddev:125071.54 (515.5%) stddev-sans-first:125334.55 22:25:01 INFO - PROCESS | 3920 | Values: 580.6 611.7 639.1 640.4 643.6 42343.4 43519.6 43536.0 43810.8 47675.3 45573.0 45849.5 46022.3 46312.0 46440.8 8679.7 8746.8 8863.1 8876.0 8879.3 8827.6 8970.8 8971.3 8976.0 8978.2 8979.7 9019.0 9028.8 9029.1 9046.0 8951.3 8988.8 8990.6 8998.7 9002.2 8845.2 8905.3 8912.1 8915.7 8929.5 42873.0 43387.8 43530.6 43608.3 43649.3 3585.0 3674.8 3724.4 3778.1 3924.5 32383.0 33713.8 33759.8 33851.3 34415.7 4407.1 4420.4 4423.4 4500.1 4551.5 344217.0 345878.0 347630.0 347816.8 351209.0 55166.4 55233.7 55273.0 55692.2 55696.7 35693.3 36022.8 36282.6 38108.4 65658.0 15179.3 15493.4 15532.8 15555.6 15648.2 12649.9 12744.8 12860.8 12946.0 12961.8 19711.7 19712.6 19720.7 19833.9 19901.2 6906.8 7146.4 7154.5 7393.2 7411.7 936.0 1003.1 1051.5 1078.0 1088.7 32216.2 32273.2 32693.5 32991.0 33112.7 1073.1 1129.2 1167.1 1194.2 1233.1 16098.2 16313.1 16315.4 16421.8 16671.6 556941.0 558914.0 559074.0 562915.0 566601.0 59578.6 60448.4 60645.7 60857.4 61498.1 1306.8 1310.6 1331.9 1335.7 1364.3 30627.2 32064.2 32393.4 32484.2 32940.0 52073.2 55607.4 56337.2 56612.7 63208.4 477106.0 478340.0 482875.0 484107.0 484851.0 44261.0 44603.8 44910.8 44931.3 45707.0 48928.5 49124.5 49657.3 49947.3 50510.7 42744.6 43065.0 43163.8 43346.3 44623.8 42970.4 42984.6 43263.4 43468.0 43762.8 36188.8 42828.4 44100.0 44416.6 44611.6 39732.8 44809.8 45155.0 45636.3 45717.3 34508.3 35363.5 35381.6 35521.8 35532.1 22:25:01 INFO - PROCESS | 3920 | 22:25:01 INFO - PROCESS | 3920 | [#2] jquery.html Cycles:180 Average:30280.15 Median:393.70 stddev:84724.57 (21520.3%) stddev-sans-first:84932.52 22:25:01 INFO - PROCESS | 3920 | Values: 391.2 396.1 401.3 402.4 419.3 19034.6 20768.5 20811.4 20867.2 21369.7 19659.2 19947.7 20042.9 20074.0 20170.0 5783.6 6015.5 6022.7 6023.0 6026.8 5357.5 5901.1 5916.4 5942.5 5949.1 5654.9 5684.9 5714.1 5741.1 5748.3 5663.6 5665.6 5729.7 5743.7 5803.2 5533.3 5574.1 5581.7 5600.5 5633.2 23410.5 23502.9 23767.8 23849.9 24189.5 2366.7 2406.3 2499.8 2582.5 2744.6 9822.4 10013.9 10180.4 10420.5 10481.5 2017.4 2020.9 2047.8 2059.7 2066.9 85022.6 85421.6 86507.0 89017.0 89521.0 11152.6 11180.3 11471.5 11575.2 11596.4 15708.7 15726.1 15755.2 15786.8 15901.5 8009.3 8271.6 8363.7 8417.2 8430.7 7858.8 7904.2 7955.6 8033.1 8036.8 4545.2 4607.3 4640.0 4699.1 4750.0 1854.5 2035.2 2035.4 2047.9 2088.7 992.2 999.1 1000.8 1007.4 1051.2 20183.7 20319.5 20623.9 20807.2 21043.9 910.7 1035.9 1035.9 1086.6 1093.2 10992.3 11167.1 11252.5 11263.1 11296.3 494735.0 502407.0 522131.0 522203.0 523406.0 95361.5 97228.0 98557.5 98600.0 99409.5 952.9 969.7 980.6 997.1 1000.0 17563.0 17587.0 18124.6 18156.8 18503.6 41906.0 43194.8 43706.0 44694.8 45520.3 57565.0 58234.4 61872.4 62264.0 62946.0 8249.8 8254.8 8300.9 8712.9 8776.7 8316.3 11832.5 12594.4 13682.4 14151.6 11047.9 11282.8 11448.1 11638.7 11843.2 12559.0 12655.9 12683.7 12863.5 13072.9 11597.8 11846.3 12076.8 12091.3 12108.6 8394.8 8403.5 8444.7 8480.9 8986.7 10638.3 10828.5 11700.8 11845.9 11929.1 22:25:01 INFO - PROCESS | 3920 | 22:25:01 INFO - PROCESS | 3920 | [#3] mootools.html Cycles:180 Average:5815.06 Median:2428.85 stddev:3313.62 (136.4%) stddev-sans-first:3307.13 22:25:01 INFO - PROCESS | 3920 | Values: 1511.8 1512.3 1670.7 1781.8 1798.3 7943.0 8483.3 8621.0 8763.2 8872.0 8754.9 8898.0 8949.6 8989.5 9005.1 2292.8 2298.0 2327.7 2339.4 2342.8 2253.7 2266.4 2304.0 2308.7 2312.4 2277.0 2288.3 2294.5 2309.7 2311.7 2260.2 2267.8 2273.1 2281.9 2284.1 2284.0 2289.6 2291.0 2300.6 2302.2 9056.6 9112.3 9117.2 9118.1 9130.7 5065.4 5079.0 5148.8 5149.1 5246.7 3234.9 3264.0 3313.8 3382.7 3397.1 1120.6 1138.6 1154.9 1161.0 1168.0 11818.3 11912.7 11953.6 11966.9 11992.0 4342.6 4413.7 4469.2 4533.4 4567.7 10033.6 10094.2 10122.8 10130.3 10133.4 5147.4 5164.9 5165.4 5180.3 5187.0 4241.1 4666.7 4770.2 4803.3 4826.3 3776.3 3852.2 3929.0 3935.4 3970.9 1180.4 1183.5 1186.4 1189.5 1198.1 969.3 989.1 1018.7 1024.2 1028.1 6235.7 6236.8 6283.6 6321.5 6350.8 437.1 444.0 444.4 448.3 450.6 4218.5 4297.3 4312.1 4349.8 4353.4 10654.8 10974.8 10998.2 11004.3 11010.6 10115.6 10804.4 10877.3 10886.6 10925.9 8208.6 8511.5 8530.5 8554.1 8618.3 5753.5 6026.8 6059.4 6069.9 6200.1 9757.1 10021.7 10048.1 10055.3 10184.7 10041.4 10135.9 10144.9 10155.3 10199.4 6887.0 7569.7 7849.5 7915.8 8092.4 8865.7 8957.9 8994.2 9001.8 9072.3 7969.3 8150.5 8231.0 8311.4 8400.8 7494.5 7542.4 7595.5 7719.8 7890.1 6905.1 6940.8 6999.4 7039.2 7048.5 5328.9 5329.0 5362.3 5402.4 5402.8 5323.8 5425.2 5456.7 5476.9 5501.4 22:25:01 INFO - PROCESS | 3920 | 22:25:01 INFO - PROCESS | 3920 | [#4] prototype.html Cycles:180 Average:4985.68 Median:5738.00 stddev:1482.47 (25.8%) stddev-sans-first:1444.65 22:25:01 INFO - PROCESS | 3920 | Values: 318.7 321.2 324.5 327.4 327.7 5650.8 5687.1 5744.3 5748.7 5773.6 5631.9 5632.9 5645.5 5653.5 5686.2 4081.6 4221.6 4373.0 4387.2 4390.0 4335.4 4345.0 4348.5 4349.4 4377.3 4360.9 4367.4 4369.4 4376.1 4397.6 4324.2 4325.2 4349.7 4356.7 4391.6 3830.4 3833.2 3845.8 3851.3 3860.7 5510.5 5524.3 5541.8 5550.8 5559.9 4855.3 4971.8 4990.2 5008.3 5027.9 5925.6 5926.7 5929.3 5938.3 5944.4 4210.1 4254.8 4259.1 4260.3 4264.4 6029.8 6039.9 6099.0 6136.3 6173.4 4232.5 4236.3 4268.1 4306.5 4317.4 4333.4 4354.7 4357.9 4361.2 4363.5 4897.8 4969.9 4980.8 5005.2 5018.8 5944.9 5960.9 5981.1 6045.7 6063.8 1485.3 1495.3 1500.8 1503.6 1521.3 950.4 952.8 972.7 993.8 1030.6 5669.8 5683.4 5702.3 5745.0 5775.9 5987.7 6027.3 6033.6 6091.0 6108.2 5535.7 5657.9 5732.7 5743.3 5746.0 3230.6 3248.2 3254.3 3255.0 3258.0 6108.5 6238.2 6294.7 6308.6 6325.8 6074.8 6145.1 6181.9 6193.5 6201.8 5989.4 6185.7 6227.4 6316.8 6319.6 5995.9 6013.3 6034.2 6070.7 6082.2 5976.1 6001.6 6012.2 6023.7 6037.6 6118.5 6306.2 6402.0 6412.5 6440.6 4257.5 4273.7 4297.9 4299.6 4312.8 5834.6 6124.1 6141.0 6181.8 6201.9 5926.2 5930.6 5973.4 5982.7 6001.2 5894.3 5904.0 5914.7 5931.4 6029.2 5691.9 5856.5 5866.2 5904.3 5912.8 5945.2 6004.2 6050.4 6050.8 6064.8 5679.4 5882.1 5900.9 5902.0 5912.3 22:25:01 INFO - PROCESS | 3920 | 22:25:01 INFO - PROCESS | 3920 | [#5] yui.html Cycles:180 Average:20746.05 Median:4856.63 stddev:29499.93 (607.4%) stddev-sans-first:29544.51 22:25:01 INFO - PROCESS | 3920 | Values: 757.7 779.7 797.4 812.5 901.7 15776.0 16126.7 16497.2 16515.0 16612.1 13809.8 15013.4 15101.1 15105.8 15140.0 668.6 804.8 810.2 811.0 815.8 811.5 829.1 833.2 835.1 837.2 864.2 868.4 868.8 870.9 872.0 859.5 865.1 867.9 868.1 869.1 632.6 634.0 634.2 635.1 635.2 15289.1 15366.5 15392.1 15401.2 15403.3 15804.8 15932.5 15966.0 16144.6 16241.6 12156.6 12165.9 12187.9 12417.3 12725.8 3937.3 3995.4 4000.7 4047.3 4071.4 67014.3 69309.0 69976.7 75398.0 75720.6 11698.4 12162.3 12211.3 12221.7 12340.7 21677.0 21957.9 21978.3 22012.4 22060.9 8912.6 9064.1 9081.8 9108.5 9289.5 4998.8 5015.1 5056.0 5060.9 5133.5 3466.3 3535.1 3551.3 3557.1 3565.2 617.0 617.1 619.6 630.5 641.8 684.4 763.5 764.4 777.1 785.0 9935.6 10031.7 10343.5 10452.0 10969.6 682.8 722.8 736.0 755.7 763.9 4752.0 4775.8 4937.5 4957.4 4972.4 106580.0 118504.4 121765.0 122234.0 122257.0 73718.0 98261.5 98288.0 98725.0 99812.0 54738.9 90543.5 90616.0 90720.4 91588.5 9191.0 9205.2 9357.3 9403.8 9498.6 52813.0 53721.0 53905.5 54693.5 55154.0 50977.7 75460.0 75685.6 75776.0 76805.2 11893.2 11902.2 12345.3 12467.5 12745.2 14143.2 14241.9 14328.6 14497.3 14932.3 13525.4 13545.3 13776.7 13777.5 14355.6 12781.6 12861.3 13023.0 13335.7 13589.5 12698.6 14210.6 14368.8 14554.6 14733.7 11679.4 11906.9 12099.3 12427.9 12452.7 12166.8 12895.9 12913.7 12917.2 13076.9 22:25:01 INFO - PROCESS | 3920 | -------- Summary: end -------- 22:25:01 INFO - PROCESS | 3920 | 22:25:02 INFO - TEST-INFO | 3920: exit 0 22:25:02 INFO - TEST-OK | dromaeo_css | took 1110335ms 22:25:02 INFO - TEST-START | kraken 22:25:02 INFO - operating with platform_type : linux_ 22:25:02 INFO - Initialising browser for kraken test... 22:25:02 INFO - TEST-INFO | started process 4179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIBN8PM/profile http://localhost:56479/getInfo.html) 22:25:06 INFO - PROCESS | 4179 | __metrics Screen width/height:1600/1200 22:25:06 INFO - PROCESS | 4179 | colorDepth:24 22:25:06 INFO - PROCESS | 4179 | Browser inner width/height: 1024/697 22:25:06 INFO - PROCESS | 4179 | __metrics 22:25:07 ERROR - PROCESS | 4179 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 22:25:07 INFO - TEST-INFO | 4179: exit 0 22:25:07 INFO - Browser initialized. 22:25:07 INFO - Running cycle 1/1 for kraken test... 22:25:07 INFO - TEST-INFO | started process 4300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIBN8PM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:25:19 INFO - PROCESS | 4300 | RSS: Main: 168611840 22:25:19 INFO - PROCESS | 4300 | 22:25:22 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:56479/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56479/tests/kraken/driver.html?testName=audio-beat-detection) 22:25:23 INFO - PROCESS | 4300 | RSS: Main: 174198784 22:25:23 INFO - PROCESS | 4300 | 22:25:25 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:56479/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56479/tests/kraken/driver.html?testName=audio-dft) 22:25:26 INFO - PROCESS | 4300 | RSS: Main: 173408256 22:25:26 INFO - PROCESS | 4300 | 22:25:29 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:56479/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56479/tests/kraken/driver.html?testName=audio-fft) 22:25:29 INFO - PROCESS | 4300 | RSS: Main: 167907328 22:25:29 INFO - PROCESS | 4300 | 22:25:32 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:56479/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56479/tests/kraken/driver.html?testName=audio-oscillator) 22:25:32 INFO - PROCESS | 4300 | RSS: Main: 168898560 22:25:32 INFO - PROCESS | 4300 | 22:25:34 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:56479/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56479/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:25:35 INFO - PROCESS | 4300 | RSS: Main: 169381888 22:25:35 INFO - PROCESS | 4300 | 22:25:38 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:56479/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56479/tests/kraken/driver.html?testName=imaging-darkroom) 22:25:39 INFO - PROCESS | 4300 | RSS: Main: 168611840 22:25:39 INFO - PROCESS | 4300 | 22:25:42 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:56479/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56479/tests/kraken/driver.html?testName=imaging-desaturate) 22:25:43 INFO - PROCESS | 4300 | RSS: Main: 167460864 22:25:43 INFO - PROCESS | 4300 | 22:25:46 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:56479/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56479/tests/kraken/driver.html?testName=json-parse-financial) 22:25:46 INFO - PROCESS | 4300 | RSS: Main: 168407040 22:25:46 INFO - PROCESS | 4300 | 22:25:48 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:56479/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56479/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:25:48 INFO - PROCESS | 4300 | RSS: Main: 168730624 22:25:48 INFO - PROCESS | 4300 | 22:25:50 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:56479/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56479/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:25:51 INFO - PROCESS | 4300 | RSS: Main: 169242624 22:25:51 INFO - PROCESS | 4300 | 22:25:53 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:56479/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56479/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:25:54 INFO - PROCESS | 4300 | RSS: Main: 169488384 22:25:54 INFO - PROCESS | 4300 | 22:25:56 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:56479/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:25:57 INFO - PROCESS | 4300 | RSS: Main: 169832448 22:25:57 INFO - PROCESS | 4300 | 22:26:00 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:56479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:26:00 INFO - PROCESS | 4300 | RSS: Main: 169455616 22:26:00 INFO - PROCESS | 4300 | 22:26:02 INFO - PROCESS | 4300 | Cycle 1(1): loaded http://localhost:56479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56479/tests/kraken/driver.html?testName=ai-astar) 22:26:02 INFO - PROCESS | 4300 | RSS: Main: 170131456 22:26:02 INFO - PROCESS | 4300 | 22:26:02 INFO - PROCESS | 4300 | __start_tp_report 22:26:02 INFO - PROCESS | 4300 | _x_x_mozilla_page_load 22:26:02 INFO - PROCESS | 4300 | _x_x_mozilla_page_load_details 22:26:02 INFO - PROCESS | 4300 | |i|pagename|runs| 22:26:02 INFO - PROCESS | 4300 | |0;ai-astar;102;110;104;111;110;112;113;114;110;110 22:26:02 INFO - PROCESS | 4300 | |1;audio-beat-detection;152;123;149;184;120;150;146;121;177;119 22:26:02 INFO - PROCESS | 4300 | |2;audio-dft;162;167;163;162;163;165;172;165;163;162 22:26:02 INFO - PROCESS | 4300 | |3;audio-fft;76;75;77;169;76;77;75;77;157;75 22:26:02 INFO - PROCESS | 4300 | |4;audio-oscillator;84;84;151;85;85;84;138;84;84;134 22:26:02 INFO - PROCESS | 4300 | |5;imaging-gaussian-blur;118;118;118;117;118;117;117;117;118;118 22:26:02 INFO - PROCESS | 4300 | |6;imaging-darkroom;147;148;147;148;147;148;147;146;148;147 22:26:02 INFO - PROCESS | 4300 | |7;imaging-desaturate;95;95;97;96;95;95;95;97;96;96 22:26:02 INFO - PROCESS | 4300 | |8;json-parse-financial;54;59;54;55;57;58;54;53;61;55 22:26:02 INFO - PROCESS | 4300 | |9;json-stringify-tinderbox;61;61;61;61;61;60;60;61;61;62 22:26:02 INFO - PROCESS | 4300 | |10;stanford-crypto-aes;74;75;74;75;75;77;75;76;76;75 22:26:02 INFO - PROCESS | 4300 | |11;stanford-crypto-ccm;120;118;122;139;121;121;130;135;183;122 22:26:02 INFO - PROCESS | 4300 | |12;stanford-crypto-pbkdf2;165;164;155;163;158;164;157;157;160;162 22:26:02 INFO - PROCESS | 4300 | |13;stanford-crypto-sha256-iterative;63;65;63;65;64;64;61;64;62;68 22:26:02 INFO - PROCESS | 4300 | __end_tp_report 22:26:02 INFO - PROCESS | 4300 | __start_cc_report 22:26:02 INFO - PROCESS | 4300 | _x_x_mozilla_cycle_collect,912 22:26:02 INFO - PROCESS | 4300 | __end_cc_report 22:26:02 INFO - PROCESS | 4300 | __startTimestamp1467782762587__endTimestamp 22:26:02 INFO - PROCESS | 4300 | 22:26:02 INFO - PROCESS | 4300 | ------- Summary: start ------- 22:26:02 INFO - PROCESS | 4300 | Number of tests: 14 22:26:02 INFO - PROCESS | 4300 | 22:26:02 INFO - PROCESS | 4300 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:3.78 (3.4%) stddev-sans-first:2.83 22:26:02 INFO - PROCESS | 4300 | Values: 102.0 110.0 104.0 111.0 110.0 112.0 113.0 114.0 110.0 110.0 22:26:02 INFO - PROCESS | 4300 | 22:26:02 INFO - PROCESS | 4300 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:149.50 stddev:23.54 (15.7%) stddev-sans-first:24.80 22:26:02 INFO - PROCESS | 4300 | Values: 152.0 123.0 149.0 184.0 120.0 150.0 146.0 121.0 177.0 119.0 22:26:02 INFO - PROCESS | 4300 | 22:26:02 INFO - PROCESS | 4300 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:3.13 (1.9%) stddev-sans-first:3.20 22:26:02 INFO - PROCESS | 4300 | Values: 162.0 167.0 163.0 162.0 163.0 165.0 172.0 165.0 163.0 162.0 22:26:02 INFO - PROCESS | 4300 | 22:26:02 INFO - PROCESS | 4300 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:36.80 (48.4%) stddev-sans-first:38.49 22:26:02 INFO - PROCESS | 4300 | Values: 76.0 75.0 77.0 169.0 76.0 77.0 75.0 77.0 157.0 75.0 22:26:02 INFO - PROCESS | 4300 | 22:26:02 INFO - PROCESS | 4300 | [#4] audio-oscillator Cycles:10 Average:101.30 Median:84.00 stddev:27.72 (33.0%) stddev-sans-first:28.68 22:26:02 INFO - PROCESS | 4300 | Values: 84.0 84.0 151.0 85.0 85.0 84.0 138.0 84.0 84.0 134.0 22:26:02 INFO - PROCESS | 4300 | 22:26:02 INFO - PROCESS | 4300 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:26:02 INFO - PROCESS | 4300 | Values: 118.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 22:26:02 INFO - PROCESS | 4300 | 22:26:02 INFO - PROCESS | 4300 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 22:26:02 INFO - PROCESS | 4300 | Values: 147.0 148.0 147.0 148.0 147.0 148.0 147.0 146.0 148.0 147.0 22:26:02 INFO - PROCESS | 4300 | 22:26:02 INFO - PROCESS | 4300 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 22:26:02 INFO - PROCESS | 4300 | Values: 95.0 95.0 97.0 96.0 95.0 95.0 95.0 97.0 96.0 96.0 22:26:02 INFO - PROCESS | 4300 | 22:26:02 INFO - PROCESS | 4300 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:2.62 (4.7%) stddev-sans-first:2.68 22:26:02 INFO - PROCESS | 4300 | Values: 54.0 59.0 54.0 55.0 57.0 58.0 54.0 53.0 61.0 55.0 22:26:02 INFO - PROCESS | 4300 | 22:26:02 INFO - PROCESS | 4300 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 22:26:02 INFO - PROCESS | 4300 | Values: 61.0 61.0 61.0 61.0 61.0 60.0 60.0 61.0 61.0 62.0 22:26:02 INFO - PROCESS | 4300 | 22:26:02 INFO - PROCESS | 4300 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:0.92 (1.2%) stddev-sans-first:0.87 22:26:02 INFO - PROCESS | 4300 | Values: 74.0 75.0 74.0 75.0 75.0 77.0 75.0 76.0 76.0 75.0 22:26:02 INFO - PROCESS | 4300 | 22:26:02 INFO - PROCESS | 4300 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:126.00 stddev:19.54 (15.5%) stddev-sans-first:20.31 22:26:02 INFO - PROCESS | 4300 | Values: 120.0 118.0 122.0 139.0 121.0 121.0 130.0 135.0 183.0 122.0 22:26:02 INFO - PROCESS | 4300 | 22:26:02 INFO - PROCESS | 4300 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:162.50 stddev:3.57 (2.2%) stddev-sans-first:3.39 22:26:02 INFO - PROCESS | 4300 | Values: 165.0 164.0 155.0 163.0 158.0 164.0 157.0 157.0 160.0 162.0 22:26:02 INFO - PROCESS | 4300 | 22:26:02 INFO - PROCESS | 4300 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.91 (3.0%) stddev-sans-first:2.00 22:26:02 INFO - PROCESS | 4300 | Values: 63.0 65.0 63.0 65.0 64.0 64.0 61.0 64.0 62.0 68.0 22:26:02 INFO - PROCESS | 4300 | -------- Summary: end -------- 22:26:02 INFO - PROCESS | 4300 | 22:26:03 INFO - TEST-INFO | 4300: exit 0 22:26:03 INFO - TEST-OK | kraken | took 61163ms 22:26:03 INFO - SUITE-END | took 1171s 22:26:03 INFO - Completed test suite (00:19:31) 22:26:03 INFO - javascript benchmark 22:26:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7436.943003963665, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3156.652768195498, 3199.344134452439, 3203.567518385017, 3205.79162354447, 3235.530848027036, 5444.0, 5487.341519017718, 5513.3108361454815, 5547.972260138704, 5560.555155587554, 5385.030694474993, 5440.782368705257, 5520.558355331564, 5537.307836520435, 5544.0575102232615, 4993.850184494471, 5019.247112933071, 5122.410922743895, 5191.610629202825, 5229.686218826882, 575.667125581566, 4906.484819093979, 4962.975185124069, 5070.31550740649, 5140.0, 5020.221865610836, 5024.5226703463295, 5049.798008079672, 5053.949460505403, 5083.822066227683, 5092.872678183038, 5099.821506247264, 5107.157319042391, 5110.693358398508, 5112.539871411591, 4962.379702537183, 5021.748912554394, 5050.974745126287, 5070.366204224472, 5080.695158290514, 5511.751971161268, 5515.255440515519, 5524.226608274845, 5543.390227075019, 5617.157426386034, 5737.942620573783, 5836.328822185461, 5950.672713000783, 5974.641521508724, 5977.731002104916, 5931.970340148272, 5977.910331345033, 5994.640321580676, 5999.160117583542, 6052.848678783022, 5566.443355664401, 5607.7476513556985, 5611.326640803089, 5612.494875461187, 5632.436756324376, 5914.112883067574, 5947.1376650385455, 5991.281046274475, 6106.145139680449, 6107.114468402056, 5833.82498525045, 5856.414358564195, 5859.150423188614, 5863.2670916135485, 5895.970520147372, 5927.851803704942, 5929.911051334234, 5933.961556727555, 5939.13882487037, 5944.821655350346, 5724.570657200643, 5852.824415267549, 5876.941230587725, 5914.905742437662, 5925.555583331267, 5936.7922122725495, 5967.522598192221, 5971.373005834412, 5976.9402305977255, 5995.970020149872, 4513.954860451354, 4517.706349087299, 4520.52534483881, 4521.11838191556, 4522.525134860858, 3907.96092039076, 3953.5651078381356, 3970.7419017763755, 3992.540857801332, 4043.211573743092, 5529.949309631157, 5544.500994910478, 5549.19536667181, 5558.249636299129, 5619.381867994517, 5931.199288096138, 5936.0, 5939.168516407706, 5940.049592065336, 5951.0, 5522.585806064561, 5545.500904918576, 5644.9839028975175, 5654.321481422256, 5662.2639056922335, 4918.065567542156, 4945.530174633404, 4956.752162391866, 4961.975190124026, 4976.726280054631, 6149.754009839646, 6187.195664563578, 6211.751529938842, 6227.221597300338, 6228.813135605939, 5822.388649191774, 5889.52883769306, 5906.232189815297, 5976.820695379146, 5993.760249589967, 6121.4490695837585, 6203.31763506005, 6237.4698150657705, 6250.156228909221, 6251.499880009497, 5861.706914654335, 5872.500837428866, 5899.764009439575, 5901.1443340714495, 5911.852203694942, 5713.8285851424525, 5777.653340799566, 5777.9133313001175, 5806.0, 5915.763369465173, 5655.066913959151, 5703.001974654336, 5712.143178523254, 5725.0, 5775.566832487496, 5757.596968212185, 5759.94240057594, 5771.797987070432, 5777.104548794943, 5791.044477661138, 5608.971955140361, 5630.0, 5697.601167918372, 5724.313082430135, 5783.306003279633, 5790.884182316414, 5806.158107074535, 5836.562257830595, 5858.9414105860105, 5868.706564671835, 5537.612367134262, 5709.628874123168, 5714.571407144564, 5715.428457154418, 5737.6557406554075], "value": 5422.859646219576, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.6254965547222, 611.7155522681952, 639.1180171363518, 640.378832532444, 643.6266965160207, 42343.36484952724, 43519.56480435198, 43536.0, 43810.78094609526, 47675.28487072688, 45573.0, 45849.541504584944, 46022.309665354966, 46312.0, 46440.76779616105, 8679.652813887453, 8746.825063498727, 8863.11368863115, 8875.999999999967, 8879.28965682747, 8827.602757875911, 8970.820583588324, 8971.327150463709, 8975.95512022439, 8978.191962723353, 8979.730608081769, 9018.954905225464, 9028.819423611523, 9029.097090290985, 9046.0, 8951.283897288235, 8988.775280618036, 8990.64037438505, 8998.68504602339, 9002.234810041155, 8845.159709827556, 8905.332100092453, 8912.06423325548, 8915.73252802417, 8929.464232146092, 42873.0, 43387.78306108449, 43530.564694352965, 43608.3458748119, 43649.34525982113, 3584.9641503585153, 3674.81625918703, 3724.366857634209, 3778.0932576181517, 3924.548676902136, 32383.0, 33713.83143084293, 33759.831200844084, 33851.322973540635, 34415.655843441746, 4407.140607581523, 4420.381146639441, 4423.402840616508, 4500.09998000398, 4551.544845515455, 344217.0, 345878.0, 347630.0, 347816.8264110744, 351209.0, 55166.448335516936, 55233.72383138139, 55273.0, 55692.16461753077, 55696.72151639297, 35693.28613427717, 36022.81988590093, 36282.637173627925, 38108.42837357442, 65658.0, 15179.316930738143, 15493.380264789283, 15532.767008494882, 15555.611109722347, 15648.217589120499, 12649.87350126487, 12744.80882786759, 12860.807087893689, 12946.0, 12961.805572916413, 19711.704324435144, 19712.60574788525, 19720.70418943717, 19833.900830496044, 19901.203951841766, 6906.827329316808, 7146.3568278855155, 7154.534955227893, 7393.186749457555, 7411.66647500853, 935.9859602105973, 1003.0521157506232, 1051.5163025008428, 1077.9813076642497, 1088.6516314779353, 32216.19459513531, 32273.193170170463, 32693.50959735606, 32991.0, 33112.675492980496, 1073.098597178374, 1129.2095533126844, 1167.1304877865875, 1194.2177873492876, 1233.1218318388617, 16098.195090245441, 16313.10277934725, 16315.428959986344, 16421.753673694904, 16671.583210419838, 556941.0, 558914.0, 559074.0, 562915.0, 566601.0, 59578.63792258718, 60448.39551604516, 60645.69677151586, 60857.391426086055, 61498.0775288371, 1306.7909134538618, 1310.6199202231246, 1331.8934485241157, 1335.7061446481953, 1364.2632978191864, 30627.2343191422, 32064.198395039377, 32393.35213295768, 32484.18789530186, 32940.0, 52073.218901717264, 55607.44392556184, 56337.15494267507, 56612.716936415054, 63208.36791632209, 477106.0, 478340.0, 482875.0, 484107.0, 484851.0, 44261.0, 44603.776981116185, 44910.77544612256, 44931.32603011023, 45707.0, 48928.51071489239, 49124.508754913426, 49657.255141173635, 49947.25079123889, 50510.74744626253, 42744.57255427406, 43065.0, 43163.78418108015, 43346.349804752324, 44623.77688111668, 42970.35544466773, 42984.57015429805, 43263.35104973365, 43468.0, 43762.78118609387, 36188.819055904554, 42828.357574637026, 44100.0, 44416.55583444254, 44611.55388446204, 39732.801335993136, 44809.775951120035, 45155.0, 45636.315455268865, 45717.31424028709, 34508.30983380369, 35363.46954795629, 35381.646183537836, 35521.82239088891, 35532.11169720778], "value": 20805.95936089283, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.24684981410775, 396.14432825097794, 401.25967589796824, 402.4466358756708, 419.33326011641503, 19034.61930761384, 20768.48078798031, 20811.375658730245, 20867.165313387482, 21369.679454808153, 19659.213631454724, 19947.700784488206, 20042.89978550109, 20074.0, 20170.0, 5783.624064435809, 6015.458608725214, 6022.6687532185715, 6023.036314189731, 6026.819195424145, 5357.49103835137, 5901.144334071557, 5916.437938395867, 5942.465178133967, 5949.137375080611, 5654.858628534278, 5684.943150568503, 5714.114312281603, 5741.081426971686, 5748.310202775652, 5663.603547751659, 5665.631733937302, 5729.742161602738, 5743.741531631065, 5803.187553742479, 5533.335999680065, 5574.136008918624, 5581.665100094007, 5600.52395546379, 5633.183188437653, 23410.531789364286, 23502.882485587634, 23767.76232237673, 23849.88075059631, 24189.51620967571, 2366.6804981327473, 2406.2781165650235, 2499.7500249975037, 2582.5480540905264, 2744.643196384477, 9822.361546499526, 10013.89986100137, 10180.389176649425, 10420.478976051243, 10481.475926203659, 2017.4250338653412, 2020.9393718188478, 2047.825934795544, 2059.7322348094654, 2066.8863212523306, 85022.57488712517, 85421.57289213514, 86507.0, 89017.0, 89521.0, 11152.553897844158, 11180.273282236629, 11471.541138354372, 11575.189736718517, 11596.362200079077, 15708.68582628341, 15726.05643661384, 15755.212239388215, 15786.842131578767, 15901.52295431139, 8009.3192078673965, 8271.586420678943, 8363.749087527383, 8417.158284171534, 8430.747077587683, 7858.8428231435055, 7904.1700621435075, 7955.602219888982, 8033.1163572007035, 8036.758897233092, 4545.227311357077, 4607.262837945913, 4640.0, 4699.130660827758, 4749.95250047502, 1854.5270955906158, 2035.2062695548748, 2035.39955713065, 2047.9180832766522, 2088.6762551804495, 992.1566668332005, 999.0627554988456, 1000.7898341348252, 1007.415698894654, 1051.1958351860833, 20183.697244541345, 20319.492012699506, 20623.896880515502, 20807.1677132916, 21043.894780526, 910.6858133943779, 1035.8601588785418, 1035.9015893490107, 1086.6196831109048, 1093.2074246171462, 10992.340459572451, 11167.106631469464, 11252.549898003988, 11263.098952083814, 11296.322220666621, 494735.0, 502407.0, 522131.0, 522203.0, 523406.0, 95361.52319238498, 97228.0, 98557.50721246348, 98600.0, 99409.50295248478, 952.8570714392896, 969.699393188114, 980.6371642492323, 997.0527998401548, 999.9550020249106, 17563.0, 17587.0, 18124.637507249518, 18156.818431815514, 18503.629927401646, 41906.0, 43194.784026079666, 43705.997749475064, 44694.77652611716, 45520.317195241434, 57565.0, 58234.4176558229, 61872.38127618846, 62264.0, 62946.0, 8249.83500330002, 8254.83490330202, 8300.916990830014, 8712.869306960274, 8776.692815751418, 8316.251537361666, 11832.46753896094, 12594.370281486072, 13682.384292706653, 14151.64620884486, 11047.944760276469, 11282.7743445129, 11448.084153267551, 11638.65084047446, 11843.23019003762, 12559.0, 12655.93672031634, 12683.682907927006, 12863.485460581473, 13072.934635327143, 11597.826032609686, 11846.289222646668, 12076.818847717115, 12091.274523528617, 12108.636740897788, 8394.832103358021, 8403.537805420761, 8444.66221351139, 8480.872786908325, 8986.730398088068, 10638.255322127377, 10828.549626696602, 11700.824487632523, 11845.881541184823, 11929.105317101426], "value": 9437.763415001775, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1511.7581187010078, 1512.3043400035979, 1670.7479464762187, 1781.750554922312, 1798.2896755781467, 7943.007124109472, 8483.27892129169, 8620.956895215531, 8763.211310982002, 8871.955640221799, 8754.86867696985, 8898.0, 8949.597268122934, 8989.505577193251, 9005.054469280713, 2292.8280378971563, 2297.954040919189, 2327.72067351918, 2339.4034521197073, 2342.7774361435636, 2253.6619507073906, 2266.3654176830432, 2304.043821813945, 2308.7114110736156, 2312.387217387394, 2276.9544609107807, 2288.347820871052, 2294.4952110535655, 2309.7343805462333, 2311.7225932888077, 2260.16373941641, 2267.841251112423, 2273.090763694527, 2281.942951426211, 2284.0749496453964, 2283.9885800571055, 2289.5878741826464, 2291.049214575949, 2300.574393737164, 2302.228753367607, 9056.592453339616, 9112.31657625674, 9117.22503587196, 9118.133777291147, 9130.680426185052, 5065.366829146356, 5079.0, 5148.794048238066, 5149.0731668299695, 5246.65896716716, 3234.91912702182, 3263.9673603264137, 3313.784604000732, 3382.746294027958, 3397.065806903097, 1120.5741818109148, 1138.6242539961875, 1154.924929879555, 1161.0479406886357, 1167.9591214307459, 11818.290902545874, 11912.702182445422, 11953.581624643095, 11966.880331196664, 11992.04063674904, 4342.630876375543, 4413.735175889393, 4469.173202957463, 4533.387992620954, 4567.680262381601, 10033.598656053822, 10094.242931780145, 10122.848157277647, 10130.341527800669, 10133.391996480235, 5147.382314122329, 5164.948350516522, 5165.380154381423, 5180.300659411007, 5186.974065129726, 4241.088166044254, 4666.673332866734, 4770.165221086296, 4803.303520989507, 4826.32431459596, 3776.3202623527477, 3852.24881148179, 3929.0, 3935.3506671399473, 3970.861019864291, 1180.403896032498, 1183.46743965216, 1186.4423720851187, 1189.4647408666135, 1198.0774803401507, 969.3021024862088, 989.124624707125, 1018.7402212435782, 1024.1908891975256, 1028.0593257169605, 6235.690504993911, 6236.781712640036, 6283.560150789493, 6321.525885558602, 6350.809475715736, 437.06250093549795, 443.97336159830513, 444.42225107360304, 448.31631761563875, 450.5539515879256, 4218.493780746268, 4297.269464191095, 4312.094460163401, 4349.804258808361, 4353.390525326457, 10654.840177397346, 10974.835377469344, 10998.175136864607, 11004.339739615649, 11010.559577616805, 10115.595376185018, 10804.405757683402, 10877.259638457808, 10886.61896833607, 10925.890741092488, 8208.630611622491, 8511.489310641382, 8530.488170709777, 8554.101819308882, 8618.267447267053, 5753.482186603226, 6026.7589296429405, 6059.424354686298, 6069.939300606938, 6200.100985357189, 9757.121859032437, 10021.699349019542, 10048.145907597936, 10055.296129271173, 10184.694459166238, 10041.447720375158, 10135.898641013495, 10144.949275253577, 10155.339902906288, 10199.439030853375, 6887.035814986006, 7569.735059272899, 7849.4897831640765, 7915.841683166189, 8092.433529652868, 8865.68970086044, 8957.910420895969, 8994.190522852712, 9001.774955626162, 9072.319576031692, 7969.282764551218, 8150.470219435955, 8230.958845205974, 8311.418200725891, 8400.83198336042, 7494.5128566643, 7542.396608271435, 7595.5442673439775, 7719.807004824925, 7890.132085470708, 6905.102336696398, 6940.757073502403, 6999.4050505705545, 7039.225685174729, 7048.471364647775, 5328.866778330573, 5329.040772660958, 5362.302900622894, 5402.35171779389, 5402.756875940513, 5323.840284791462, 5425.159100339453, 5456.672599644034, 5476.890462190813, 5501.367342755634], "value": 4566.825314748227, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.6701763674596, 321.2498815266353, 324.51161002690947, 327.4024904549198, 327.67560115485674, 5650.841577476618, 5687.090065589501, 5744.25324707788, 5748.655080695161, 5773.566982476321, 5631.915521267184, 5632.943670563293, 5645.520130788888, 5653.519450846673, 5686.175504551838, 4081.632653061228, 4221.556736542665, 4372.97813510932, 4387.166438376714, 4389.9561004390025, 4335.393044973706, 4345.0, 4348.4999225089205, 4349.391085248068, 4377.321515165155, 4360.912781744363, 4367.388565600819, 4369.410129632507, 4376.102898905732, 4397.61475135333, 4324.178406102862, 4325.178216138924, 4349.717268377545, 4356.6514678825615, 4391.6486681065435, 3830.4062870255157, 3833.17586718854, 3845.769253844778, 3851.306764782338, 3860.6911447084167, 5510.476504732044, 5524.254225679522, 5541.806036788734, 5550.778828657729, 5559.8888022239325, 4855.344528488679, 4971.801127954877, 4990.201567749143, 5008.323876276692, 5027.924581131286, 5925.555583331225, 5926.733297001602, 5929.288485381781, 5938.257717785277, 5944.405559444064, 4210.136921931027, 4254.808533615995, 4259.148170365908, 4260.25445547028, 4264.402983582301, 6029.763898400817, 6039.909401358983, 6098.969505152446, 6136.294326152505, 6173.444390004921, 4232.492100947906, 4236.322188449833, 4268.125034367947, 4306.5262821089655, 4317.352397140454, 4333.371661109121, 4354.716943398669, 4357.891052723708, 4361.171377438277, 4363.47638283408, 4897.7795999180125, 4969.875753106201, 4980.7509624518625, 5005.174146265898, 5018.824341148043, 5944.881102377928, 5960.910586341209, 5981.102834574848, 6045.667488288186, 6063.787767428207, 1485.2944851195596, 1495.28973737476, 1500.7748837674217, 1503.59413947959, 1521.3078049487456, 950.4249928792981, 952.8142012307673, 972.6887396033202, 993.7813680990171, 1030.6341248856697, 5669.829905102853, 5683.403242659544, 5702.258706368146, 5744.971275143597, 5775.942240577624, 5987.700614969234, 6027.336992930774, 6033.577649564489, 6090.969545152335, 6108.205933228741, 5535.723213839292, 5657.886842263214, 5732.684702341411, 5743.310802703702, 5745.971270143623, 3230.578545439999, 3248.187953011747, 3254.267789747288, 3255.0, 3257.9674203257664, 6108.480779133734, 6238.220222472191, 6294.65379404128, 6308.558400911892, 6325.841853953596, 6074.845779301919, 6145.078238264206, 6181.876362472725, 6193.473554747897, 6201.7519299228425, 5989.401059893976, 6185.659788711574, 6227.408396202444, 6316.810495685045, 6319.6208227506495, 5995.91006134917, 6013.278406591237, 6034.2155519782145, 6070.666113363807, 6082.2093127893095, 5976.133460648269, 6001.639901605918, 6012.226393213925, 6023.728932197974, 6037.607555508878, 6118.510519158545, 6306.180196574416, 6402.0, 6412.487001039813, 6440.6135631862235, 4257.510386305491, 4273.658107351466, 4297.882550536945, 4299.634531064769, 4312.792418122931, 5834.591578589458, 6124.142620033288, 6141.0, 6181.81454556364, 6201.906971395523, 5926.170336153028, 5930.584859059824, 5973.417044483303, 5982.730777115127, 6001.219841420588, 5894.263217097863, 5903.970480147744, 5914.674692891932, 5931.3772053935445, 6029.186059881859, 5691.943080569141, 5856.472917437451, 5866.178734977192, 5904.261967254093, 5912.763489460545, 5945.186718051036, 6004.189434426296, 6050.425209605257, 6050.757969681339, 6064.818055458343, 5679.438154507544, 5882.058970514742, 5900.852478688067, 5902.026165682614, 5912.320083190488], "value": 4501.5563930681055, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.7385801898347, 779.6803310642638, 797.3581267080001, 812.4556547113433, 901.7249738829656, 15776.0, 16126.677466450665, 16497.17514124295, 16515.0, 16612.086335251555, 13809.792853107212, 15013.399464021426, 15101.093934363946, 15105.848941510609, 15140.015898966587, 668.6422763821356, 804.8470790549806, 810.2100452059254, 811.0267678785451, 815.7797394703456, 811.4563242627424, 829.1376967953321, 833.1876420490004, 835.0855812884881, 837.1753822484848, 864.2006144316514, 868.4355169140077, 868.7958329792493, 870.8954925408959, 871.9782005449852, 859.4800145911696, 865.1002956924791, 867.9349048821332, 868.053821334745, 869.1091631078132, 632.5730132160819, 633.9936600633981, 634.1597383466925, 635.139386131794, 635.2059925093633, 15289.082655040622, 15366.462173823862, 15392.076475411512, 15401.22993850303, 15403.306851191723, 15804.841951580453, 15932.522024339289, 15966.0, 16144.59638509035, 16241.593960150973, 12156.635300940987, 12165.878341216563, 12187.878121218851, 12417.317047562381, 12725.809112863315, 3937.251922134785, 3995.440638310639, 4000.6799456043445, 4047.251258517184, 4071.42999980003, 67014.3298567013, 69308.99999999949, 69976.6501167496, 75398.0, 75720.62139689321, 11698.410574363885, 12162.270263784201, 12211.267323960414, 12221.694457638452, 12340.691482712824, 21677.0, 21957.890210549165, 21978.340649780213, 22012.449688757908, 22060.88969555174, 8912.55437228136, 9064.138906803842, 9081.81836363269, 9108.499032553273, 9289.535523223813, 4998.800047998039, 5015.097282489187, 5055.974720126449, 5060.924086138711, 5133.5379815816, 3466.30673865228, 3535.116220944764, 3551.2542366103407, 3557.0751604582993, 3565.1978304881713, 616.9907451388233, 617.1206031405229, 619.5632079384023, 630.5397060146119, 641.8042497038355, 684.4114061906756, 763.5304287862924, 764.3503022431, 777.1218523068897, 784.9921500785033, 9935.602575897028, 10031.749206269902, 10343.482825858828, 10451.985847411112, 10969.561217551209, 682.7712716240115, 722.8265216348038, 735.9632018399059, 755.6662490703912, 763.9388848892075, 4751.976240118777, 4775.785089670973, 4937.481564435754, 4957.355543779286, 4972.428170760337, 106580.0, 118504.40747796206, 121765.0, 122234.0, 122257.0, 73718.0, 98261.50869245607, 98288.0, 98725.0, 99812.0, 54738.90522189534, 90543.54728226448, 90616.0, 90720.38156375133, 91588.54205728929, 9190.954045229999, 9205.171534561921, 9357.251419886528, 9403.81192376135, 9498.620055197714, 52813.0, 53721.0, 53905.46094539161, 54693.453065468835, 55154.0, 50977.74511127569, 75460.0, 75685.62157189178, 75776.0, 76805.23194767981, 11893.226940248856, 11902.226355286879, 12345.298107498786, 12467.5012999479, 12745.17156384832, 14143.222122782934, 14241.857581424054, 14328.570142895729, 14497.275136242935, 14932.328045237773, 13525.391357388744, 13545.255010974492, 13776.65558361049, 13777.517786877412, 14355.56933292003, 12781.61655150347, 12861.2926289055, 13023.0, 13335.66660833487, 13589.456421743414, 12698.555550555686, 14210.573682789533, 14368.784468233194, 14554.563363099123, 14733.705325893636, 11679.416029198675, 11906.880931190924, 12099.274043557414, 12427.93786031064, 12452.688682783002, 12166.837424087344, 12895.935520322713, 12913.677158071123, 12917.160384574972, 13076.869231307564], "value": 7727.874696671848, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 104.0, 111.0, 110.0, 112.0, 113.0, 114.0, 110.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 149.0, 184.0, 120.0, 150.0, 146.0, 121.0, 177.0, 119.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 167.0, 163.0, 162.0, 163.0, 165.0, 172.0, 165.0, 163.0, 162.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 169.0, 76.0, 77.0, 75.0, 77.0, 157.0, 75.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 151.0, 85.0, 85.0, 84.0, 138.0, 84.0, 84.0, 134.0], "value": 101.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 146.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 95.0, 95.0, 95.0, 97.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 54.0, 55.0, 57.0, 58.0, 54.0, 53.0, 61.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0, 61.0, 61.0, 62.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 75.0, 75.0, 77.0, 75.0, 76.0, 76.0, 75.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 122.0, 139.0, 121.0, 121.0, 130.0, 135.0, 183.0, 122.0], "value": 131.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 155.0, 163.0, 158.0, 164.0, 157.0, 157.0, 160.0, 162.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 65.0, 64.0, 64.0, 61.0, 64.0, 62.0, 68.0], "value": 63.9, "unit": "score"}]}]} 22:26:03 INFO - Return code: 0 22:26:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:26:03 ERROR - # TBPL SUCCESS # 22:26:03 INFO - Running post-action listener: _resource_record_post_action 22:26:03 INFO - ##### 22:26:03 INFO - ##### Finished run-tests step (success) 22:26:03 INFO - ##### 22:26:03 INFO - Running post-run listener: _resource_record_post_run 22:26:03 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 555442176; Read time: 0; Write time: 403856 22:26:03 INFO - TinderboxPrint: CPU usage
13.3% 22:26:03 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:26:03 INFO - TinderboxPrint: I/O write bytes / time
555,442,176 / 403,856 22:26:03 INFO - TinderboxPrint: CPU idle
8,225.5 (86.7%) 22:26:03 INFO - TinderboxPrint: CPU user
1,209.3 (12.7%) 22:26:03 INFO - TinderboxPrint: Swap in / out
0 / 0 22:26:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 262959104; Read time: 0; Write time: 203104 22:26:03 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 292483072; Read time: 0; Write time: 200752 22:26:04 INFO - Running post-run listener: _upload_blobber_files 22:26:04 INFO - Blob upload gear active. 22:26:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:26:04 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 22:26:04 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:26:04 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:26:04 INFO - (blobuploader) - INFO - Open directory for files ... 22:26:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:26:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:26:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:26:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:26:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:26:05 INFO - (blobuploader) - INFO - Done attempting. 22:26:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:26:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:26:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:26:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:26:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:26:09 INFO - (blobuploader) - INFO - Done attempting. 22:26:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:26:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:26:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:26:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:26:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:26:10 INFO - (blobuploader) - INFO - Done attempting. 22:26:10 INFO - (blobuploader) - INFO - Iteration through files over. 22:26:10 INFO - Return code: 0 22:26:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:26:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:26:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9dd51f3cae0f4463f57bb06c2a179191e7db86532ccb90f27436bae43e1ec8de4d1c0318374c0b7fba2fd65e213312129fb379eef54ff1bd06384d012232e2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dacac9bf60de4385a1c3a6a654c6ef6b1106d4528dc616c119d0bdef65884c6ed84104aa3987a2fec2ac79f075ad9d2fee35a3bcab0a04e9557a4655b7c13865", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc0b8d4f99984c556f3060a236abdc5102c87384bd2454b1b34569765e526a02ef9111d68f12709159fd03d7d91160d270534e14198c6c169bd094360b315f04"} 22:26:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:26:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:26:10 INFO - Contents: 22:26:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9dd51f3cae0f4463f57bb06c2a179191e7db86532ccb90f27436bae43e1ec8de4d1c0318374c0b7fba2fd65e213312129fb379eef54ff1bd06384d012232e2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dacac9bf60de4385a1c3a6a654c6ef6b1106d4528dc616c119d0bdef65884c6ed84104aa3987a2fec2ac79f075ad9d2fee35a3bcab0a04e9557a4655b7c13865", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc0b8d4f99984c556f3060a236abdc5102c87384bd2454b1b34569765e526a02ef9111d68f12709159fd03d7d91160d270534e14198c6c169bd094360b315f04"} 22:26:10 INFO - Running post-run listener: copy_logs_to_upload_dir 22:26:10 INFO - Copying logs to upload dir... 22:26:10 INFO - mkdir: /builds/slave/test/build/upload/logs 22:26:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.032699 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-07-05 22:26:09.265342) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 22:26:09.271254) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549 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/sha512/b9dd51f3cae0f4463f57bb06c2a179191e7db86532ccb90f27436bae43e1ec8de4d1c0318374c0b7fba2fd65e213312129fb379eef54ff1bd06384d012232e2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dacac9bf60de4385a1c3a6a654c6ef6b1106d4528dc616c119d0bdef65884c6ed84104aa3987a2fec2ac79f075ad9d2fee35a3bcab0a04e9557a4655b7c13865", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc0b8d4f99984c556f3060a236abdc5102c87384bd2454b1b34569765e526a02ef9111d68f12709159fd03d7d91160d270534e14198c6c169bd094360b315f04"} build_url:https://queue.taskcluster.net/v1/task/agJ7V28tTBmw0OC7XmFigA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011150 build_url: 'https://queue.taskcluster.net/v1/task/agJ7V28tTBmw0OC7XmFigA/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/sha512/b9dd51f3cae0f4463f57bb06c2a179191e7db86532ccb90f27436bae43e1ec8de4d1c0318374c0b7fba2fd65e213312129fb379eef54ff1bd06384d012232e2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dacac9bf60de4385a1c3a6a654c6ef6b1106d4528dc616c119d0bdef65884c6ed84104aa3987a2fec2ac79f075ad9d2fee35a3bcab0a04e9557a4655b7c13865", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc0b8d4f99984c556f3060a236abdc5102c87384bd2454b1b34569765e526a02ef9111d68f12709159fd03d7d91160d270534e14198c6c169bd094360b315f04"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 22:26:09.296632) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:26:09.296947) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467781541.777258-413524549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004386 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:26:09.379740) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 22:26:09.380045) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 22:26:09.380358) ========= ========= Total master_lag: 0.15 =========