builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1468294237.35 results: success (0) buildid: 20160711173007 builduid: 6191662bbcf8429ea88db479cc27bb86 revision: f87c66fa12c635e07cd071dbfb9646258b7896d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 20:30:37.348674) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 20:30:37.349149) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 20:30:37.349449) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 20:30:37.364050) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 20:30:37.364336) ========= 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=745a4373a2a16df560f216e000000264-1468294216.572604-1455945311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 20:30:37-- 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.4M=0s 2016-07-11 20:30:37 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100158 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 20:30:37.478083) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 20:30:37.478392) ========= 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=745a4373a2a16df560f216e000000264-1468294216.572604-1455945311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018025 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 20:30:37.527689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 20:30:37.528081) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f87c66fa12c635e07cd071dbfb9646258b7896d2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f87c66fa12c635e07cd071dbfb9646258b7896d2 --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=745a4373a2a16df560f216e000000264-1468294216.572604-1455945311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 20:30:37,599 truncating revision to first 12 chars 2016-07-11 20:30:37,599 Setting DEBUG logging. 2016-07-11 20:30:37,599 attempt 1/10 2016-07-11 20:30:37,599 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f87c66fa12c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 20:30:38,241 unpacking tar archive at: fx-team-f87c66fa12c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.985181 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 20:30:38.526888) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 20:30:38.527235) ========= script_repo_revision: f87c66fa12c635e07cd071dbfb9646258b7896d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 20:30:38.527627) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 20:30:38.527929) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 20:30:38.538284) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-11 20:30:38.538576) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=745a4373a2a16df560f216e000000264-1468294216.572604-1455945311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:30:38 INFO - MultiFileLogger online at 20160711 20:30:38 in /builds/slave/test 20:30:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:30:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:30:38 INFO - {'append_to_log': False, 20:30:38 INFO - 'base_work_dir': '/builds/slave/test', 20:30:38 INFO - 'blob_upload_branch': 'Fx-Team', 20:30:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:30:38 INFO - 'branch': 'Fx-Team', 20:30:38 INFO - 'buildbot_json_path': 'buildprops.json', 20:30:38 INFO - 'config_files': ('talos/linux_config.py',), 20:30:38 INFO - 'default_actions': ('clobber', 20:30:38 INFO - 'read-buildbot-config', 20:30:38 INFO - 'download-and-extract', 20:30:38 INFO - 'populate-webroot', 20:30:38 INFO - 'create-virtualenv', 20:30:38 INFO - 'install', 20:30:38 INFO - 'run-tests'), 20:30:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:30:38 INFO - 'download_minidump_stackwalk': True, 20:30:38 INFO - 'download_symbols': 'ondemand', 20:30:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:30:38 INFO - 'tooltool.py': '/tools/tooltool.py', 20:30:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:30:38 INFO - '/tools/misc-python/virtualenv.py')}, 20:30:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:30:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:30:38 INFO - 'installer_path': 'installer.exe', 20:30:38 INFO - 'log_level': 'info', 20:30:38 INFO - 'log_name': 'talos', 20:30:38 INFO - 'log_to_console': True, 20:30:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:30:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:30:38 INFO - 'opt_config_files': (), 20:30:38 INFO - 'pip_index': False, 20:30:38 INFO - 'sps_profile': False, 20:30:38 INFO - 'sps_profile_interval': 0, 20:30:38 INFO - 'suite': 'dromaeojs-e10s', 20:30:38 INFO - 'system_bits': '32', 20:30:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:30:38 INFO - 'title': 'talos-linux64-ix-032', 20:30:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:30:38 INFO - 'use_talos_json': True, 20:30:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:30:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:30:38 INFO - 'work_dir': 'build'} 20:30:38 INFO - ##### 20:30:38 INFO - ##### Running clobber step. 20:30:38 INFO - ##### 20:30:38 INFO - Running pre-action listener: _resource_record_pre_action 20:30:38 INFO - Running main action method: clobber 20:30:38 INFO - rmtree: /builds/slave/test/build 20:30:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:30:39 INFO - Running post-action listener: _resource_record_post_action 20:30:39 INFO - ##### 20:30:39 INFO - ##### Finished clobber step (success) 20:30:39 INFO - ##### 20:30:39 INFO - ##### 20:30:39 INFO - ##### Running read-buildbot-config step. 20:30:39 INFO - ##### 20:30:39 INFO - Running pre-action listener: _resource_record_pre_action 20:30:39 INFO - Running main action method: read_buildbot_config 20:30:39 INFO - Using buildbot properties: 20:30:39 INFO - { 20:30:39 INFO - "project": "", 20:30:39 INFO - "product": "firefox", 20:30:39 INFO - "script_repo_revision": "production", 20:30:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:30:39 INFO - "repository": "", 20:30:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:30:39 INFO - "buildid": "20160711173007", 20:30:39 INFO - "pgo_build": "True", 20:30:39 INFO - "basedir": "/builds/slave/test", 20:30:39 INFO - "buildnumber": 915, 20:30:39 INFO - "slavename": "talos-linux64-ix-032", 20:30:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:30:39 INFO - "platform": "ubuntu64_hw", 20:30:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:30:39 INFO - "branch": "fx-team", 20:30:39 INFO - "repo_path": "integration/fx-team", 20:30:39 INFO - "revision": "f87c66fa12c635e07cd071dbfb9646258b7896d2", 20:30:39 INFO - "stage_platform": "linux64-pgo", 20:30:39 INFO - "builduid": "6191662bbcf8429ea88db479cc27bb86", 20:30:39 INFO - "slavebuilddir": "test" 20:30:39 INFO - } 20:30:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:30:39 INFO - Running post-action listener: _resource_record_post_action 20:30:39 INFO - ##### 20:30:39 INFO - ##### Finished read-buildbot-config step (success) 20:30:39 INFO - ##### 20:30:39 INFO - ##### 20:30:39 INFO - ##### Running download-and-extract step. 20:30:39 INFO - ##### 20:30:39 INFO - Running pre-action listener: _resource_record_pre_action 20:30:39 INFO - Running main action method: download_and_extract 20:30:39 INFO - mkdir: /builds/slave/test/build/tests 20:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:39 INFO - https://queue.taskcluster.net/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:30:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:30:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:30:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/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 20:30:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/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 20:30:40 INFO - Downloaded 1361 bytes. 20:30:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:30:40 INFO - Using the following test package requirements: 20:30:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:30:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:30:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:30:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:30:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:30:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:30:40 INFO - u'jsshell-linux-x86_64.zip'], 20:30:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:30:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:30:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:30:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:30:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:30:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:30:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:30:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:30:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:30:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:30:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:30:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:40 INFO - https://queue.taskcluster.net/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:30:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:30:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:30:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/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 20:30:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/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 20:30:41 INFO - Downloaded 24270441 bytes. 20:30:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:30:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:30:43 INFO - Return code: 0 20:30:43 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 20:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:43 INFO - https://queue.taskcluster.net/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:30:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:30:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:30:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/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 20:30:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/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 20:30:45 INFO - Downloaded 24270441 bytes. 20:30: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'] 20:30: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 20:30:46 INFO - Return code: 0 20:30: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')]} 20:30:46 INFO - https://queue.taskcluster.net/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:30:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:30:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:30:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/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 20:30:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/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 20:30:47 INFO - Downloaded 14403333 bytes. 20:30:47 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'] 20:30:47 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 20:30:47 INFO - Return code: 0 20:30:47 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')]} 20:30:47 INFO - https://queue.taskcluster.net/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:30:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:30:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:30:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/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 20:30:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXRhGYqjRKaIx20u-tT7HQ/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 20:30:50 INFO - Downloaded 60484428 bytes. 20:30:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:30:50 INFO - mkdir: /builds/slave/test/properties 20:30:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:30:50 INFO - Writing to file /builds/slave/test/properties/build_url 20:30:50 INFO - Contents: 20:30:50 INFO - build_url:https://queue.taskcluster.net/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:30:51 INFO - Running post-action listener: _resource_record_post_action 20:30:51 INFO - Running post-action listener: set_extra_try_arguments 20:30:51 INFO - ##### 20:30:51 INFO - ##### Finished download-and-extract step (success) 20:30:51 INFO - ##### 20:30:51 INFO - ##### 20:30:51 INFO - ##### Running populate-webroot step. 20:30:51 INFO - ##### 20:30:51 INFO - Running pre-action listener: _resource_record_pre_action 20:30:51 INFO - Running main action method: populate_webroot 20:30:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:30:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:30:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:30:51 INFO - '--tppagecycles', 20:30:51 INFO - '7'], 20:30:51 INFO - 'tests': ['tsvgm']}}, 20:30:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:30:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:30:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:30:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:30:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:30:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:30:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:30:51 INFO - 'talos_options': ['--disable-e10s'], 20:30:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:30:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:30:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:30:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:30:51 INFO - 'talos_options': ['--disable-e10s'], 20:30:51 INFO - 'tests': ['damp', 'tps']}, 20:30:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:30:51 INFO - 'tests': ['damp', 'tps']}, 20:30:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:30:51 INFO - 'tests': ['dromaeo_dom']}, 20:30:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:30:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:30:51 INFO - 'tests': ['basic_compositor_video']}, 20:30:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:30:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:30:51 INFO - 'tests': ['a11yr', 20:30:51 INFO - 'ts_paint', 20:30:51 INFO - 'tpaint', 20:30:51 INFO - 'sessionrestore', 20:30:51 INFO - 'sessionrestore_no_auto_restore', 20:30:51 INFO - 'tabpaint']}, 20:30:51 INFO - 'other-e10s': {'tests': ['a11yr', 20:30:51 INFO - 'ts_paint', 20:30:51 INFO - 'tpaint', 20:30:51 INFO - 'sessionrestore', 20:30:51 INFO - 'sessionrestore_no_auto_restore', 20:30:51 INFO - 'tabpaint']}, 20:30:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:30:51 INFO - 'ts_paint', 20:30:51 INFO - 'tpaint', 20:30:51 INFO - 'sessionrestore', 20:30:51 INFO - 'sessionrestore_no_auto_restore', 20:30:51 INFO - 'tabpaint']}, 20:30:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:30:51 INFO - 'ts_paint', 20:30:51 INFO - 'tpaint', 20:30:51 INFO - 'sessionrestore', 20:30:51 INFO - 'sessionrestore_no_auto_restore', 20:30:51 INFO - 'tabpaint']}, 20:30:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:30:51 INFO - 'tests': ['a11yr', 20:30:51 INFO - 'ts_paint', 20:30:51 INFO - 'tpaint', 20:30:51 INFO - 'sessionrestore', 20:30:51 INFO - 'sessionrestore_no_auto_restore', 20:30:51 INFO - 'tabpaint']}, 20:30:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:30:51 INFO - 'tests': ['a11yr', 20:30:51 INFO - 'ts_paint', 20:30:51 INFO - 'tpaint', 20:30:51 INFO - 'sessionrestore', 20:30:51 INFO - 'sessionrestore_no_auto_restore', 20:30:51 INFO - 'tabpaint']}, 20:30:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:30:51 INFO - 'tests': ['tsvgx', 20:30:51 INFO - 'tsvgr_opacity', 20:30:51 INFO - 'tart', 20:30:51 INFO - 'tscrollx', 20:30:51 INFO - 'cart']}, 20:30:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:30:51 INFO - 'tsvgr_opacity', 20:30:51 INFO - 'tart', 20:30:51 INFO - 'tscrollx', 20:30:51 INFO - 'cart']}, 20:30:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:30:51 INFO - 'talos_options': ['--disable-e10s'], 20:30:51 INFO - 'tests': ['tp5o']}, 20:30:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:30:51 INFO - 'tests': ['tp5o']}, 20:30:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:30:51 INFO - 'talos_options': ['--disable-e10s', 20:30:51 INFO - '--xperf_path', 20:30:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:30:51 INFO - 'tests': ['tp5n']}, 20:30:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:30:51 INFO - 'talos_options': ['--xperf_path', 20:30:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:30:51 INFO - 'tests': ['tp5n']}}, 20:30:51 INFO - 'talos.zip': {'path': '', 20:30:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:30:51 INFO - Running post-action listener: _resource_record_post_action 20:30:51 INFO - ##### 20:30:51 INFO - ##### Finished populate-webroot step (success) 20:30:51 INFO - ##### 20:30:51 INFO - ##### 20:30:51 INFO - ##### Running create-virtualenv step. 20:30:51 INFO - ##### 20:30:51 INFO - Running pre-action listener: _resource_record_pre_action 20:30:51 INFO - Running main action method: create_virtualenv 20:30:51 INFO - Creating virtualenv /builds/slave/test/build/venv 20:30:51 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 20:30:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:30:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:30:51 INFO - Using real prefix '/usr' 20:30:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:30:51 INFO - Installing distribute.............................................................................................................................................................................................done. 20:30:53 INFO - Installing pip.................done. 20:30:53 INFO - Return code: 0 20:30:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:53 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 0x1c07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec63b0>, '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 0x1ec72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7740>, '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': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', '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 20:30:53 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 20:30:53 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 20:30:53 INFO - Using env: {'DISPLAY': ':0', 20:30:53 INFO - 'HOME': '/home/cltbld', 20:30:53 INFO - 'LANG': 'en_US.UTF-8', 20:30:53 INFO - 'LANGUAGE': 'en_US:en', 20:30:53 INFO - 'LOGNAME': 'cltbld', 20:30:53 INFO - 'MAIL': '/var/mail/cltbld', 20:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:53 INFO - 'MOZ_NO_REMOTE': '1', 20:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:30:53 INFO - 'NO_EM_RESTART': '1', 20:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:53 INFO - 'PWD': '/builds/slave/test', 20:30:53 INFO - 'SHELL': '/bin/bash', 20:30:53 INFO - 'SHLVL': '1', 20:30:53 INFO - 'TERM': 'linux', 20:30:53 INFO - 'TMOUT': '86400', 20:30:53 INFO - 'USER': 'cltbld', 20:30:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', 20:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:53 INFO - '_': '/tools/buildbot/bin/python'} 20:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:54 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 20:30:54 INFO - Cleaning up... 20:30:54 INFO - Return code: 0 20:30:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec63b0>, '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 0x1ec72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7740>, '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': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', '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 20:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:30:54 INFO - Using env: {'DISPLAY': ':0', 20:30:54 INFO - 'HOME': '/home/cltbld', 20:30:54 INFO - 'LANG': 'en_US.UTF-8', 20:30:54 INFO - 'LANGUAGE': 'en_US:en', 20:30:54 INFO - 'LOGNAME': 'cltbld', 20:30:54 INFO - 'MAIL': '/var/mail/cltbld', 20:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:54 INFO - 'MOZ_NO_REMOTE': '1', 20:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:30:54 INFO - 'NO_EM_RESTART': '1', 20:30:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:54 INFO - 'PWD': '/builds/slave/test', 20:30:54 INFO - 'SHELL': '/bin/bash', 20:30:54 INFO - 'SHLVL': '1', 20:30:54 INFO - 'TERM': 'linux', 20:30:54 INFO - 'TMOUT': '86400', 20:30:54 INFO - 'USER': 'cltbld', 20:30:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', 20:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:54 INFO - '_': '/tools/buildbot/bin/python'} 20:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:54 INFO - Downloading/unpacking psutil>=3.1.1 20:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:30:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:30:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:30:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:30:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:30:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:30:56 INFO - Installing collected packages: psutil 20:30:56 INFO - Running setup.py install for psutil 20:30:56 INFO - building 'psutil._psutil_linux' extension 20:30:56 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 20:30:56 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 20:30:56 INFO - building 'psutil._psutil_posix' extension 20:30:56 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 20:30:56 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 20:30:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:30:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:30:56 INFO - Successfully installed psutil 20:30:56 INFO - Cleaning up... 20:30:56 INFO - Return code: 0 20:30:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec63b0>, '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 0x1ec72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7740>, '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': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', '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 20:30:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:30:56 INFO - Using env: {'DISPLAY': ':0', 20:30:56 INFO - 'HOME': '/home/cltbld', 20:30:56 INFO - 'LANG': 'en_US.UTF-8', 20:30:56 INFO - 'LANGUAGE': 'en_US:en', 20:30:56 INFO - 'LOGNAME': 'cltbld', 20:30:56 INFO - 'MAIL': '/var/mail/cltbld', 20:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:56 INFO - 'MOZ_NO_REMOTE': '1', 20:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:30:56 INFO - 'NO_EM_RESTART': '1', 20:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:56 INFO - 'PWD': '/builds/slave/test', 20:30:56 INFO - 'SHELL': '/bin/bash', 20:30:56 INFO - 'SHLVL': '1', 20:30:56 INFO - 'TERM': 'linux', 20:30:56 INFO - 'TMOUT': '86400', 20:30:56 INFO - 'USER': 'cltbld', 20:30:56 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', 20:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:56 INFO - '_': '/tools/buildbot/bin/python'} 20:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:30:57 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 20:30:57 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 20:30:57 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 20:30:57 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 20:30:57 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 20:30:57 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 20:30:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:30:58 INFO - Installing collected packages: mozsystemmonitor 20:30:58 INFO - Running setup.py install for mozsystemmonitor 20:30:59 INFO - Successfully installed mozsystemmonitor 20:30:59 INFO - Cleaning up... 20:31:01 INFO - Return code: 0 20:31:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:31:01 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')]} 20:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:01 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')]} 20:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:01 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 0x1c07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec63b0>, '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 0x1ec72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7740>, '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': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', '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 20:31:01 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 20:31:01 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 20:31:01 INFO - Using env: {'DISPLAY': ':0', 20:31:01 INFO - 'HOME': '/home/cltbld', 20:31:01 INFO - 'LANG': 'en_US.UTF-8', 20:31:01 INFO - 'LANGUAGE': 'en_US:en', 20:31:01 INFO - 'LOGNAME': 'cltbld', 20:31:01 INFO - 'MAIL': '/var/mail/cltbld', 20:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:01 INFO - 'MOZ_NO_REMOTE': '1', 20:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:01 INFO - 'NO_EM_RESTART': '1', 20:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:01 INFO - 'PWD': '/builds/slave/test', 20:31:01 INFO - 'SHELL': '/bin/bash', 20:31:01 INFO - 'SHLVL': '1', 20:31:01 INFO - 'TERM': 'linux', 20:31:01 INFO - 'TMOUT': '86400', 20:31:01 INFO - 'USER': 'cltbld', 20:31:01 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', 20:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:01 INFO - '_': '/tools/buildbot/bin/python'} 20:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:31:01 INFO - Downloading/unpacking jsonschema==2.5.1 20:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:31:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:31:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:31:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:31:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:31:04 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 20:31:04 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 20:31:04 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 20:31:04 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 20:31:04 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 20:31:04 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 20:31:05 INFO - Downloading functools32-3.2.3-2.tar.gz 20:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:31:05 INFO - warning: no files found matching '*.txt' 20:31:05 INFO - no previously-included directories found matching 'build' 20:31:05 INFO - no previously-included directories found matching 'dist' 20:31:05 INFO - no previously-included directories found matching '.git*' 20:31:05 INFO - Installing collected packages: jsonschema, functools32 20:31:05 INFO - Running setup.py install for functools32 20:31:05 INFO - warning: no files found matching '*.txt' 20:31:05 INFO - no previously-included directories found matching 'build' 20:31:05 INFO - no previously-included directories found matching 'dist' 20:31:05 INFO - no previously-included directories found matching '.git*' 20:31:05 INFO - Successfully installed jsonschema functools32 20:31:05 INFO - Cleaning up... 20:31:05 INFO - Return code: 0 20:31:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:31:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:05 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 0x1c07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec63b0>, '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 0x1ec72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7740>, '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': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', '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 20:31:05 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 20:31:05 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 20:31:05 INFO - Using env: {'DISPLAY': ':0', 20:31:05 INFO - 'HOME': '/home/cltbld', 20:31:05 INFO - 'LANG': 'en_US.UTF-8', 20:31:05 INFO - 'LANGUAGE': 'en_US:en', 20:31:05 INFO - 'LOGNAME': 'cltbld', 20:31:05 INFO - 'MAIL': '/var/mail/cltbld', 20:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:05 INFO - 'MOZ_NO_REMOTE': '1', 20:31:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:05 INFO - 'NO_EM_RESTART': '1', 20:31:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:05 INFO - 'PWD': '/builds/slave/test', 20:31:05 INFO - 'SHELL': '/bin/bash', 20:31:05 INFO - 'SHLVL': '1', 20:31:05 INFO - 'TERM': 'linux', 20:31:05 INFO - 'TMOUT': '86400', 20:31:05 INFO - 'USER': 'cltbld', 20:31:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', 20:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:05 INFO - '_': '/tools/buildbot/bin/python'} 20:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:31:05 INFO - Downloading/unpacking blobuploader==1.2.4 20:31: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 20:31: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 20:31: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 20:31: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 20:31: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 20:31: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 20:31:07 INFO - Downloading blobuploader-1.2.4.tar.gz 20:31:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:31:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:31:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:31:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:31:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:31:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:31:08 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 20:31:08 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 20:31:08 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 20:31:08 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 20:31:08 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 20:31:08 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 20:31:08 INFO - Downloading docopt-0.6.1.tar.gz 20:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:31:08 INFO - Installing collected packages: blobuploader, requests, docopt 20:31:08 INFO - Running setup.py install for blobuploader 20:31:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:31:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:31:08 INFO - Running setup.py install for requests 20:31:08 INFO - Running setup.py install for docopt 20:31:08 INFO - Successfully installed blobuploader requests docopt 20:31:08 INFO - Cleaning up... 20:31:08 INFO - Return code: 0 20:31:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:31:08 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')]} 20:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:31:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:08 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')]} 20:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:31:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:08 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 0x1c07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec63b0>, '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 0x1ec72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7740>, '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': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', '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 20:31:08 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 20:31:08 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 20:31:08 INFO - Using env: {'DISPLAY': ':0', 20:31:08 INFO - 'HOME': '/home/cltbld', 20:31:08 INFO - 'LANG': 'en_US.UTF-8', 20:31:08 INFO - 'LANGUAGE': 'en_US:en', 20:31:08 INFO - 'LOGNAME': 'cltbld', 20:31:08 INFO - 'MAIL': '/var/mail/cltbld', 20:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:08 INFO - 'MOZ_NO_REMOTE': '1', 20:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:08 INFO - 'NO_EM_RESTART': '1', 20:31:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:08 INFO - 'PWD': '/builds/slave/test', 20:31:08 INFO - 'SHELL': '/bin/bash', 20:31:08 INFO - 'SHLVL': '1', 20:31:08 INFO - 'TERM': 'linux', 20:31:08 INFO - 'TMOUT': '86400', 20:31:08 INFO - 'USER': 'cltbld', 20:31:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', 20:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:08 INFO - '_': '/tools/buildbot/bin/python'} 20:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:31:09 INFO - Running setup.py (path:/tmp/pip-SmxNt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:31:09 INFO - Running setup.py (path:/tmp/pip-V6Iv5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:31:09 INFO - Running setup.py (path:/tmp/pip-sUxmkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:31:09 INFO - Running setup.py (path:/tmp/pip-8iQMCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:31:09 INFO - Running setup.py (path:/tmp/pip-5EoxlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:31:09 INFO - Running setup.py (path:/tmp/pip-QsZMAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:31:09 INFO - Running setup.py (path:/tmp/pip-VyRTNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:31:09 INFO - Running setup.py (path:/tmp/pip-ePbO9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:31:09 INFO - Running setup.py (path:/tmp/pip-LHxbEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:31:09 INFO - Running setup.py (path:/tmp/pip-5kogq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:31:09 INFO - Running setup.py (path:/tmp/pip-ekuiBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:31:09 INFO - Running setup.py (path:/tmp/pip-9KQgTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:31:10 INFO - Running setup.py (path:/tmp/pip-50u5qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:31:10 INFO - Running setup.py (path:/tmp/pip-4NdqUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:31:10 INFO - Running setup.py (path:/tmp/pip-qby3Dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:31:10 INFO - Running setup.py (path:/tmp/pip-MRHdzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:31:10 INFO - Running setup.py (path:/tmp/pip-Hj36IQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:31:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:31:10 INFO - Running setup.py install for manifestparser 20:31:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:31:10 INFO - Running setup.py install for mozcrash 20:31:10 INFO - Running setup.py install for mozdebug 20:31:10 INFO - Running setup.py install for mozdevice 20:31:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:31:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:31:10 INFO - Running setup.py install for mozfile 20:31:10 INFO - Running setup.py install for mozhttpd 20:31:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:31:11 INFO - Running setup.py install for mozinfo 20:31:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:31:11 INFO - Running setup.py install for mozInstall 20:31:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:31:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:31:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:31:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:31:11 INFO - Running setup.py install for mozleak 20:31:11 INFO - Running setup.py install for mozlog 20:31:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:31:11 INFO - Running setup.py install for moznetwork 20:31:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:31:11 INFO - Running setup.py install for mozprocess 20:31:11 INFO - Running setup.py install for mozprofile 20:31:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:31:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:31:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:31:11 INFO - Running setup.py install for mozrunner 20:31:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:31:11 INFO - Running setup.py install for mozscreenshot 20:31:11 INFO - Running setup.py install for moztest 20:31:12 INFO - Running setup.py install for mozversion 20:31:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:31:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:31:12 INFO - Cleaning up... 20:31:12 INFO - Return code: 0 20:31:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:12 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 0x1c07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec63b0>, '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 0x1ec72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7740>, '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': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', '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 20:31:12 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 20:31:12 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 20:31:12 INFO - Using env: {'DISPLAY': ':0', 20:31:12 INFO - 'HOME': '/home/cltbld', 20:31:12 INFO - 'LANG': 'en_US.UTF-8', 20:31:12 INFO - 'LANGUAGE': 'en_US:en', 20:31:12 INFO - 'LOGNAME': 'cltbld', 20:31:12 INFO - 'MAIL': '/var/mail/cltbld', 20:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:12 INFO - 'MOZ_NO_REMOTE': '1', 20:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:12 INFO - 'NO_EM_RESTART': '1', 20:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:12 INFO - 'PWD': '/builds/slave/test', 20:31:12 INFO - 'SHELL': '/bin/bash', 20:31:12 INFO - 'SHLVL': '1', 20:31:12 INFO - 'TERM': 'linux', 20:31:12 INFO - 'TMOUT': '86400', 20:31:12 INFO - 'USER': 'cltbld', 20:31:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', 20:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:12 INFO - '_': '/tools/buildbot/bin/python'} 20:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:31:12 INFO - Running setup.py (path:/tmp/pip-ZfqHIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:31:12 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)) 20:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:31:12 INFO - Running setup.py (path:/tmp/pip-nSWuGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:31:12 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)) 20:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:31:12 INFO - Running setup.py (path:/tmp/pip-rYxndd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:31:12 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)) 20:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:31:12 INFO - Running setup.py (path:/tmp/pip-j2KP0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:31:12 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)) 20:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:31:12 INFO - Running setup.py (path:/tmp/pip-h0A9yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:31:12 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)) 20:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:31:12 INFO - Running setup.py (path:/tmp/pip-43S_s5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:31:12 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)) 20:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:31:12 INFO - Running setup.py (path:/tmp/pip-AtKOnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:31:12 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)) 20:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:31:12 INFO - Running setup.py (path:/tmp/pip-bsVEDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:31:12 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)) 20:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:31:12 INFO - Running setup.py (path:/tmp/pip-PHVSy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:31:13 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)) 20:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:31:13 INFO - Running setup.py (path:/tmp/pip-Xx2xHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:31:13 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)) 20:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:31:13 INFO - Running setup.py (path:/tmp/pip-21yCck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:31:13 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)) 20:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:31:13 INFO - Running setup.py (path:/tmp/pip-O_wCY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:31:13 INFO - Running setup.py (path:/tmp/pip-S9prnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:31:13 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)) 20:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:31:13 INFO - Running setup.py (path:/tmp/pip-n0JOxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:31:13 INFO - Running setup.py (path:/tmp/pip-3ulzZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:31:13 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)) 20:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:31:13 INFO - Running setup.py (path:/tmp/pip-dRb1xM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:31:13 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)) 20:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:31:13 INFO - Running setup.py (path:/tmp/pip-YLGzSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:31:13 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)) 20:31:13 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)) 20:31:13 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)) 20:31:13 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)) 20:31:13 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)) 20:31:13 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)) 20:31:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:31:13 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 20:31:13 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 20:31:13 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 20:31:13 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 20:31:13 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 20:31:13 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 20:31:15 INFO - Downloading blessings-1.6.tar.gz 20:31:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:31:15 INFO - Installing collected packages: blessings 20:31:15 INFO - Running setup.py install for blessings 20:31:15 INFO - Successfully installed blessings 20:31:15 INFO - Cleaning up... 20:31:15 INFO - Return code: 0 20:31:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:31:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:31:15 INFO - Reading from file tmpfile_stdout 20:31:15 INFO - Current package versions: 20:31:15 INFO - argparse == 1.2.1 20:31:15 INFO - blessings == 1.6 20:31:15 INFO - blobuploader == 1.2.4 20:31:15 INFO - docopt == 0.6.1 20:31:15 INFO - functools32 == 3.2.3-2 20:31:15 INFO - jsonschema == 2.5.1 20:31:15 INFO - manifestparser == 1.1 20:31:15 INFO - mozInstall == 1.12 20:31:15 INFO - mozcrash == 0.17 20:31:15 INFO - mozdebug == 0.1 20:31:15 INFO - mozdevice == 0.48 20:31:15 INFO - mozfile == 1.2 20:31:15 INFO - mozhttpd == 0.7 20:31:15 INFO - mozinfo == 0.9 20:31:15 INFO - mozleak == 0.1 20:31:15 INFO - mozlog == 3.2 20:31:15 INFO - moznetwork == 0.27 20:31:15 INFO - mozprocess == 0.23 20:31:15 INFO - mozprofile == 0.28 20:31:15 INFO - mozrunner == 6.12 20:31:15 INFO - mozscreenshot == 0.1 20:31:15 INFO - mozsystemmonitor == 0.3 20:31:15 INFO - moztest == 0.7 20:31:15 INFO - mozversion == 1.4 20:31:15 INFO - psutil == 3.1.1 20:31:15 INFO - requests == 1.2.3 20:31:15 INFO - wsgiref == 0.1.2 20:31:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:15 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 0x1c07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec63b0>, '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 0x1ec72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7740>, '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': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', '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 20:31:15 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 20:31:15 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 20:31:15 INFO - Using env: {'DISPLAY': ':0', 20:31:15 INFO - 'HOME': '/home/cltbld', 20:31:15 INFO - 'LANG': 'en_US.UTF-8', 20:31:15 INFO - 'LANGUAGE': 'en_US:en', 20:31:15 INFO - 'LOGNAME': 'cltbld', 20:31:15 INFO - 'MAIL': '/var/mail/cltbld', 20:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:15 INFO - 'MOZ_NO_REMOTE': '1', 20:31:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:15 INFO - 'NO_EM_RESTART': '1', 20:31:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:15 INFO - 'PWD': '/builds/slave/test', 20:31:15 INFO - 'SHELL': '/bin/bash', 20:31:15 INFO - 'SHLVL': '1', 20:31:15 INFO - 'TERM': 'linux', 20:31:16 INFO - 'TMOUT': '86400', 20:31:16 INFO - 'USER': 'cltbld', 20:31:16 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', 20:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:16 INFO - '_': '/tools/buildbot/bin/python'} 20:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:31:16 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)) 20:31:16 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)) 20:31:16 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)) 20:31:16 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)) 20:31:16 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)) 20:31:16 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)) 20:31:16 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)) 20:31:16 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)) 20:31:16 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)) 20:31:16 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)) 20:31:16 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)) 20:31:16 INFO - Cleaning up... 20:31:16 INFO - Return code: 0 20:31:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:31:16 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')]} 20:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:31:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:16 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')]} 20:31:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:31:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:16 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 0x1c07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec63b0>, '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 0x1ec72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7740>, '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': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', '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 20:31:16 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 20:31:16 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 20:31:16 INFO - Using env: {'DISPLAY': ':0', 20:31:16 INFO - 'HOME': '/home/cltbld', 20:31:16 INFO - 'LANG': 'en_US.UTF-8', 20:31:16 INFO - 'LANGUAGE': 'en_US:en', 20:31:16 INFO - 'LOGNAME': 'cltbld', 20:31:16 INFO - 'MAIL': '/var/mail/cltbld', 20:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:16 INFO - 'MOZ_NO_REMOTE': '1', 20:31:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:16 INFO - 'NO_EM_RESTART': '1', 20:31:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:16 INFO - 'PWD': '/builds/slave/test', 20:31:16 INFO - 'SHELL': '/bin/bash', 20:31:16 INFO - 'SHLVL': '1', 20:31:16 INFO - 'TERM': 'linux', 20:31:16 INFO - 'TMOUT': '86400', 20:31:16 INFO - 'USER': 'cltbld', 20:31:16 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', 20:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:16 INFO - '_': '/tools/buildbot/bin/python'} 20:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:31:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:31:16 INFO - Cleaning up... 20:31:16 INFO - Return code: 0 20:31:16 INFO - Running post-action listener: _resource_record_post_action 20:31:16 INFO - Running post-action listener: _start_resource_monitoring 20:31:16 INFO - Starting resource monitoring. 20:31:16 INFO - ##### 20:31:16 INFO - ##### Finished create-virtualenv step (success) 20:31:16 INFO - ##### 20:31:16 INFO - ##### 20:31:16 INFO - ##### Running install step. 20:31:16 INFO - ##### 20:31:16 INFO - Running pre-action listener: _resource_record_pre_action 20:31:16 INFO - Running main action method: install 20:31:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:31:16 INFO - Reading from file tmpfile_stdout 20:31:16 INFO - Detecting whether we're running mozinstall >=1.0... 20:31:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:31:16 INFO - Reading from file tmpfile_stdout 20:31:16 INFO - Output received: 20:31:16 INFO - Usage: mozinstall [options] installer 20:31:16 INFO - Options: 20:31:16 INFO - -h, --help show this help message and exit 20:31:16 INFO - -d DEST, --destination=DEST 20:31:16 INFO - Directory to install application into. [default: 20:31:16 INFO - "/builds/slave/test"] 20:31:16 INFO - --app=APP Application being installed. [default: firefox] 20:31:16 INFO - mkdir: /builds/slave/test/build/application 20:31:16 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'] 20:31:16 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 20:31:33 INFO - Reading from file tmpfile_stdout 20:31:33 INFO - Output received: 20:31:33 INFO - /builds/slave/test/build/application/firefox/firefox 20:31:33 INFO - Running post-action listener: _resource_record_post_action 20:31:33 INFO - ##### 20:31:33 INFO - ##### Finished install step (success) 20:31:33 INFO - ##### 20:31:33 INFO - ##### 20:31:33 INFO - ##### Running run-tests step. 20:31:33 INFO - ##### 20:31:33 INFO - Running pre-action listener: _resource_record_pre_action 20:31:33 INFO - Running main action method: run_tests 20:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:31:33 INFO - Python 2.7.3 20:31:33 INFO - Return code: 0 20:31:33 INFO - grabbing minidump binary from tooltool 20:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:31:33 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 0x1ec63b0>, '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 0x1ec72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:31:33 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 20:31:33 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 20:31:33 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 20:31:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:31:33 INFO - Return code: 0 20:31:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:31:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:31:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:31:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:31:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 20:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 20:31:33 INFO - Using env: {'DISPLAY': ':0', 20:31:33 INFO - 'HOME': '/home/cltbld', 20:31:33 INFO - 'LANG': 'en_US.UTF-8', 20:31:33 INFO - 'LANGUAGE': 'en_US:en', 20:31:33 INFO - 'LOGNAME': 'cltbld', 20:31:33 INFO - 'MAIL': '/var/mail/cltbld', 20:31:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:31:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:33 INFO - 'MOZ_NO_REMOTE': '1', 20:31:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:33 INFO - 'NO_EM_RESTART': '1', 20:31:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:33 INFO - 'PWD': '/builds/slave/test', 20:31:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:31:33 INFO - 'SHELL': '/bin/bash', 20:31:33 INFO - 'SHLVL': '1', 20:31:33 INFO - 'TERM': 'linux', 20:31:33 INFO - 'TMOUT': '86400', 20:31:33 INFO - 'USER': 'cltbld', 20:31:33 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468294216.572604-1455945311', 20:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:33 INFO - '_': '/tools/buildbot/bin/python'} 20:31:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 20:31:34 INFO - mozversion application_buildid: 20160711173007 20:31:34 INFO - mozversion application_changeset: f87c66fa12c635e07cd071dbfb9646258b7896d2 20:31:34 INFO - mozversion application_display_name: Nightly 20:31:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:31:34 INFO - mozversion application_name: Firefox 20:31:34 INFO - mozversion application_remotingname: firefox 20:31:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:31:34 INFO - mozversion application_vendor: Mozilla 20:31:34 INFO - mozversion application_version: 50.0a1 20:31:34 INFO - mozversion platform_buildid: 20160711173007 20:31:34 INFO - mozversion platform_changeset: f87c66fa12c635e07cd071dbfb9646258b7896d2 20:31:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:31:34 INFO - mozversion platform_version: 50.0a1 20:31:34 INFO - using testdate: 1468294294 20:31:34 INFO - actual date: 1468294294 20:31:34 INFO - starting webserver on 'localhost:39734' 20:31:34 INFO - SUITE-START | Running 2 tests 20:31:34 INFO - TEST-START | dromaeo_css 20:31:34 INFO - operating with platform_type : linux_ 20:31:34 INFO - Initialising browser for dromaeo_css test... 20:31:34 INFO - TEST-INFO | started process 12635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnma3n4/profile http://localhost:39734/getInfo.html) 20:31:40 INFO - PROCESS | 12635 | __metrics Screen width/height:1600/1200 20:31:40 INFO - PROCESS | 12635 | colorDepth:24 20:31:40 INFO - PROCESS | 12635 | Browser inner width/height: 1024/697 20:31:40 INFO - PROCESS | 12635 | __metrics 20:31:41 ERROR - PROCESS | 12635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 20:31:42 INFO - TEST-INFO | 12635: exit 0 20:31:42 INFO - Browser initialized. 20:31:42 INFO - Running cycle 1/1 for dromaeo_css test... 20:31:42 INFO - TEST-INFO | started process 12758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnma3n4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:31:54 INFO - PROCESS | 12758 | RSS: Main: 167440384 20:31:54 INFO - PROCESS | 12758 | 20:32:43 INFO - PROCESS | 12758 | 1468294363695 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] 20:34:52 INFO - PROCESS | 12758 | Cycle 1(1): loaded http://localhost:39734/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39734/tests/dromaeo/cssquery-ext.html) 20:34:54 INFO - PROCESS | 12758 | RSS: Main: 170610688 20:34:54 INFO - PROCESS | 12758 | 20:37:56 INFO - PROCESS | 12758 | Cycle 1(1): loaded http://localhost:39734/tests/dromaeo/cssquery-ext.html (next: http://localhost:39734/tests/dromaeo/cssquery-jquery.html) 20:37:56 INFO - PROCESS | 12758 | RSS: Main: 168734720 20:37:56 INFO - PROCESS | 12758 | 20:40:58 INFO - PROCESS | 12758 | Cycle 1(1): loaded http://localhost:39734/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39734/tests/dromaeo/cssquery-mootools.html) 20:40:59 INFO - PROCESS | 12758 | RSS: Main: 171458560 20:40:59 INFO - PROCESS | 12758 | 20:44:01 INFO - PROCESS | 12758 | Cycle 1(1): loaded http://localhost:39734/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39734/tests/dromaeo/cssquery-prototype.html) 20:44:01 INFO - PROCESS | 12758 | RSS: Main: 166907904 20:44:01 INFO - PROCESS | 12758 | 20:47:04 INFO - PROCESS | 12758 | Cycle 1(1): loaded http://localhost:39734/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39734/tests/dromaeo/cssquery-yui.html) 20:47:05 INFO - PROCESS | 12758 | RSS: Main: 169373696 20:47:05 INFO - PROCESS | 12758 | 20:50:07 INFO - PROCESS | 12758 | Cycle 1(1): loaded http://localhost:39734/tests/dromaeo/cssquery-yui.html (next: http://localhost:39734/tests/dromaeo/cssquery-dojo.html) 20:50:07 INFO - PROCESS | 12758 | RSS: Main: 170291200 20:50:07 INFO - PROCESS | 12758 | 20:50:07 INFO - PROCESS | 12758 | __start_tp_report 20:50:07 INFO - PROCESS | 12758 | _x_x_mozilla_page_load 20:50:07 INFO - PROCESS | 12758 | _x_x_mozilla_page_load_details 20:50:07 INFO - PROCESS | 12758 | |i|pagename|runs| 20:50:07 INFO - PROCESS | 12758 | |0;dojo.html;3102.1469095998596;3118.9220269493267;3140.13646247282;3146.103360542246;3157.621085469744;5630.634008789426;5652.09566469365;5653.547716182706;5672.886542269152;5713.771449142029;5450.04624190767;5615;5672.829815105543;5686.5735069869825;5746.396628354026;5016.27264046713;5044.924326135111;5073.594112471012;5186.5850731941355;5201.323827902367;5085.847424577269;5231.816886408977;5253.028189784883;5270.209468579706;5286.497782710656;5038.722870242135;5095.439501654815;5110.8466745997675;5116.258142569344;5119.38567371914;5127.359080114986;5132.076226279269;5139.794408223666;5141.485851414866;5151.974240128813;5057.418396884369;5091.9236211456855;5133.640645154841;5148.0476111919415;5156;5438.347398312228;5447.891042179174;5455.563554915597;5463.371712253102;5615.382307946123;6030.909536356959;6031.819045428644;6035.547333949971;6051.1225872248715;6093.725782339805;6033.78881739137;6051.969740151271;6068.544859135583;6090.604110732788;6103;5502.724863756796;5529.060059789846;5575.080111781592;5634.971825140848;5639.351474580476;6121.296050954108;6122.908156377658;6155.076738489262;6160.414760597736;6170.50635949123;5902.61632993854;5937.050071988461;5940.960331941893;5951.4048595141;5956.225690660186;5799.449052340021;5930.495907847881;5988.610740301867;5991.700414979234;6048.576599637983;5828;5944.435278648608;5946.85132871673;5954.434328738763;6003.399660034049;6033.456988871023;6036.0644100164545;6037.486813620803;6072.36240194782;6075.605085669506;4405.207062728739;4529;4559.202139625619;4567.292069729131;4609.723416595015;4014.4580481634607;4022.1553473770837;4028.4561584186345;4038.0914294283552;4073.205724883619;5793.594448388657;5796.275465566804;5797.333306669702;5800.477956983892;5803.303603567599;5895.823125306248;6017.0974353846395;6060.303065147565;6099.69501524922;6143.938560614337;5727.6826329943515;5788.044972579477;5805.187273781674;5825.7378417971295;5836.299644042742;5037.420696619935;5255.973720131375;5258.474152584711;5259.447757985433;5267.1309233976735;6095.408112664863;6121.666376154749;6145;6228.813135606029;6249.593776404519;5997.940020599738;5999.940000599938;6010.7295171716505;6016.157737916783;6054.7275372607455;6126.693665316628;6148.9692551536955;6228.190335256388;6232.688365581612;6235.438810507076;5879.676617786063;5942.316633587193;5954.225950626391;5954.46409823118;5999.370066143167;6036.698165091816;6046.697665116814;6094.238220222473;6101.389861013863;6111.113888486234;5778.537716982715;5856.648601083949;5890.646561206341;5971;6005.759769609167;5741;5755.798547050833;5756.769729210785;5806.245188125686;5957.672328022;5718.313802343745;5730.799422020209;5736.971315143398;5743;5759.798407055733;5752.367239603556;5836.328822185503;5852.795152169653;5855.121731740273;5935.317438494629;5781.046127389102;5802.622829516068;5811.941880581309;5827.358990510956;5871.7651293947765 20:50:07 INFO - PROCESS | 12758 | |1;ext.html;546.3405266569049;587.5798803855242;594.8334466349422;603.532262496565;625.9061140828873;38147.75744061755;42213;42351.99999999996;42432.363514547265;42436.57563424365;42685.57314426855;42962.57037429625;43034.13931721372;43166;43207.56792432075;8731.563421828914;8859.911400885972;8888.60001299943;8902.777430564256;8909.509976951265;8795.164459376349;8800.691975780848;8891.932968043844;8892.866607000868;8907.643694252254;8865.290776737846;8970.327225458084;8980.146886045815;8996.100389960984;9015.594298256561;8818.69134580293;8859.95570022149;8866.024737278927;8893.288536917064;8927.285817134678;8781.560921953876;8784.956075219583;8829;8840.911590884138;8845.823083538358;41479.37780933289;41877.371839422434;41912.37131443031;41949.58050419487;42084;3423.246885685145;3725.6088110748524;3749.718771092179;3760.774353538769;4393.077453734688;32582.6741732582;32887.34225315504;32920.670793292236;33483;34546.48180277298;4460.6208472279895;4488.5960263576435;4594.058218065322;4608.9308660370125;4674.32222327764;370589;371249;372982;374712;375401.99999999726;34369.65630343714;35199.82400087983;35430.645693542734;56550.43449565534;56621;36707.63292367096;36845.26309473849;36947.815260924064;36978.815105924834;37017.62982370142;15564.844351556567;15612.063276203464;15695.843041569666;15850.52448426549;15884.841151588567;13369.532066377824;13423.798643020362;13451.529196478272;13474.797878031837;13488.730225395437;8448.831023379498;8459.323254139654;8477.915220847835;8499.107593702573;8554.486730796049;3287.342531493711;3289.079057863802;3312.9006129816144;3329.3840639481773;3373.1735724747105;999.6601155607128;1040.921930855189;1045.0803293102022;1095.5289225633055;1108.8669359676728;32800.50799238013;32958.835205824296;33247.335053299284;33502.49746253808;33885.32229355448;1134.8638163420442;1176.082655528689;1200.1059210887945;1203.5907791350808;1234.9073819463576;17046.829531704523;17122.657546848994;17277.91361043212;17331.4800555981;17473.38843140484;633724;637432;637797;644698;649275;58146.7092664534;58330.12504812431;58656;58692;58984.871059025456;1361.4418088583832;1367.5350380870552;1368.8494265630773;1388.1324172392053;1400.880925121376;30885.227869303446;32171;32434.513482297312;32906.68231993385;33008.66991330152;49810.75094624504;49973.250401243284;50235.49764502308;50395.748021261126;50486.74756626193;468120;476872;478184.65446036676;482518;483515;27054.594181087694;27881.860590696917;28065.158045258675;28166.85916570404;28374.43251135007;47760.28359574539;47766.761166193945;48706.02587948292;49038.50961490339;49059.5094049055;39660.60339396569;39891.20489578034;41173.79413102915;41482.1703565921;41528;41519.58480415157;41764;41831.37252941269;42293.577064230194;43345;41537.58462415337;42620.57379426166;42720.78639606782;43027.56972430235;43197.13605727805;33195.66804332023;34501.482477763355;34502.30995380028;34520.2966743751;34767;28240;29254.7074529252;29311;29377.265568360963;29429.411411772075 20:50:07 INFO - PROCESS | 12758 | |2;jquery.html;392.78200598667746;395.92675355059333;396.4113291761731;397.7851959941632;421.59948049353125;14120.435182592684;18451.169697363617;19036.524086897836;20127.899360503212;20234.494137646565;18961.62076758464;18985.905070474662;19191.080891910802;19878.403647890587;19928.9003554982;5574.275344205268;5613.494785469307;5708.08670612702;5744.79893203738;5752.942470575304;5529.391766905637;5577.498025177733;5593.74828132735;5645.181448689958;5653.802116925908;5567.164925261223;5619.690916999563;5626.578006649518;5628.634138780986;5632.493075623193;5427.891442171154;5538.169274608821;5541.196526503634;5578.191162281487;5610.887782244353;5000.89998200034;5088.847334579968;5089.287499750038;5091.389033315989;5094.31226784383;23009.53980920372;23196;24266.514669706507;24571.63142552863;24614.384640383956;2448.4001419652122;2449.1795248591743;2552.5660637691453;2568.563344231485;3065.5401689746495;14709.70580588393;15188.46840360582;15223.162726050063;15342.156181410019;15641.452549160726;1912.9713054304198;1916.549610841465;1943.9028048597513;2006.5384961458947;2006.7190593316948;86408;88656;90219.54890225573;90531.75229513612;91253;10400.271980961412;10651.84022239667;10664.360138391721;10911.890881091247;11141.387223702612;14820.258987050604;14838.851611483962;14912.030718003294;14928.02967807089;15015.849841501664;7967.681292748225;8049.758507244792;8186.83626327482;8277.006759188936;8384.580770961427;7999.400044996532;8011.038675358995;8089.433739638169;8155.10293867674;8220.383471239562;6503.382178693017;6630.552546045485;6646.700898459581;6652.833679157963;6706.362895525015;1934.4680212941553;1970.7927121623873;1979.6337677529702;1983.5140390604106;1984.6526857799827;940.3981451870808;959.8848138223458;975.2539307429822;1060.379677888444;1067.7170549804307;20329.186832526535;20726.48183795387;20730.585388292453;20993.790062099488;21074.15703371848;1022.5858527296457;1026.594495174402;1028.4343611013912;1034.5706531789374;1037.8598889150019;11311.886881131248;11843.88156118445;11894.643160705193;11960.521579136912;12029.75940481203;473231;478200;479345;481376;485105;53107.468925310255;81562;83401;84133;85133;1018.3787889387468;1035.808375450529;1039.1271332081087;1053.146950969717;1064.2762921213648;17800.46598602044;18104;18672.813271867108;18777.624447511247;18804.341848035252;41022.38466423066;41803.58196417997;41992.58007420009;42261.78869105635;42740.78629606832;53388;55825;56604.15093773515;56727;56839.147412789665;7480.738174163878;7858.253465920957;8659.567021648767;8762.167594078552;9013.459192448474;13825.308734563432;13847.30763461843;14067.577972660836;14309.713805724035;14412.495562655256;12526.812097818722;12568.622941311774;12696.555620553236;12785.232886026868;12878.613641590768;10722.303050301705;10962.890371096188;11402.771944561227;11574.826377604175;11893.702657433634;12053.57812476559;12209.389530523616;12446.128770985944;12538.561150359694;12863.421146048264;7520.172780993977;8119.188081191834;8143.42995990275;8210.425270231026;8381.078081410918;12290.877091228973;12403.379831008593;12412.19320744185;12719.300438475602;12722.809157862825 20:50:07 INFO - PROCESS | 12758 | |3;mootools.html;1490.4336352186172;1498.4380857178558;1662.900225986441;1741.6168442942549;1792.7579776730129;8125.91874081259;8593.828123437528;8928.973168085671;9556.187724043455;9568.995255498168;8602.784930376729;8747.825043499126;8984.91015089849;8993.640254389833;9092.045335239787;2295.4490922178684;2354.376090336062;2355.3287313115766;2370.040133745827;2374.8100151987887;2354.564405584964;2387.6776635154292;2397.1609936522163;2415.04605680756;2432.9513409731794;2388.52229554089;2403.0868270057354;2408.2895545814026;2415.9758402416014;2429.0648100481353;2328.883555822219;2331.335569362732;2333.7782910623464;2347.835651504395;2354.9764502355015;2304.9308520744403;2323.8373313868037;2333.1134169015836;2340.403197184724;2341.4380548668196;9207.76980575491;9234.353595248336;9307.627694892197;9312.534373281309;9315.76710582234;5337.8131765388025;5416;5509.311336082989;5523.751431185566;5528.668279903219;3527.2063785648024;3547.3614749345106;3597.6762091411897;3609.8917032489067;3615.168511242429;1164.5807509296646;1173.1904985560022;1250.699832040313;1270.4727538071688;1271.1991445389438;12880.162789418751;13042.934785326108;13073.08488405812;13116.27860467674;13125.606231812966;4713.481517033124;4721.3287070605975;4794.976025119852;4852.611791056707;4908.852734417973;10908.636420447445;10992.890071099346;11025.338479691245;11042.613508527164;11045.83431248532;5534.612577119644;5592.97203513988;5598.188262701886;5603.495685388253;5606.327240731139;4352.368906508538;4844.927326090112;5004.324416203839;5038.168702164176;5127.051495473349;4133.111381053088;4144.958550414518;4150.543440221573;4153.1070819773895;4182.019801192467;1307.8692130787035;1356.4370786123648;1367.3163418290856;1367.911085779441;1371.7942308653583;869.2741560796679;918.5407296351824;936.283742936654;940.8165407745424;968.6125549780145;6182.319944806068;6208.1308616793685;6231.813045608639;6277.654728989858;6283.3035080528;959.2182371367313;960.7021823234819;974.8391515400021;996.2826764729383;1020.1838529176629;4256.7445953242905;4306.418633484503;4383.802728877208;4400.889977750518;4404.779761012001;11183.384913829817;11456.369899655432;11558.479868405942;11560.421978901022;11582.768344633228;10737.355758654505;11088.112950963903;11148.609798657008;11522.423878806027;11553.36456494884;8339.20777526134;8510.36172287081;8529.147085291544;8580;8587.22714955657;6053.364396738455;6316.905246421215;6317.652529110759;6372.330905254881;6398.656282180794;10037.096661300518;10309.22680798958;10425.687229383131;10545.894541054799;10609.045185933302;10638.84041739359;10841.620543280947;10874.728131796768;10948.890511094787;10989;7111.53775004623;7830.804229894298;7869.370450364072;7908;7941.166177551274;8718.476891386537;8768.473891566526;8799.780005499913;8843.425177363451;8903;7715.498492597963;7774.144844067035;7991.200879911962;8011.679532818622;8298.08721040673;8112.75661730149;8137.471064380797;8203.548804815793;8232.876506852523;8318.334533237448;7215.855682886207;7254.310840470147;7328.083989501312;7344.192138864827;7362.6318684066655;5346.705931173823;5374.11327131019;5392.379876314274;5398.676079435247;5431.158170483582;5376.0591896418755;5386.730663466889;5398.4871437213405;5508.531774799187;5533.280673512579 20:50:07 INFO - PROCESS | 12758 | |4;prototype.html;295.62750933823384;300.64674008040555;301.39419766269793;318.75137392833585;321.9839008049597;5496.587755918312;5513.2005859150395;5643.435656434354;5690.3171619405675;5748.942510574893;5542.806001789938;5568.3596386415575;5569.331680198382;5580.130656230158;5582.218489411485;4381.627561657263;4396.538363471837;4424.203643344197;4426.557344265564;4432.3794668746405;4093.9151124951914;4280.657547396217;4290.163418133465;4429.402030725859;4440.777961101948;4230.619244268015;4249.065205654751;4250.236151996917;4259.084296876171;4286.785660716967;4286.828526858938;4295.153084173804;4297.914041719179;4316.805743741539;4331.848385306531;3533.381658209803;3749.3063783199923;3759.0414444316525;3763;3772.5661548921953;5485.396606373296;5485.9725701371235;5502.046773395427;5527.226188333637;5541.224228607998;4912.238603016538;4919.409670839522;4924.113659541281;4939.160342741707;4950.405951285833;5613.410591887875;5877.412258774131;5885.204527849281;5906.527477801766;5958.705898229169;4073.572274911151;4078.755274683499;4079.6124368185274;4092.2224777292518;4138.151678905817;6087.665178415185;6119.632822030692;6124.724387402578;6158.9692051539905;6163.414475624809;4038.8990275243355;4110.383442483651;4119.196756632487;4140.544540100586;4175.227582897173;4183.895402614898;4201.222773786859;4205.705600607989;4215.283401821697;4230.661547076288;4856.854294371175;4857.587105096107;4870.732109733999;4883.267509873476;4912.901741965141;5662.348829884533;5910.763569457259;5922.555808314393;5952.523798096142;6002.688964748603;1450.4633285684365;1462.2469428244463;1464.6265202373327;1466.7579849324954;1468.6108181331956;877.9824403511894;911.129870973219;919.1268295119663;926.9073092690677;931.4737173496952;5043.268726034705;5050.292958985745;5052.898942021213;5097.006083813695;5152.355955505562;5308.973455132699;5319.787208511693;5405.756675964551;5453.682185071329;5479.53423958968;5122.487751224848;5146.511081447256;5154.355705536808;5382.2464854920345;5820;3227.967720322814;3255.674432556773;3275.721563667067;3277.6558461361215;3283.967160328414;6149.692515374213;6338.429541341209;6397.26431460388;6402.295747467775;6416.711247993851;6158.274244082355;6225.875482490324;6232.657203853741;6252.499800015988;6262.810066087429;6380.776672816429;6385.265694445198;6386.297507274289;6388.1376014237485;6406.903896441557;5884.734782021886;6081.331053584014;6084.817455476343;6124.785632503019;6131.049687298476;6042.969785151222;6060.878782424415;6074.787382441594;6084.718230663501;6090.482309003607;6032.095185722177;6184.567080304336;6284.5600807943;6290.672451193088;6295.653739044396;4258.40382346478;4337.652987761035;4348.391225228407;4368.890777730582;4381.912361752811;6115.84710382244;6118.296395914527;6131.662758548323;6133.38666133401;6202.81391558254;5804.564657650609;5893.351731309638;6005;6022.608530445507;6024.277086749618;5916.970415147896;5952.553558483044;5970.671438139042;5978.730957107027;5980.910286345621;5729.512991395778;5862.296524417097;5931.013110607994;5940.910886336622;5977.402259773988;5962.52299816005;5969.522438204846;5973.761049557969;6005.879882402415;6040.607360521552;5805.593608447368;5810;5818.050952930816;5839.766409343579;5885.55858310637 20:50:07 INFO - PROCESS | 12758 | |5;yui.html;737.9188289288178;777.5257093173163;819.2258315891484;823.1480417767611;827.7309874290856;15399.69200615987;15806.13066281354;15814.841851581496;15844.445444409448;15858.524244272676;12109.15235933485;14965.775513367282;15142.394304227846;15143.848561514382;15150.090994540335;788.0543347982415;811.5942028985507;811.663159788687;813.4631143445328;813.9348852091819;795.9482633628825;807.0557447786105;807.2411932783194;807.289585165054;808.8301456694102;852.6333676519095;854.0520022774715;855.0893298636931;855.7646647172015;857.2028013947026;853.9444936079135;855.5209082913589;855.7304449098576;855.9101294364095;857.8455877941968;613.1997742945455;613.9785107521216;616.4113271825396;616.7193926763312;621.8321053315625;15274.38902443901;15280;15328.846711532853;15355.692886142326;15367.692646147014;15553;15852.52442426729;15966.201689915457;16296.103714295708;16320.75518867218;12027.93986030073;12304.81542776859;12365.137348771428;12413.193142445713;12416.937915310365;3861.420786881962;3865.4781604483314;3867.6325749053794;3911.941320880189;4018.819153138116;69312;72351.27648723498;73747.63126184334;78970;79636.60181699113;11762.294262344287;11773.293602383885;11782.351970641697;11868.821967670492;12048.578299759467;21781.237656682257;22117.33647990563;22192;22192.334229973127;22212.88893555554;9092.318076144184;9129.817403652023;9254.981951985275;9302.767430814283;9464.19554337889;4874.8781280467565;4906.288588154697;4930.137225985438;4988.850334489971;5006.549410553068;3623.456481527739;3714.257148570297;3749.1189570450924;3758.962410375861;3765.0963768695315;666.976655817044;672.4553111979312;677.2245778583494;688.3288793426369;703.2545501768142;760.4828716472741;770.3336613828998;826.1862065865118;826.2041776934807;829.7178959153916;9771.730069434312;10298.897011029943;10298.948505257425;10369.170466362673;10588.894111058791;706.3257705034862;739.4417215002638;785.8506883692195;794.7218473534217;811.4157806379397;4785.019071090418;5068.265101560327;5133.79464821403;5138.794448222029;5228.424873263938;123965;124879.3756031214;125631;128700;129029;85309;107202.46398767956;108768;109621.45189274162;109989.45005274922;58234.708826456445;66317;87173.5641321802;88652.5567372172;89588.6561701575;9861.309708320348;10454.42500662471;10473.476326183812;10646.787064258826;10824.079953204066;36826.63173368232;36980.81509592435;51874.48125518696;53124;53672.46327536675;50367.49632503628;54128.72935635297;61401.07898381438;61693.38306616876;79114;13687.247201404018;13821.654458638615;13915.930420348239;14044;14238.074525155831;16039.35842566331;16103.275352609395;16107.436239731553;16641.50075497737;16664.33342666328;14599.562013139623;14773.409063637335;14839.183844888636;15301.081935083484;16028.439004634782;15023.849761502244;15116.09303441797;15602.765958510405;15871.444499442465;16173.27220275067;14645.633859153606;14949;14992.700145997238;15196.088234705952;15465.690686186439;11820.586279480176;12091.39543022863;12107.227756818807;12293.815592766294;12392.938035309766;12402.75194496123;12503.249805011728;12562.560310389092;12830.29433381173;12906.677333066373 20:50:07 INFO - PROCESS | 12758 | __end_tp_report 20:50:07 INFO - PROCESS | 12758 | __start_cc_report 20:50:07 INFO - PROCESS | 12758 | _x_x_mozilla_cycle_collect,381 20:50:07 INFO - PROCESS | 12758 | __end_cc_report 20:50:07 INFO - PROCESS | 12758 | __startTimestamp1468295407833__endTimestamp 20:50:07 INFO - PROCESS | 12758 | 20:50:07 INFO - PROCESS | 12758 | ------- Summary: start ------- 20:50:07 INFO - PROCESS | 12758 | Number of tests: 6 20:50:07 INFO - PROCESS | 12758 | 20:50:07 INFO - PROCESS | 12758 | [#0] dojo.html Cycles:165 Average:5583.24 Median:5800.48 stddev:653.59 (11.3%) stddev-sans-first:625.94 20:50:07 INFO - PROCESS | 12758 | Values: 3102.1 3118.9 3140.1 3146.1 3157.6 5630.6 5652.1 5653.5 5672.9 5713.8 5450.0 5615.0 5672.8 5686.6 5746.4 5016.3 5044.9 5073.6 5186.6 5201.3 5085.8 5231.8 5253.0 5270.2 5286.5 5038.7 5095.4 5110.8 5116.3 5119.4 5127.4 5132.1 5139.8 5141.5 5152.0 5057.4 5091.9 5133.6 5148.0 5156.0 5438.3 5447.9 5455.6 5463.4 5615.4 6030.9 6031.8 6035.5 6051.1 6093.7 6033.8 6052.0 6068.5 6090.6 6103.0 5502.7 5529.1 5575.1 5635.0 5639.4 6121.3 6122.9 6155.1 6160.4 6170.5 5902.6 5937.1 5941.0 5951.4 5956.2 5799.4 5930.5 5988.6 5991.7 6048.6 5828.0 5944.4 5946.9 5954.4 6003.4 6033.5 6036.1 6037.5 6072.4 6075.6 4405.2 4529.0 4559.2 4567.3 4609.7 4014.5 4022.2 4028.5 4038.1 4073.2 5793.6 5796.3 5797.3 5800.5 5803.3 5895.8 6017.1 6060.3 6099.7 6143.9 5727.7 5788.0 5805.2 5825.7 5836.3 5037.4 5256.0 5258.5 5259.4 5267.1 6095.4 6121.7 6145.0 6228.8 6249.6 5997.9 5999.9 6010.7 6016.2 6054.7 6126.7 6149.0 6228.2 6232.7 6235.4 5879.7 5942.3 5954.2 5954.5 5999.4 6036.7 6046.7 6094.2 6101.4 6111.1 5778.5 5856.6 5890.6 5971.0 6005.8 5741.0 5755.8 5756.8 5806.2 5957.7 5718.3 5730.8 5737.0 5743.0 5759.8 5752.4 5836.3 5852.8 5855.1 5935.3 5781.0 5802.6 5811.9 5827.4 5871.8 20:50:07 INFO - PROCESS | 12758 | 20:50:07 INFO - PROCESS | 12758 | [#1] ext.html Cycles:180 Average:63511.65 Median:41797.69 stddev:136006.03 (325.4%) stddev-sans-first:136305.40 20:50:07 INFO - PROCESS | 12758 | Values: 546.3 587.6 594.8 603.5 625.9 38147.8 42213.0 42352.0 42432.4 42436.6 42685.6 42962.6 43034.1 43166.0 43207.6 8731.6 8859.9 8888.6 8902.8 8909.5 8795.2 8800.7 8891.9 8892.9 8907.6 8865.3 8970.3 8980.1 8996.1 9015.6 8818.7 8860.0 8866.0 8893.3 8927.3 8781.6 8785.0 8829.0 8840.9 8845.8 41479.4 41877.4 41912.4 41949.6 42084.0 3423.2 3725.6 3749.7 3760.8 4393.1 32582.7 32887.3 32920.7 33483.0 34546.5 4460.6 4488.6 4594.1 4608.9 4674.3 370589.0 371249.0 372982.0 374712.0 375402.0 34369.7 35199.8 35430.6 56550.4 56621.0 36707.6 36845.3 36947.8 36978.8 37017.6 15564.8 15612.1 15695.8 15850.5 15884.8 13369.5 13423.8 13451.5 13474.8 13488.7 8448.8 8459.3 8477.9 8499.1 8554.5 3287.3 3289.1 3312.9 3329.4 3373.2 999.7 1040.9 1045.1 1095.5 1108.9 32800.5 32958.8 33247.3 33502.5 33885.3 1134.9 1176.1 1200.1 1203.6 1234.9 17046.8 17122.7 17277.9 17331.5 17473.4 633724.0 637432.0 637797.0 644698.0 649275.0 58146.7 58330.1 58656.0 58692.0 58984.9 1361.4 1367.5 1368.8 1388.1 1400.9 30885.2 32171.0 32434.5 32906.7 33008.7 49810.8 49973.3 50235.5 50395.7 50486.7 468120.0 476872.0 478184.7 482518.0 483515.0 27054.6 27881.9 28065.2 28166.9 28374.4 47760.3 47766.8 48706.0 49038.5 49059.5 39660.6 39891.2 41173.8 41482.2 41528.0 41519.6 41764.0 41831.4 42293.6 43345.0 41537.6 42620.6 42720.8 43027.6 43197.1 33195.7 34501.5 34502.3 34520.3 34767.0 28240.0 29254.7 29311.0 29377.3 29429.4 20:50:07 INFO - PROCESS | 12758 | 20:50:07 INFO - PROCESS | 12758 | [#2] jquery.html Cycles:180 Average:28823.72 Median:2448.79 stddev:78936.15 (3223.5%) stddev-sans-first:79128.72 20:50:07 INFO - PROCESS | 12758 | Values: 392.8 395.9 396.4 397.8 421.6 14120.4 18451.2 19036.5 20127.9 20234.5 18961.6 18985.9 19191.1 19878.4 19928.9 5574.3 5613.5 5708.1 5744.8 5752.9 5529.4 5577.5 5593.7 5645.2 5653.8 5567.2 5619.7 5626.6 5628.6 5632.5 5427.9 5538.2 5541.2 5578.2 5610.9 5000.9 5088.8 5089.3 5091.4 5094.3 23009.5 23196.0 24266.5 24571.6 24614.4 2448.4 2449.2 2552.6 2568.6 3065.5 14709.7 15188.5 15223.2 15342.2 15641.5 1913.0 1916.5 1943.9 2006.5 2006.7 86408.0 88656.0 90219.5 90531.8 91253.0 10400.3 10651.8 10664.4 10911.9 11141.4 14820.3 14838.9 14912.0 14928.0 15015.8 7967.7 8049.8 8186.8 8277.0 8384.6 7999.4 8011.0 8089.4 8155.1 8220.4 6503.4 6630.6 6646.7 6652.8 6706.4 1934.5 1970.8 1979.6 1983.5 1984.7 940.4 959.9 975.3 1060.4 1067.7 20329.2 20726.5 20730.6 20993.8 21074.2 1022.6 1026.6 1028.4 1034.6 1037.9 11311.9 11843.9 11894.6 11960.5 12029.8 473231.0 478200.0 479345.0 481376.0 485105.0 53107.5 81562.0 83401.0 84133.0 85133.0 1018.4 1035.8 1039.1 1053.1 1064.3 17800.5 18104.0 18672.8 18777.6 18804.3 41022.4 41803.6 41992.6 42261.8 42740.8 53388.0 55825.0 56604.2 56727.0 56839.1 7480.7 7858.3 8659.6 8762.2 9013.5 13825.3 13847.3 14067.6 14309.7 14412.5 12526.8 12568.6 12696.6 12785.2 12878.6 10722.3 10962.9 11402.8 11574.8 11893.7 12053.6 12209.4 12446.1 12538.6 12863.4 7520.2 8119.2 8143.4 8210.4 8381.1 12290.9 12403.4 12412.2 12719.3 12722.8 20:50:07 INFO - PROCESS | 12758 | 20:50:07 INFO - PROCESS | 12758 | [#3] mootools.html Cycles:180 Average:6047.47 Median:4848.77 stddev:3453.76 (71.2%) stddev-sans-first:3446.47 20:50:07 INFO - PROCESS | 12758 | Values: 1490.4 1498.4 1662.9 1741.6 1792.8 8125.9 8593.8 8929.0 9556.2 9569.0 8602.8 8747.8 8984.9 8993.6 9092.0 2295.4 2354.4 2355.3 2370.0 2374.8 2354.6 2387.7 2397.2 2415.0 2433.0 2388.5 2403.1 2408.3 2416.0 2429.1 2328.9 2331.3 2333.8 2347.8 2355.0 2304.9 2323.8 2333.1 2340.4 2341.4 9207.8 9234.4 9307.6 9312.5 9315.8 5337.8 5416.0 5509.3 5523.8 5528.7 3527.2 3547.4 3597.7 3609.9 3615.2 1164.6 1173.2 1250.7 1270.5 1271.2 12880.2 13042.9 13073.1 13116.3 13125.6 4713.5 4721.3 4795.0 4852.6 4908.9 10908.6 10992.9 11025.3 11042.6 11045.8 5534.6 5593.0 5598.2 5603.5 5606.3 4352.4 4844.9 5004.3 5038.2 5127.1 4133.1 4145.0 4150.5 4153.1 4182.0 1307.9 1356.4 1367.3 1367.9 1371.8 869.3 918.5 936.3 940.8 968.6 6182.3 6208.1 6231.8 6277.7 6283.3 959.2 960.7 974.8 996.3 1020.2 4256.7 4306.4 4383.8 4400.9 4404.8 11183.4 11456.4 11558.5 11560.4 11582.8 10737.4 11088.1 11148.6 11522.4 11553.4 8339.2 8510.4 8529.1 8580.0 8587.2 6053.4 6316.9 6317.7 6372.3 6398.7 10037.1 10309.2 10425.7 10545.9 10609.0 10638.8 10841.6 10874.7 10948.9 10989.0 7111.5 7830.8 7869.4 7908.0 7941.2 8718.5 8768.5 8799.8 8843.4 8903.0 7715.5 7774.1 7991.2 8011.7 8298.1 8112.8 8137.5 8203.5 8232.9 8318.3 7215.9 7254.3 7328.1 7344.2 7362.6 5346.7 5374.1 5392.4 5398.7 5431.2 5376.1 5386.7 5398.5 5508.5 5533.3 20:50:07 INFO - PROCESS | 12758 | 20:50:07 INFO - PROCESS | 12758 | [#4] prototype.html Cycles:180 Average:4914.84 Median:5542.02 stddev:1485.30 (26.8%) stddev-sans-first:1448.43 20:50:07 INFO - PROCESS | 12758 | Values: 295.6 300.6 301.4 318.8 322.0 5496.6 5513.2 5643.4 5690.3 5748.9 5542.8 5568.4 5569.3 5580.1 5582.2 4381.6 4396.5 4424.2 4426.6 4432.4 4093.9 4280.7 4290.2 4429.4 4440.8 4230.6 4249.1 4250.2 4259.1 4286.8 4286.8 4295.2 4297.9 4316.8 4331.8 3533.4 3749.3 3759.0 3763.0 3772.6 5485.4 5486.0 5502.0 5527.2 5541.2 4912.2 4919.4 4924.1 4939.2 4950.4 5613.4 5877.4 5885.2 5906.5 5958.7 4073.6 4078.8 4079.6 4092.2 4138.2 6087.7 6119.6 6124.7 6159.0 6163.4 4038.9 4110.4 4119.2 4140.5 4175.2 4183.9 4201.2 4205.7 4215.3 4230.7 4856.9 4857.6 4870.7 4883.3 4912.9 5662.3 5910.8 5922.6 5952.5 6002.7 1450.5 1462.2 1464.6 1466.8 1468.6 878.0 911.1 919.1 926.9 931.5 5043.3 5050.3 5052.9 5097.0 5152.4 5309.0 5319.8 5405.8 5453.7 5479.5 5122.5 5146.5 5154.4 5382.2 5820.0 3228.0 3255.7 3275.7 3277.7 3284.0 6149.7 6338.4 6397.3 6402.3 6416.7 6158.3 6225.9 6232.7 6252.5 6262.8 6380.8 6385.3 6386.3 6388.1 6406.9 5884.7 6081.3 6084.8 6124.8 6131.0 6043.0 6060.9 6074.8 6084.7 6090.5 6032.1 6184.6 6284.6 6290.7 6295.7 4258.4 4337.7 4348.4 4368.9 4381.9 6115.8 6118.3 6131.7 6133.4 6202.8 5804.6 5893.4 6005.0 6022.6 6024.3 5917.0 5952.6 5970.7 5978.7 5980.9 5729.5 5862.3 5931.0 5940.9 5977.4 5962.5 5969.5 5973.8 6005.9 6040.6 5805.6 5810.0 5818.1 5839.8 5885.6 20:50:07 INFO - PROCESS | 12758 | 20:50:07 INFO - PROCESS | 12758 | [#5] yui.html Cycles:180 Average:20955.99 Median:3731.69 stddev:30202.17 (809.3%) stddev-sans-first:30248.75 20:50:07 INFO - PROCESS | 12758 | Values: 737.9 777.5 819.2 823.1 827.7 15399.7 15806.1 15814.8 15844.4 15858.5 12109.2 14965.8 15142.4 15143.8 15150.1 788.1 811.6 811.7 813.5 813.9 795.9 807.1 807.2 807.3 808.8 852.6 854.1 855.1 855.8 857.2 853.9 855.5 855.7 855.9 857.8 613.2 614.0 616.4 616.7 621.8 15274.4 15280.0 15328.8 15355.7 15367.7 15553.0 15852.5 15966.2 16296.1 16320.8 12027.9 12304.8 12365.1 12413.2 12416.9 3861.4 3865.5 3867.6 3911.9 4018.8 69312.0 72351.3 73747.6 78970.0 79636.6 11762.3 11773.3 11782.4 11868.8 12048.6 21781.2 22117.3 22192.0 22192.3 22212.9 9092.3 9129.8 9255.0 9302.8 9464.2 4874.9 4906.3 4930.1 4988.9 5006.5 3623.5 3714.3 3749.1 3759.0 3765.1 667.0 672.5 677.2 688.3 703.3 760.5 770.3 826.2 826.2 829.7 9771.7 10298.9 10298.9 10369.2 10588.9 706.3 739.4 785.9 794.7 811.4 4785.0 5068.3 5133.8 5138.8 5228.4 123965.0 124879.4 125631.0 128700.0 129029.0 85309.0 107202.5 108768.0 109621.5 109989.5 58234.7 66317.0 87173.6 88652.6 89588.7 9861.3 10454.4 10473.5 10646.8 10824.1 36826.6 36980.8 51874.5 53124.0 53672.5 50367.5 54128.7 61401.1 61693.4 79114.0 13687.2 13821.7 13915.9 14044.0 14238.1 16039.4 16103.3 16107.4 16641.5 16664.3 14599.6 14773.4 14839.2 15301.1 16028.4 15023.8 15116.1 15602.8 15871.4 16173.3 14645.6 14949.0 14992.7 15196.1 15465.7 11820.6 12091.4 12107.2 12293.8 12392.9 12402.8 12503.2 12562.6 12830.3 12906.7 20:50:07 INFO - PROCESS | 12758 | -------- Summary: end -------- 20:50:07 INFO - PROCESS | 12758 | 20:50:08 INFO - TEST-INFO | 12758: exit 0 20:50:08 INFO - TEST-OK | dromaeo_css | took 1114477ms 20:50:08 INFO - TEST-START | kraken 20:50:08 INFO - operating with platform_type : linux_ 20:50:08 INFO - Initialising browser for kraken test... 20:50:08 INFO - TEST-INFO | started process 13002 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcdLSOV/profile http://localhost:39734/getInfo.html) 20:50:14 INFO - PROCESS | 13002 | __metrics Screen width/height:1600/1200 20:50:14 INFO - PROCESS | 13002 | colorDepth:24 20:50:14 INFO - PROCESS | 13002 | Browser inner width/height: 1024/697 20:50:14 INFO - PROCESS | 13002 | __metrics 20:50:14 ERROR - PROCESS | 13002 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 20:50:15 INFO - TEST-INFO | 13002: exit 0 20:50:15 INFO - Browser initialized. 20:50:15 INFO - Running cycle 1/1 for kraken test... 20:50:15 INFO - TEST-INFO | started process 13125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcdLSOV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:50:27 INFO - PROCESS | 13125 | RSS: Main: 167677952 20:50:27 INFO - PROCESS | 13125 | 20:50:29 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:39734/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39734/tests/kraken/driver.html?testName=audio-beat-detection) 20:50:30 INFO - PROCESS | 13125 | RSS: Main: 172929024 20:50:30 INFO - PROCESS | 13125 | 20:50:33 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:39734/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39734/tests/kraken/driver.html?testName=audio-dft) 20:50:33 INFO - PROCESS | 13125 | RSS: Main: 173228032 20:50:33 INFO - PROCESS | 13125 | 20:50:36 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:39734/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39734/tests/kraken/driver.html?testName=audio-fft) 20:50:37 INFO - PROCESS | 13125 | RSS: Main: 166899712 20:50:37 INFO - PROCESS | 13125 | 20:50:39 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:39734/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39734/tests/kraken/driver.html?testName=audio-oscillator) 20:50:40 INFO - PROCESS | 13125 | RSS: Main: 167477248 20:50:40 INFO - PROCESS | 13125 | 20:50:42 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:39734/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39734/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:50:42 INFO - PROCESS | 13125 | RSS: Main: 167964672 20:50:42 INFO - PROCESS | 13125 | 20:50:46 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:39734/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39734/tests/kraken/driver.html?testName=imaging-darkroom) 20:50:46 INFO - PROCESS | 13125 | RSS: Main: 167120896 20:50:46 INFO - PROCESS | 13125 | 20:50:50 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:39734/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39734/tests/kraken/driver.html?testName=imaging-desaturate) 20:50:50 INFO - PROCESS | 13125 | RSS: Main: 166604800 20:50:50 INFO - PROCESS | 13125 | 20:50:53 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:39734/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39734/tests/kraken/driver.html?testName=json-parse-financial) 20:50:54 INFO - PROCESS | 13125 | RSS: Main: 168214528 20:50:54 INFO - PROCESS | 13125 | 20:50:55 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:39734/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39734/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:50:56 INFO - PROCESS | 13125 | RSS: Main: 168574976 20:50:56 INFO - PROCESS | 13125 | 20:50:58 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:39734/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39734/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:50:58 INFO - PROCESS | 13125 | RSS: Main: 168226816 20:50:58 INFO - PROCESS | 13125 | 20:51:00 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:39734/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39734/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:51:01 INFO - PROCESS | 13125 | RSS: Main: 169263104 20:51:01 INFO - PROCESS | 13125 | 20:51:04 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:39734/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:51:04 INFO - PROCESS | 13125 | RSS: Main: 169136128 20:51:04 INFO - PROCESS | 13125 | 20:51:07 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:39734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:51:08 INFO - PROCESS | 13125 | RSS: Main: 169373696 20:51:08 INFO - PROCESS | 13125 | 20:51:09 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:39734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39734/tests/kraken/driver.html?testName=ai-astar) 20:51:10 INFO - PROCESS | 13125 | RSS: Main: 170168320 20:51:10 INFO - PROCESS | 13125 | 20:51:10 INFO - PROCESS | 13125 | __start_tp_report 20:51:10 INFO - PROCESS | 13125 | _x_x_mozilla_page_load 20:51:10 INFO - PROCESS | 13125 | _x_x_mozilla_page_load_details 20:51:10 INFO - PROCESS | 13125 | |i|pagename|runs| 20:51:10 INFO - PROCESS | 13125 | |0;ai-astar;102;113;105;112;111;112;111;110;110;111 20:51:10 INFO - PROCESS | 13125 | |1;audio-beat-detection;143;118;147;167;118;151;152;118;189;118 20:51:10 INFO - PROCESS | 13125 | |2;audio-dft;162;161;162;159;168;162;165;175;162;160 20:51:10 INFO - PROCESS | 13125 | |3;audio-fft;78;76;75;148;78;87;76;74;163;77 20:51:10 INFO - PROCESS | 13125 | |4;audio-oscillator;85;84;140;85;84;83;140;86;86;147 20:51:10 INFO - PROCESS | 13125 | |5;imaging-gaussian-blur;118;117;117;119;117;118;118;119;118;117 20:51:10 INFO - PROCESS | 13125 | |6;imaging-darkroom;147;147;147;147;146;147;147;148;146;147 20:51:10 INFO - PROCESS | 13125 | |7;imaging-desaturate;97;96;96;95;95;95;96;96;95;95 20:51:10 INFO - PROCESS | 13125 | |8;json-parse-financial;56;55;55;54;55;56;54;56;54;56 20:51:10 INFO - PROCESS | 13125 | |9;json-stringify-tinderbox;61;62;61;62;63;63;63;62;63;61 20:51:10 INFO - PROCESS | 13125 | |10;stanford-crypto-aes;77;77;86;76;77;82;78;77;80;77 20:51:10 INFO - PROCESS | 13125 | |11;stanford-crypto-ccm;125;126;139;123;136;129;135;129;165;124 20:51:10 INFO - PROCESS | 13125 | |12;stanford-crypto-pbkdf2;165;165;167;162;163;171;165;167;165;174 20:51:10 INFO - PROCESS | 13125 | |13;stanford-crypto-sha256-iterative;65;66;66;68;66;65;67;69;65;68 20:51:10 INFO - PROCESS | 13125 | __end_tp_report 20:51:10 INFO - PROCESS | 13125 | __start_cc_report 20:51:10 INFO - PROCESS | 13125 | _x_x_mozilla_cycle_collect,875 20:51:10 INFO - PROCESS | 13125 | __end_cc_report 20:51:10 INFO - PROCESS | 13125 | __startTimestamp1468295470121__endTimestamp 20:51:10 INFO - PROCESS | 13125 | 20:51:10 INFO - PROCESS | 13125 | ------- Summary: start ------- 20:51:10 INFO - PROCESS | 13125 | Number of tests: 14 20:51:10 INFO - PROCESS | 13125 | 20:51:10 INFO - PROCESS | 13125 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.47 (3.1%) stddev-sans-first:2.30 20:51:10 INFO - PROCESS | 13125 | Values: 102.0 113.0 105.0 112.0 111.0 112.0 111.0 110.0 110.0 111.0 20:51:10 INFO - PROCESS | 13125 | 20:51:10 INFO - PROCESS | 13125 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:149.00 stddev:24.37 (16.4%) stddev-sans-first:25.85 20:51:10 INFO - PROCESS | 13125 | Values: 143.0 118.0 147.0 167.0 118.0 151.0 152.0 118.0 189.0 118.0 20:51:10 INFO - PROCESS | 13125 | 20:51:10 INFO - PROCESS | 13125 | [#2] audio-dft Cycles:10 Average:163.60 Median:162.00 stddev:4.74 (2.9%) stddev-sans-first:4.99 20:51:10 INFO - PROCESS | 13125 | Values: 162.0 161.0 162.0 159.0 168.0 162.0 165.0 175.0 162.0 160.0 20:51:10 INFO - PROCESS | 13125 | 20:51:10 INFO - PROCESS | 13125 | [#3] audio-fft Cycles:10 Average:93.20 Median:76.50 stddev:33.22 (43.4%) stddev-sans-first:34.77 20:51:10 INFO - PROCESS | 13125 | Values: 78.0 76.0 75.0 148.0 78.0 87.0 76.0 74.0 163.0 77.0 20:51:10 INFO - PROCESS | 13125 | 20:51:10 INFO - PROCESS | 13125 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:84.50 stddev:27.91 (33.0%) stddev-sans-first:28.92 20:51:10 INFO - PROCESS | 13125 | Values: 85.0 84.0 140.0 85.0 84.0 83.0 140.0 86.0 86.0 147.0 20:51:10 INFO - PROCESS | 13125 | 20:51:10 INFO - PROCESS | 13125 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 20:51:10 INFO - PROCESS | 13125 | Values: 118.0 117.0 117.0 119.0 117.0 118.0 118.0 119.0 118.0 117.0 20:51:10 INFO - PROCESS | 13125 | 20:51:10 INFO - PROCESS | 13125 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 20:51:10 INFO - PROCESS | 13125 | Values: 147.0 147.0 147.0 147.0 146.0 147.0 147.0 148.0 146.0 147.0 20:51:10 INFO - PROCESS | 13125 | 20:51:10 INFO - PROCESS | 13125 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 20:51:10 INFO - PROCESS | 13125 | Values: 97.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 20:51:10 INFO - PROCESS | 13125 | 20:51:10 INFO - PROCESS | 13125 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.50 stddev:0.88 (1.6%) stddev-sans-first:0.87 20:51:10 INFO - PROCESS | 13125 | Values: 56.0 55.0 55.0 54.0 55.0 56.0 54.0 56.0 54.0 56.0 20:51:10 INFO - PROCESS | 13125 | 20:51:10 INFO - PROCESS | 13125 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.50 stddev:0.88 (1.4%) stddev-sans-first:0.83 20:51:10 INFO - PROCESS | 13125 | Values: 61.0 62.0 61.0 62.0 63.0 63.0 63.0 62.0 63.0 61.0 20:51:10 INFO - PROCESS | 13125 | 20:51:10 INFO - PROCESS | 13125 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:77.50 stddev:3.13 (4.0%) stddev-sans-first:3.26 20:51:10 INFO - PROCESS | 13125 | Values: 77.0 77.0 86.0 76.0 77.0 82.0 78.0 77.0 80.0 77.0 20:51:10 INFO - PROCESS | 13125 | 20:51:10 INFO - PROCESS | 13125 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:132.00 stddev:12.47 (9.4%) stddev-sans-first:12.87 20:51:10 INFO - PROCESS | 13125 | Values: 125.0 126.0 139.0 123.0 136.0 129.0 135.0 129.0 165.0 124.0 20:51:10 INFO - PROCESS | 13125 | 20:51:10 INFO - PROCESS | 13125 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:166.00 stddev:3.63 (2.2%) stddev-sans-first:3.81 20:51:10 INFO - PROCESS | 13125 | Values: 165.0 165.0 167.0 162.0 163.0 171.0 165.0 167.0 165.0 174.0 20:51:10 INFO - PROCESS | 13125 | 20:51:10 INFO - PROCESS | 13125 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:1.43 (2.2%) stddev-sans-first:1.41 20:51:10 INFO - PROCESS | 13125 | Values: 65.0 66.0 66.0 68.0 66.0 65.0 67.0 69.0 65.0 68.0 20:51:10 INFO - PROCESS | 13125 | -------- Summary: end -------- 20:51:10 INFO - PROCESS | 13125 | 20:51:11 INFO - TEST-INFO | 13125: exit 0 20:51:11 INFO - TEST-OK | kraken | took 62518ms 20:51:11 INFO - SUITE-END | took 1176s 20:51:11 INFO - Completed test suite (00:19:37) 20:51:11 INFO - javascript benchmark 20:51:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7435.220025147406, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.1469095998596, 3118.9220269493267, 3140.13646247282, 3146.103360542246, 3157.621085469744, 5630.634008789426, 5652.09566469365, 5653.547716182706, 5672.886542269152, 5713.771449142029, 5450.04624190767, 5615.0, 5672.829815105543, 5686.5735069869825, 5746.396628354026, 5016.27264046713, 5044.924326135111, 5073.594112471012, 5186.5850731941355, 5201.323827902367, 5085.847424577269, 5231.816886408977, 5253.028189784883, 5270.209468579706, 5286.497782710656, 5038.722870242135, 5095.439501654815, 5110.8466745997675, 5116.258142569344, 5119.38567371914, 5127.359080114986, 5132.076226279269, 5139.794408223666, 5141.485851414866, 5151.974240128813, 5057.418396884369, 5091.9236211456855, 5133.640645154841, 5148.0476111919415, 5156.0, 5438.347398312228, 5447.891042179174, 5455.563554915597, 5463.371712253102, 5615.382307946123, 6030.909536356959, 6031.819045428644, 6035.547333949971, 6051.1225872248715, 6093.725782339805, 6033.78881739137, 6051.969740151271, 6068.544859135583, 6090.604110732788, 6103.0, 5502.724863756796, 5529.060059789846, 5575.080111781592, 5634.971825140848, 5639.351474580476, 6121.296050954108, 6122.908156377658, 6155.076738489262, 6160.414760597736, 6170.50635949123, 5902.61632993854, 5937.050071988461, 5940.960331941893, 5951.4048595141, 5956.225690660186, 5799.449052340021, 5930.495907847881, 5988.610740301867, 5991.700414979234, 6048.576599637983, 5828.0, 5944.435278648608, 5946.85132871673, 5954.434328738763, 6003.399660034049, 6033.456988871023, 6036.0644100164545, 6037.486813620803, 6072.36240194782, 6075.605085669506, 4405.207062728739, 4529.0, 4559.202139625619, 4567.292069729131, 4609.723416595015, 4014.4580481634607, 4022.1553473770837, 4028.4561584186345, 4038.0914294283552, 4073.205724883619, 5793.594448388657, 5796.275465566804, 5797.333306669702, 5800.477956983892, 5803.303603567599, 5895.823125306248, 6017.0974353846395, 6060.303065147565, 6099.69501524922, 6143.938560614337, 5727.6826329943515, 5788.044972579477, 5805.187273781674, 5825.7378417971295, 5836.299644042742, 5037.420696619935, 5255.973720131375, 5258.474152584711, 5259.447757985433, 5267.1309233976735, 6095.408112664863, 6121.666376154749, 6145.0, 6228.813135606029, 6249.593776404519, 5997.940020599738, 5999.940000599938, 6010.7295171716505, 6016.157737916783, 6054.7275372607455, 6126.693665316628, 6148.9692551536955, 6228.190335256388, 6232.688365581612, 6235.438810507076, 5879.676617786063, 5942.316633587193, 5954.225950626391, 5954.46409823118, 5999.370066143167, 6036.698165091816, 6046.697665116814, 6094.238220222473, 6101.389861013863, 6111.113888486234, 5778.537716982715, 5856.648601083949, 5890.646561206341, 5971.0, 6005.759769609167, 5741.0, 5755.798547050833, 5756.769729210785, 5806.245188125686, 5957.672328022, 5718.313802343745, 5730.799422020209, 5736.971315143398, 5743.0, 5759.798407055733, 5752.367239603556, 5836.328822185503, 5852.795152169653, 5855.121731740273, 5935.317438494629, 5781.046127389102, 5802.622829516068, 5811.941880581309, 5827.358990510956, 5871.7651293947765], "value": 5536.787027073, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.3405266569049, 587.5798803855242, 594.8334466349422, 603.532262496565, 625.9061140828873, 38147.75744061755, 42213.0, 42351.99999999996, 42432.363514547265, 42436.57563424365, 42685.57314426855, 42962.57037429625, 43034.13931721372, 43166.0, 43207.56792432075, 8731.563421828914, 8859.911400885972, 8888.60001299943, 8902.777430564256, 8909.509976951265, 8795.164459376349, 8800.691975780848, 8891.932968043844, 8892.866607000868, 8907.643694252254, 8865.290776737846, 8970.327225458084, 8980.146886045815, 8996.100389960984, 9015.594298256561, 8818.69134580293, 8859.95570022149, 8866.024737278927, 8893.288536917064, 8927.285817134678, 8781.560921953876, 8784.956075219583, 8829.0, 8840.911590884138, 8845.823083538358, 41479.37780933289, 41877.371839422434, 41912.37131443031, 41949.58050419487, 42084.0, 3423.246885685145, 3725.6088110748524, 3749.718771092179, 3760.774353538769, 4393.077453734688, 32582.6741732582, 32887.34225315504, 32920.670793292236, 33483.0, 34546.48180277298, 4460.6208472279895, 4488.5960263576435, 4594.058218065322, 4608.9308660370125, 4674.32222327764, 370589.0, 371249.0, 372982.0, 374712.0, 375401.99999999726, 34369.65630343714, 35199.82400087983, 35430.645693542734, 56550.43449565534, 56621.0, 36707.63292367096, 36845.26309473849, 36947.815260924064, 36978.815105924834, 37017.62982370142, 15564.844351556567, 15612.063276203464, 15695.843041569666, 15850.52448426549, 15884.841151588567, 13369.532066377824, 13423.798643020362, 13451.529196478272, 13474.797878031837, 13488.730225395437, 8448.831023379498, 8459.323254139654, 8477.915220847835, 8499.107593702573, 8554.486730796049, 3287.342531493711, 3289.079057863802, 3312.9006129816144, 3329.3840639481773, 3373.1735724747105, 999.6601155607128, 1040.921930855189, 1045.0803293102022, 1095.5289225633055, 1108.8669359676728, 32800.50799238013, 32958.835205824296, 33247.335053299284, 33502.49746253808, 33885.32229355448, 1134.8638163420442, 1176.082655528689, 1200.1059210887945, 1203.5907791350808, 1234.9073819463576, 17046.829531704523, 17122.657546848994, 17277.91361043212, 17331.4800555981, 17473.38843140484, 633724.0, 637432.0, 637797.0, 644698.0, 649275.0, 58146.7092664534, 58330.12504812431, 58656.0, 58692.0, 58984.871059025456, 1361.4418088583832, 1367.5350380870552, 1368.8494265630773, 1388.1324172392053, 1400.880925121376, 30885.227869303446, 32171.0, 32434.513482297312, 32906.68231993385, 33008.66991330152, 49810.75094624504, 49973.250401243284, 50235.49764502308, 50395.748021261126, 50486.74756626193, 468120.0, 476872.0, 478184.65446036676, 482518.0, 483515.0, 27054.594181087694, 27881.860590696917, 28065.158045258675, 28166.85916570404, 28374.43251135007, 47760.28359574539, 47766.761166193945, 48706.02587948292, 49038.50961490339, 49059.5094049055, 39660.60339396569, 39891.20489578034, 41173.79413102915, 41482.1703565921, 41528.0, 41519.58480415157, 41764.0, 41831.37252941269, 42293.577064230194, 43345.0, 41537.58462415337, 42620.57379426166, 42720.78639606782, 43027.56972430235, 43197.13605727805, 33195.66804332023, 34501.482477763355, 34502.30995380028, 34520.2966743751, 34767.0, 28240.0, 29254.7074529252, 29311.0, 29377.265568360963, 29429.411411772075], "value": 19152.702214253743, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.78200598667746, 395.92675355059333, 396.4113291761731, 397.7851959941632, 421.59948049353125, 14120.435182592684, 18451.169697363617, 19036.524086897836, 20127.899360503212, 20234.494137646565, 18961.62076758464, 18985.905070474662, 19191.080891910802, 19878.403647890587, 19928.9003554982, 5574.275344205268, 5613.494785469307, 5708.08670612702, 5744.79893203738, 5752.942470575304, 5529.391766905637, 5577.498025177733, 5593.74828132735, 5645.181448689958, 5653.802116925908, 5567.164925261223, 5619.690916999563, 5626.578006649518, 5628.634138780986, 5632.493075623193, 5427.891442171154, 5538.169274608821, 5541.196526503634, 5578.191162281487, 5610.887782244353, 5000.89998200034, 5088.847334579968, 5089.287499750038, 5091.389033315989, 5094.31226784383, 23009.53980920372, 23196.0, 24266.514669706507, 24571.63142552863, 24614.384640383956, 2448.4001419652122, 2449.1795248591743, 2552.5660637691453, 2568.563344231485, 3065.5401689746495, 14709.70580588393, 15188.46840360582, 15223.162726050063, 15342.156181410019, 15641.452549160726, 1912.9713054304198, 1916.549610841465, 1943.9028048597513, 2006.5384961458947, 2006.7190593316948, 86408.0, 88656.0, 90219.54890225573, 90531.75229513612, 91253.0, 10400.271980961412, 10651.84022239667, 10664.360138391721, 10911.890881091247, 11141.387223702612, 14820.258987050604, 14838.851611483962, 14912.030718003294, 14928.02967807089, 15015.849841501664, 7967.681292748225, 8049.758507244792, 8186.83626327482, 8277.006759188936, 8384.580770961427, 7999.400044996532, 8011.038675358995, 8089.433739638169, 8155.10293867674, 8220.383471239562, 6503.382178693017, 6630.552546045485, 6646.700898459581, 6652.833679157963, 6706.362895525015, 1934.4680212941553, 1970.7927121623873, 1979.6337677529702, 1983.5140390604106, 1984.6526857799827, 940.3981451870808, 959.8848138223458, 975.2539307429822, 1060.379677888444, 1067.7170549804307, 20329.186832526535, 20726.48183795387, 20730.585388292453, 20993.790062099488, 21074.15703371848, 1022.5858527296457, 1026.594495174402, 1028.4343611013912, 1034.5706531789374, 1037.8598889150019, 11311.886881131248, 11843.88156118445, 11894.643160705193, 11960.521579136912, 12029.75940481203, 473231.0, 478200.0, 479345.0, 481376.0, 485105.0, 53107.468925310255, 81562.0, 83401.0, 84133.0, 85133.0, 1018.3787889387468, 1035.808375450529, 1039.1271332081087, 1053.146950969717, 1064.2762921213648, 17800.46598602044, 18104.0, 18672.813271867108, 18777.624447511247, 18804.341848035252, 41022.38466423066, 41803.58196417997, 41992.58007420009, 42261.78869105635, 42740.78629606832, 53388.0, 55825.0, 56604.15093773515, 56727.0, 56839.147412789665, 7480.738174163878, 7858.253465920957, 8659.567021648767, 8762.167594078552, 9013.459192448474, 13825.308734563432, 13847.30763461843, 14067.577972660836, 14309.713805724035, 14412.495562655256, 12526.812097818722, 12568.622941311774, 12696.555620553236, 12785.232886026868, 12878.613641590768, 10722.303050301705, 10962.890371096188, 11402.771944561227, 11574.826377604175, 11893.702657433634, 12053.57812476559, 12209.389530523616, 12446.128770985944, 12538.561150359694, 12863.421146048264, 7520.172780993977, 8119.188081191834, 8143.42995990275, 8210.425270231026, 8381.078081410918, 12290.877091228973, 12403.379831008593, 12412.19320744185, 12719.300438475602, 12722.809157862825], "value": 9485.809159936505, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.4336352186172, 1498.4380857178558, 1662.900225986441, 1741.6168442942549, 1792.7579776730129, 8125.91874081259, 8593.828123437528, 8928.973168085671, 9556.187724043455, 9568.995255498168, 8602.784930376729, 8747.825043499126, 8984.91015089849, 8993.640254389833, 9092.045335239787, 2295.4490922178684, 2354.376090336062, 2355.3287313115766, 2370.040133745827, 2374.8100151987887, 2354.564405584964, 2387.6776635154292, 2397.1609936522163, 2415.04605680756, 2432.9513409731794, 2388.52229554089, 2403.0868270057354, 2408.2895545814026, 2415.9758402416014, 2429.0648100481353, 2328.883555822219, 2331.335569362732, 2333.7782910623464, 2347.835651504395, 2354.9764502355015, 2304.9308520744403, 2323.8373313868037, 2333.1134169015836, 2340.403197184724, 2341.4380548668196, 9207.76980575491, 9234.353595248336, 9307.627694892197, 9312.534373281309, 9315.76710582234, 5337.8131765388025, 5416.0, 5509.311336082989, 5523.751431185566, 5528.668279903219, 3527.2063785648024, 3547.3614749345106, 3597.6762091411897, 3609.8917032489067, 3615.168511242429, 1164.5807509296646, 1173.1904985560022, 1250.699832040313, 1270.4727538071688, 1271.1991445389438, 12880.162789418751, 13042.934785326108, 13073.08488405812, 13116.27860467674, 13125.606231812966, 4713.481517033124, 4721.3287070605975, 4794.976025119852, 4852.611791056707, 4908.852734417973, 10908.636420447445, 10992.890071099346, 11025.338479691245, 11042.613508527164, 11045.83431248532, 5534.612577119644, 5592.97203513988, 5598.188262701886, 5603.495685388253, 5606.327240731139, 4352.368906508538, 4844.927326090112, 5004.324416203839, 5038.168702164176, 5127.051495473349, 4133.111381053088, 4144.958550414518, 4150.543440221573, 4153.1070819773895, 4182.019801192467, 1307.8692130787035, 1356.4370786123648, 1367.3163418290856, 1367.911085779441, 1371.7942308653583, 869.2741560796679, 918.5407296351824, 936.283742936654, 940.8165407745424, 968.6125549780145, 6182.319944806068, 6208.1308616793685, 6231.813045608639, 6277.654728989858, 6283.3035080528, 959.2182371367313, 960.7021823234819, 974.8391515400021, 996.2826764729383, 1020.1838529176629, 4256.7445953242905, 4306.418633484503, 4383.802728877208, 4400.889977750518, 4404.779761012001, 11183.384913829817, 11456.369899655432, 11558.479868405942, 11560.421978901022, 11582.768344633228, 10737.355758654505, 11088.112950963903, 11148.609798657008, 11522.423878806027, 11553.36456494884, 8339.20777526134, 8510.36172287081, 8529.147085291544, 8580.0, 8587.22714955657, 6053.364396738455, 6316.905246421215, 6317.652529110759, 6372.330905254881, 6398.656282180794, 10037.096661300518, 10309.22680798958, 10425.687229383131, 10545.894541054799, 10609.045185933302, 10638.84041739359, 10841.620543280947, 10874.728131796768, 10948.890511094787, 10989.0, 7111.53775004623, 7830.804229894298, 7869.370450364072, 7908.0, 7941.166177551274, 8718.476891386537, 8768.473891566526, 8799.780005499913, 8843.425177363451, 8903.0, 7715.498492597963, 7774.144844067035, 7991.200879911962, 8011.679532818622, 8298.08721040673, 8112.75661730149, 8137.471064380797, 8203.548804815793, 8232.876506852523, 8318.334533237448, 7215.855682886207, 7254.310840470147, 7328.083989501312, 7344.192138864827, 7362.6318684066655, 5346.705931173823, 5374.11327131019, 5392.379876314274, 5398.676079435247, 5431.158170483582, 5376.0591896418755, 5386.730663466889, 5398.4871437213405, 5508.531774799187, 5533.280673512579], "value": 4828.132585733396, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.62750933823384, 300.64674008040555, 301.39419766269793, 318.75137392833585, 321.9839008049597, 5496.587755918312, 5513.2005859150395, 5643.435656434354, 5690.3171619405675, 5748.942510574893, 5542.806001789938, 5568.3596386415575, 5569.331680198382, 5580.130656230158, 5582.218489411485, 4381.627561657263, 4396.538363471837, 4424.203643344197, 4426.557344265564, 4432.3794668746405, 4093.9151124951914, 4280.657547396217, 4290.163418133465, 4429.402030725859, 4440.777961101948, 4230.619244268015, 4249.065205654751, 4250.236151996917, 4259.084296876171, 4286.785660716967, 4286.828526858938, 4295.153084173804, 4297.914041719179, 4316.805743741539, 4331.848385306531, 3533.381658209803, 3749.3063783199923, 3759.0414444316525, 3763.0, 3772.5661548921953, 5485.396606373296, 5485.9725701371235, 5502.046773395427, 5527.226188333637, 5541.224228607998, 4912.238603016538, 4919.409670839522, 4924.113659541281, 4939.160342741707, 4950.405951285833, 5613.410591887875, 5877.412258774131, 5885.204527849281, 5906.527477801766, 5958.705898229169, 4073.572274911151, 4078.755274683499, 4079.6124368185274, 4092.2224777292518, 4138.151678905817, 6087.665178415185, 6119.632822030692, 6124.724387402578, 6158.9692051539905, 6163.414475624809, 4038.8990275243355, 4110.383442483651, 4119.196756632487, 4140.544540100586, 4175.227582897173, 4183.895402614898, 4201.222773786859, 4205.705600607989, 4215.283401821697, 4230.661547076288, 4856.854294371175, 4857.587105096107, 4870.732109733999, 4883.267509873476, 4912.901741965141, 5662.348829884533, 5910.763569457259, 5922.555808314393, 5952.523798096142, 6002.688964748603, 1450.4633285684365, 1462.2469428244463, 1464.6265202373327, 1466.7579849324954, 1468.6108181331956, 877.9824403511894, 911.129870973219, 919.1268295119663, 926.9073092690677, 931.4737173496952, 5043.268726034705, 5050.292958985745, 5052.898942021213, 5097.006083813695, 5152.355955505562, 5308.973455132699, 5319.787208511693, 5405.756675964551, 5453.682185071329, 5479.53423958968, 5122.487751224848, 5146.511081447256, 5154.355705536808, 5382.2464854920345, 5820.0, 3227.967720322814, 3255.674432556773, 3275.721563667067, 3277.6558461361215, 3283.967160328414, 6149.692515374213, 6338.429541341209, 6397.26431460388, 6402.295747467775, 6416.711247993851, 6158.274244082355, 6225.875482490324, 6232.657203853741, 6252.499800015988, 6262.810066087429, 6380.776672816429, 6385.265694445198, 6386.297507274289, 6388.1376014237485, 6406.903896441557, 5884.734782021886, 6081.331053584014, 6084.817455476343, 6124.785632503019, 6131.049687298476, 6042.969785151222, 6060.878782424415, 6074.787382441594, 6084.718230663501, 6090.482309003607, 6032.095185722177, 6184.567080304336, 6284.5600807943, 6290.672451193088, 6295.653739044396, 4258.40382346478, 4337.652987761035, 4348.391225228407, 4368.890777730582, 4381.912361752811, 6115.84710382244, 6118.296395914527, 6131.662758548323, 6133.38666133401, 6202.81391558254, 5804.564657650609, 5893.351731309638, 6005.0, 6022.608530445507, 6024.277086749618, 5916.970415147896, 5952.553558483044, 5970.671438139042, 5978.730957107027, 5980.910286345621, 5729.512991395778, 5862.296524417097, 5931.013110607994, 5940.910886336622, 5977.402259773988, 5962.52299816005, 5969.522438204846, 5973.761049557969, 6005.879882402415, 6040.607360521552, 5805.593608447368, 5810.0, 5818.050952930816, 5839.766409343579, 5885.55858310637], "value": 4423.397660561822, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.9188289288178, 777.5257093173163, 819.2258315891484, 823.1480417767611, 827.7309874290856, 15399.69200615987, 15806.13066281354, 15814.841851581496, 15844.445444409448, 15858.524244272676, 12109.15235933485, 14965.775513367282, 15142.394304227846, 15143.848561514382, 15150.090994540335, 788.0543347982415, 811.5942028985507, 811.663159788687, 813.4631143445328, 813.9348852091819, 795.9482633628825, 807.0557447786105, 807.2411932783194, 807.289585165054, 808.8301456694102, 852.6333676519095, 854.0520022774715, 855.0893298636931, 855.7646647172015, 857.2028013947026, 853.9444936079135, 855.5209082913589, 855.7304449098576, 855.9101294364095, 857.8455877941968, 613.1997742945455, 613.9785107521216, 616.4113271825396, 616.7193926763312, 621.8321053315625, 15274.38902443901, 15280.0, 15328.846711532853, 15355.692886142326, 15367.692646147014, 15553.0, 15852.52442426729, 15966.201689915457, 16296.103714295708, 16320.75518867218, 12027.93986030073, 12304.81542776859, 12365.137348771428, 12413.193142445713, 12416.937915310365, 3861.420786881962, 3865.4781604483314, 3867.6325749053794, 3911.941320880189, 4018.819153138116, 69312.0, 72351.27648723498, 73747.63126184334, 78970.0, 79636.60181699113, 11762.294262344287, 11773.293602383885, 11782.351970641697, 11868.821967670492, 12048.578299759467, 21781.237656682257, 22117.33647990563, 22192.0, 22192.334229973127, 22212.88893555554, 9092.318076144184, 9129.817403652023, 9254.981951985275, 9302.767430814283, 9464.19554337889, 4874.8781280467565, 4906.288588154697, 4930.137225985438, 4988.850334489971, 5006.549410553068, 3623.456481527739, 3714.257148570297, 3749.1189570450924, 3758.962410375861, 3765.0963768695315, 666.976655817044, 672.4553111979312, 677.2245778583494, 688.3288793426369, 703.2545501768142, 760.4828716472741, 770.3336613828998, 826.1862065865118, 826.2041776934807, 829.7178959153916, 9771.730069434312, 10298.897011029943, 10298.948505257425, 10369.170466362673, 10588.894111058791, 706.3257705034862, 739.4417215002638, 785.8506883692195, 794.7218473534217, 811.4157806379397, 4785.019071090418, 5068.265101560327, 5133.79464821403, 5138.794448222029, 5228.424873263938, 123965.0, 124879.3756031214, 125631.0, 128700.0, 129029.0, 85309.0, 107202.46398767956, 108768.0, 109621.45189274162, 109989.45005274922, 58234.708826456445, 66317.0, 87173.5641321802, 88652.5567372172, 89588.6561701575, 9861.309708320348, 10454.42500662471, 10473.476326183812, 10646.787064258826, 10824.079953204066, 36826.63173368232, 36980.81509592435, 51874.48125518696, 53124.0, 53672.46327536675, 50367.49632503628, 54128.72935635297, 61401.07898381438, 61693.38306616876, 79114.0, 13687.247201404018, 13821.654458638615, 13915.930420348239, 14044.0, 14238.074525155831, 16039.35842566331, 16103.275352609395, 16107.436239731553, 16641.50075497737, 16664.33342666328, 14599.562013139623, 14773.409063637335, 14839.183844888636, 15301.081935083484, 16028.439004634782, 15023.849761502244, 15116.09303441797, 15602.765958510405, 15871.444499442465, 16173.27220275067, 14645.633859153606, 14949.0, 14992.700145997238, 15196.088234705952, 15465.690686186439, 11820.586279480176, 12091.39543022863, 12107.227756818807, 12293.815592766294, 12392.938035309766, 12402.75194496123, 12503.249805011728, 12562.560310389092, 12830.29433381173, 12906.677333066373], "value": 7863.678245373574, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 105.0, 112.0, 111.0, 112.0, 111.0, 110.0, 110.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 147.0, 167.0, 118.0, 151.0, 152.0, 118.0, 189.0, 118.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 159.0, 168.0, 162.0, 165.0, 175.0, 162.0, 160.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 75.0, 148.0, 78.0, 87.0, 76.0, 74.0, 163.0, 77.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 140.0, 85.0, 84.0, 83.0, 140.0, 86.0, 86.0, 147.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 119.0, 117.0, 118.0, 118.0, 119.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 146.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 54.0, 55.0, 56.0, 54.0, 56.0, 54.0, 56.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 63.0, 63.0, 63.0, 62.0, 63.0, 61.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 86.0, 76.0, 77.0, 82.0, 78.0, 77.0, 80.0, 77.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 126.0, 139.0, 123.0, 136.0, 129.0, 135.0, 129.0, 165.0, 124.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 167.0, 162.0, 163.0, 171.0, 165.0, 167.0, 165.0, 174.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 68.0, 66.0, 65.0, 67.0, 69.0, 65.0, 68.0], "value": 66.5, "unit": "score"}]}]} 20:51:11 INFO - Return code: 0 20:51:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:51:11 ERROR - # TBPL SUCCESS # 20:51:11 INFO - Running post-action listener: _resource_record_post_action 20:51:11 INFO - ##### 20:51:11 INFO - ##### Finished run-tests step (success) 20:51:11 INFO - ##### 20:51:11 INFO - Running post-run listener: _resource_record_post_run 20:51:11 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 297361408; Read time: 448; Write time: 687720 20:51:11 INFO - TinderboxPrint: CPU usage
13.4% 20:51:11 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 448 20:51:11 INFO - TinderboxPrint: I/O write bytes / time
297,361,408 / 687,720 20:51:11 INFO - TinderboxPrint: CPU idle
8,250.9 (86.6%) 20:51:11 INFO - TinderboxPrint: CPU user
1,210.7 (12.7%) 20:51:11 INFO - TinderboxPrint: Swap in / out
0 / 0 20:51:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5193728; Read time: 0; Write time: 872 20:51:11 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292003840; Read time: 436; Write time: 686716 20:51:12 INFO - Running post-run listener: _upload_blobber_files 20:51:12 INFO - Blob upload gear active. 20:51:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:51:12 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 20:51:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:51:12 INFO - (blobuploader) - INFO - Open directory for files ... 20:51:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:51:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:51:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:51:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:51:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:51:16 INFO - (blobuploader) - INFO - Done attempting. 20:51:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:51:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:51:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:51:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:51:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:51:17 INFO - (blobuploader) - INFO - Done attempting. 20:51:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:51:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:51:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:51:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:51:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:51:18 INFO - (blobuploader) - INFO - Done attempting. 20:51:18 INFO - (blobuploader) - INFO - Iteration through files over. 20:51:18 INFO - Return code: 0 20:51:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:51:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:51:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/75e2486405d33f13cf30beeb0cb3859df3c889bc41241bfa439899df69ef6e4643168e5980fe4e9abd61cbb368ed4c82523351a1938df21c1579799796847291", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55aeb7c6aa408f6f95ce36c8342a37bb1a2ffe3370890a589c8efd19ce7cd15af418e4d115503462247b33ce4635940cc2d928505ecd66ed04931cf9d22dd824", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18952a2561261dab4b690eb8e56f9a511968c7ae8dbc825132b235b62b4c0d9085345818c4ee120cc40be94e5836fb71b2aa69398be1eebacfce65363148d013"} 20:51:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:51:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:51:18 INFO - Contents: 20:51:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/75e2486405d33f13cf30beeb0cb3859df3c889bc41241bfa439899df69ef6e4643168e5980fe4e9abd61cbb368ed4c82523351a1938df21c1579799796847291", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55aeb7c6aa408f6f95ce36c8342a37bb1a2ffe3370890a589c8efd19ce7cd15af418e4d115503462247b33ce4635940cc2d928505ecd66ed04931cf9d22dd824", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18952a2561261dab4b690eb8e56f9a511968c7ae8dbc825132b235b62b4c0d9085345818c4ee120cc40be94e5836fb71b2aa69398be1eebacfce65363148d013"} 20:51:18 INFO - Running post-run listener: copy_logs_to_upload_dir 20:51:18 INFO - Copying logs to upload dir... 20:51:18 INFO - mkdir: /builds/slave/test/build/upload/logs 20:51:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.611161 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-11 20:51:18.163325) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 20:51:18.166467) ========= 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=745a4373a2a16df560f216e000000264-1468294216.572604-1455945311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/75e2486405d33f13cf30beeb0cb3859df3c889bc41241bfa439899df69ef6e4643168e5980fe4e9abd61cbb368ed4c82523351a1938df21c1579799796847291", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55aeb7c6aa408f6f95ce36c8342a37bb1a2ffe3370890a589c8efd19ce7cd15af418e4d115503462247b33ce4635940cc2d928505ecd66ed04931cf9d22dd824", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18952a2561261dab4b690eb8e56f9a511968c7ae8dbc825132b235b62b4c0d9085345818c4ee120cc40be94e5836fb71b2aa69398be1eebacfce65363148d013"} build_url:https://queue.taskcluster.net/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011469 build_url: 'https://queue.taskcluster.net/v1/task/OXRhGYqjRKaIx20u-tT7HQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/75e2486405d33f13cf30beeb0cb3859df3c889bc41241bfa439899df69ef6e4643168e5980fe4e9abd61cbb368ed4c82523351a1938df21c1579799796847291", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55aeb7c6aa408f6f95ce36c8342a37bb1a2ffe3370890a589c8efd19ce7cd15af418e4d115503462247b33ce4635940cc2d928505ecd66ed04931cf9d22dd824", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18952a2561261dab4b690eb8e56f9a511968c7ae8dbc825132b235b62b4c0d9085345818c4ee120cc40be94e5836fb71b2aa69398be1eebacfce65363148d013"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 20:51:18.191505) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 20:51:18.191823) ========= 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=745a4373a2a16df560f216e000000264-1468294216.572604-1455945311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 20:51:18.274935) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 20:51:18.275257) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 20:51:18.275548) ========= ========= Total master_lag: 0.16 =========