builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1467527760.89 results: success (0) buildid: 20160702144223 builduid: bd7aa9a48dd24fd185509157046c588d revision: b8b3b1c92085c1f8b74c13203289360932182da4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:00.886867) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:00.887834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:00.888445) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:00.905028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:00.905699) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-02 23:36:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.6M=0s 2016-07-02 23:36:01 (34.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098862 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:01.021070) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:01.021463) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018909 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:01.071825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:36:01.072228) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev b8b3b1c92085c1f8b74c13203289360932182da4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev b8b3b1c92085c1f8b74c13203289360932182da4 --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=e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-02 23:36:01,564 truncating revision to first 12 chars 2016-07-02 23:36:01,564 Setting DEBUG logging. 2016-07-02 23:36:01,564 attempt 1/10 2016-07-02 23:36:01,565 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/b8b3b1c92085?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-02 23:36:02,586 unpacking tar archive at: autoland-b8b3b1c92085/testing/mozharness/ program finished with exit code 0 elapsedTime=1.346303 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:36:02.432759) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:02.433131) ========= script_repo_revision: b8b3b1c92085c1f8b74c13203289360932182da4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:02.433596) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:02.434030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:02.443990) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-02 23:36:02.444297) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:36:03 INFO - MultiFileLogger online at 20160702 23:36:03 in /builds/slave/test 23:36:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 23:36:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:36:03 INFO - {'append_to_log': False, 23:36:03 INFO - 'base_work_dir': '/builds/slave/test', 23:36:03 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 23:36:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:36:03 INFO - 'branch': 'Autoland-Non-PGO', 23:36:03 INFO - 'buildbot_json_path': 'buildprops.json', 23:36:03 INFO - 'config_files': ('talos/linux_config.py',), 23:36:03 INFO - 'default_actions': ('clobber', 23:36:03 INFO - 'read-buildbot-config', 23:36:03 INFO - 'download-and-extract', 23:36:03 INFO - 'populate-webroot', 23:36:03 INFO - 'create-virtualenv', 23:36:03 INFO - 'install', 23:36:03 INFO - 'run-tests'), 23:36:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:36:03 INFO - 'download_minidump_stackwalk': True, 23:36:03 INFO - 'download_symbols': 'ondemand', 23:36:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:36:03 INFO - 'tooltool.py': '/tools/tooltool.py', 23:36:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:36:03 INFO - '/tools/misc-python/virtualenv.py')}, 23:36:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:36:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:36:03 INFO - 'installer_path': 'installer.exe', 23:36:03 INFO - 'log_level': 'info', 23:36:03 INFO - 'log_name': 'talos', 23:36:03 INFO - 'log_to_console': True, 23:36:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:36:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:36:03 INFO - 'opt_config_files': (), 23:36:03 INFO - 'pip_index': False, 23:36:03 INFO - 'sps_profile': False, 23:36:03 INFO - 'sps_profile_interval': 0, 23:36:03 INFO - 'suite': 'dromaeojs-e10s', 23:36:03 INFO - 'system_bits': '32', 23:36:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:36:03 INFO - 'title': 'talos-linux64-ix-006', 23:36:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:36:03 INFO - 'use_talos_json': True, 23:36:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:36:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:36:03 INFO - 'work_dir': 'build'} 23:36:03 INFO - ##### 23:36:03 INFO - ##### Running clobber step. 23:36:03 INFO - ##### 23:36:03 INFO - Running pre-action listener: _resource_record_pre_action 23:36:03 INFO - Running main action method: clobber 23:36:03 INFO - rmtree: /builds/slave/test/build 23:36:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:36:03 INFO - Running post-action listener: _resource_record_post_action 23:36:03 INFO - ##### 23:36:03 INFO - ##### Finished clobber step (success) 23:36:03 INFO - ##### 23:36:03 INFO - ##### 23:36:03 INFO - ##### Running read-buildbot-config step. 23:36:03 INFO - ##### 23:36:03 INFO - Running pre-action listener: _resource_record_pre_action 23:36:03 INFO - Running main action method: read_buildbot_config 23:36:03 INFO - Using buildbot properties: 23:36:03 INFO - { 23:36:03 INFO - "project": "", 23:36:03 INFO - "product": "firefox", 23:36:03 INFO - "script_repo_revision": "production", 23:36:03 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 23:36:03 INFO - "repository": "", 23:36:03 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 23:36:03 INFO - "buildid": "20160702144223", 23:36:03 INFO - "pgo_build": "False", 23:36:03 INFO - "basedir": "/builds/slave/test", 23:36:03 INFO - "buildnumber": 31, 23:36:03 INFO - "slavename": "talos-linux64-ix-006", 23:36:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:36:03 INFO - "platform": "ubuntu64_hw", 23:36:03 INFO - "scheduler": "tests-autoland-linux64-talos", 23:36:03 INFO - "branch": "autoland", 23:36:03 INFO - "repo_path": "integration/autoland", 23:36:03 INFO - "revision": "b8b3b1c92085c1f8b74c13203289360932182da4", 23:36:03 INFO - "stage_platform": "linux64", 23:36:03 INFO - "builduid": "bd7aa9a48dd24fd185509157046c588d", 23:36:03 INFO - "slavebuilddir": "test" 23:36:03 INFO - } 23:36:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:36:03 INFO - Running post-action listener: _resource_record_post_action 23:36:03 INFO - ##### 23:36:03 INFO - ##### Finished read-buildbot-config step (success) 23:36:03 INFO - ##### 23:36:03 INFO - ##### 23:36:03 INFO - ##### Running download-and-extract step. 23:36:03 INFO - ##### 23:36:03 INFO - Running pre-action listener: _resource_record_pre_action 23:36:03 INFO - Running main action method: download_and_extract 23:36:03 INFO - mkdir: /builds/slave/test/build/tests 23:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:03 INFO - https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:36:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:36:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:36:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:04 INFO - Downloaded 1361 bytes. 23:36:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:36:04 INFO - Using the following test package requirements: 23:36:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:36:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:36:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:36:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:04 INFO - u'jsshell-linux-x86_64.zip'], 23:36:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:36:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:36:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:36:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:36:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:36:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:36:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:36:04 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')]} 23:36:04 INFO - https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:36:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:05 INFO - Downloaded 22705905 bytes. 23:36:05 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'] 23:36:05 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 23:36:07 INFO - Return code: 0 23:36:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:07 INFO - https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:36:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:09 INFO - Downloaded 22705905 bytes. 23:36:09 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'] 23:36:09 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 23:36:10 INFO - Return code: 0 23:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:10 INFO - https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:36:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:36:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:36:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:11 INFO - Downloaded 14405327 bytes. 23:36:11 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'] 23:36:11 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 23:36:11 INFO - Return code: 0 23:36:11 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')]} 23:36:11 INFO - https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:36:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:36:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:36:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:13 INFO - Downloaded 56486849 bytes. 23:36:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:36:13 INFO - mkdir: /builds/slave/test/properties 23:36:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:36:13 INFO - Writing to file /builds/slave/test/properties/build_url 23:36:13 INFO - Contents: 23:36:13 INFO - build_url:https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:36:13 INFO - Running post-action listener: _resource_record_post_action 23:36:13 INFO - Running post-action listener: set_extra_try_arguments 23:36:13 INFO - ##### 23:36:13 INFO - ##### Finished download-and-extract step (success) 23:36:13 INFO - ##### 23:36:13 INFO - ##### 23:36:13 INFO - ##### Running populate-webroot step. 23:36:13 INFO - ##### 23:36:13 INFO - Running pre-action listener: _resource_record_pre_action 23:36:13 INFO - Running main action method: populate_webroot 23:36:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:36:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:36:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:36:13 INFO - '--tppagecycles', 23:36:13 INFO - '7'], 23:36:13 INFO - 'tests': ['tsvgm']}}, 23:36:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:36:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:36:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:36:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:36:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:36:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:36:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:13 INFO - 'talos_options': ['--disable-e10s'], 23:36:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:36:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:36:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:13 INFO - 'talos_options': ['--disable-e10s'], 23:36:13 INFO - 'tests': ['damp', 'tps']}, 23:36:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:13 INFO - 'tests': ['damp', 'tps']}, 23:36:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:36:13 INFO - 'tests': ['dromaeo_dom']}, 23:36:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:36:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:36:13 INFO - 'tests': ['basic_compositor_video']}, 23:36:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:36:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:36:13 INFO - 'tests': ['a11yr', 23:36:13 INFO - 'ts_paint', 23:36:13 INFO - 'tpaint', 23:36:13 INFO - 'sessionrestore', 23:36:13 INFO - 'sessionrestore_no_auto_restore', 23:36:13 INFO - 'tabpaint']}, 23:36:13 INFO - 'other-e10s': {'tests': ['a11yr', 23:36:13 INFO - 'ts_paint', 23:36:13 INFO - 'tpaint', 23:36:13 INFO - 'sessionrestore', 23:36:13 INFO - 'sessionrestore_no_auto_restore', 23:36:13 INFO - 'tabpaint']}, 23:36:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:36:13 INFO - 'ts_paint', 23:36:13 INFO - 'tpaint', 23:36:13 INFO - 'sessionrestore', 23:36:13 INFO - 'sessionrestore_no_auto_restore', 23:36:13 INFO - 'tabpaint']}, 23:36:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:36:13 INFO - 'ts_paint', 23:36:13 INFO - 'tpaint', 23:36:13 INFO - 'sessionrestore', 23:36:13 INFO - 'sessionrestore_no_auto_restore', 23:36:13 INFO - 'tabpaint']}, 23:36:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:36:13 INFO - 'tests': ['a11yr', 23:36:13 INFO - 'ts_paint', 23:36:13 INFO - 'tpaint', 23:36:13 INFO - 'sessionrestore', 23:36:13 INFO - 'sessionrestore_no_auto_restore', 23:36:13 INFO - 'tabpaint']}, 23:36:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:36:13 INFO - 'tests': ['a11yr', 23:36:13 INFO - 'ts_paint', 23:36:13 INFO - 'tpaint', 23:36:13 INFO - 'sessionrestore', 23:36:13 INFO - 'sessionrestore_no_auto_restore', 23:36:13 INFO - 'tabpaint']}, 23:36:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:36:13 INFO - 'tests': ['tsvgx', 23:36:13 INFO - 'tsvgr_opacity', 23:36:13 INFO - 'tart', 23:36:13 INFO - 'tscrollx', 23:36:13 INFO - 'cart']}, 23:36:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:36:13 INFO - 'tsvgr_opacity', 23:36:13 INFO - 'tart', 23:36:13 INFO - 'tscrollx', 23:36:13 INFO - 'cart']}, 23:36:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:13 INFO - 'talos_options': ['--disable-e10s'], 23:36:13 INFO - 'tests': ['tp5o']}, 23:36:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:13 INFO - 'tests': ['tp5o']}, 23:36:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:13 INFO - 'talos_options': ['--disable-e10s', 23:36:13 INFO - '--xperf_path', 23:36:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:36:13 INFO - 'tests': ['tp5n']}, 23:36:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:13 INFO - 'talos_options': ['--xperf_path', 23:36:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:36:14 INFO - 'tests': ['tp5n']}}, 23:36:14 INFO - 'talos.zip': {'path': '', 23:36:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:36:14 INFO - Running post-action listener: _resource_record_post_action 23:36:14 INFO - ##### 23:36:14 INFO - ##### Finished populate-webroot step (success) 23:36:14 INFO - ##### 23:36:14 INFO - ##### 23:36:14 INFO - ##### Running create-virtualenv step. 23:36:14 INFO - ##### 23:36:14 INFO - Running pre-action listener: _resource_record_pre_action 23:36:14 INFO - Running main action method: create_virtualenv 23:36:14 INFO - Creating virtualenv /builds/slave/test/build/venv 23:36:14 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 23:36:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:36:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:36:14 INFO - Using real prefix '/usr' 23:36:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:36:14 INFO - Installing distribute.............................................................................................................................................................................................done. 23:36:16 INFO - Installing pip.................done. 23:36:16 INFO - Return code: 0 23:36:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:36: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')]} 23:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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')]} 23:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a26400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab5570>, '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 0x2ab6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', '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 23:36: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', 'pip>=1.5'] in /builds/slave/test/build 23:36: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 pip>=1.5 23:36:16 INFO - Using env: {'DISPLAY': ':0', 23:36:16 INFO - 'HOME': '/home/cltbld', 23:36:16 INFO - 'LANG': 'en_US.UTF-8', 23:36:16 INFO - 'LANGUAGE': 'en_US:en', 23:36:16 INFO - 'LOGNAME': 'cltbld', 23:36:16 INFO - 'MAIL': '/var/mail/cltbld', 23:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:16 INFO - 'MOZ_NO_REMOTE': '1', 23:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:16 INFO - 'NO_EM_RESTART': '1', 23:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:16 INFO - 'PWD': '/builds/slave/test', 23:36:16 INFO - 'SHELL': '/bin/bash', 23:36:16 INFO - 'SHLVL': '1', 23:36:16 INFO - 'TERM': 'linux', 23:36:16 INFO - 'TMOUT': '86400', 23:36:16 INFO - 'USER': 'cltbld', 23:36:16 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', 23:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:16 INFO - '_': '/tools/buildbot/bin/python'} 23:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:16 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 23:36:16 INFO - Cleaning up... 23:36:16 INFO - Return code: 0 23:36:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:36: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')]} 23:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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')]} 23:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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', '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 0x27f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a26400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab5570>, '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 0x2ab6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', '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 23:36: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', 'psutil>=3.1.1'] in /builds/slave/test/build 23:36: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 psutil>=3.1.1 23:36:16 INFO - Using env: {'DISPLAY': ':0', 23:36:16 INFO - 'HOME': '/home/cltbld', 23:36:16 INFO - 'LANG': 'en_US.UTF-8', 23:36:16 INFO - 'LANGUAGE': 'en_US:en', 23:36:16 INFO - 'LOGNAME': 'cltbld', 23:36:16 INFO - 'MAIL': '/var/mail/cltbld', 23:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:16 INFO - 'MOZ_NO_REMOTE': '1', 23:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:16 INFO - 'NO_EM_RESTART': '1', 23:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:16 INFO - 'PWD': '/builds/slave/test', 23:36:16 INFO - 'SHELL': '/bin/bash', 23:36:16 INFO - 'SHLVL': '1', 23:36:16 INFO - 'TERM': 'linux', 23:36:16 INFO - 'TMOUT': '86400', 23:36:16 INFO - 'USER': 'cltbld', 23:36:16 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', 23:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:16 INFO - '_': '/tools/buildbot/bin/python'} 23:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:17 INFO - Downloading/unpacking psutil>=3.1.1 23:36:17 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 23:36:17 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 23:36:17 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 23:36:17 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 23:36:17 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 23:36:17 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 23:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:36:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:36:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:36:19 INFO - Installing collected packages: psutil 23:36:19 INFO - Running setup.py install for psutil 23:36:19 INFO - building 'psutil._psutil_linux' extension 23:36:19 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 23:36:19 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 23:36:19 INFO - building 'psutil._psutil_posix' extension 23:36:19 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 23:36:19 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 23:36:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:36:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:36:19 INFO - Successfully installed psutil 23:36:19 INFO - Cleaning up... 23:36:19 INFO - Return code: 0 23:36:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:36:19 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')]} 23:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:19 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')]} 23:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:19 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 0x27f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a26400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab5570>, '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 0x2ab6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', '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 23:36:19 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 23:36:19 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 23:36:19 INFO - Using env: {'DISPLAY': ':0', 23:36:19 INFO - 'HOME': '/home/cltbld', 23:36:19 INFO - 'LANG': 'en_US.UTF-8', 23:36:19 INFO - 'LANGUAGE': 'en_US:en', 23:36:19 INFO - 'LOGNAME': 'cltbld', 23:36:19 INFO - 'MAIL': '/var/mail/cltbld', 23:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:19 INFO - 'MOZ_NO_REMOTE': '1', 23:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:19 INFO - 'NO_EM_RESTART': '1', 23:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:19 INFO - 'PWD': '/builds/slave/test', 23:36:19 INFO - 'SHELL': '/bin/bash', 23:36:19 INFO - 'SHLVL': '1', 23:36:19 INFO - 'TERM': 'linux', 23:36:19 INFO - 'TMOUT': '86400', 23:36:19 INFO - 'USER': 'cltbld', 23:36:19 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', 23:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:19 INFO - '_': '/tools/buildbot/bin/python'} 23:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:36:19 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 23:36:19 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 23:36:19 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 23:36:19 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 23:36:19 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 23:36:19 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 23:36:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:36:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:36:21 INFO - Installing collected packages: mozsystemmonitor 23:36:21 INFO - Running setup.py install for mozsystemmonitor 23:36:21 INFO - Successfully installed mozsystemmonitor 23:36:21 INFO - Cleaning up... 23:36:21 INFO - Return code: 0 23:36:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:36:21 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')]} 23:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:21 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')]} 23:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:21 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 0x27f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a26400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab5570>, '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 0x2ab6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', '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 23:36:21 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 23:36:21 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 23:36:21 INFO - Using env: {'DISPLAY': ':0', 23:36:21 INFO - 'HOME': '/home/cltbld', 23:36:21 INFO - 'LANG': 'en_US.UTF-8', 23:36:21 INFO - 'LANGUAGE': 'en_US:en', 23:36:21 INFO - 'LOGNAME': 'cltbld', 23:36:21 INFO - 'MAIL': '/var/mail/cltbld', 23:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:21 INFO - 'MOZ_NO_REMOTE': '1', 23:36:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:21 INFO - 'NO_EM_RESTART': '1', 23:36:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:21 INFO - 'PWD': '/builds/slave/test', 23:36:21 INFO - 'SHELL': '/bin/bash', 23:36:21 INFO - 'SHLVL': '1', 23:36:21 INFO - 'TERM': 'linux', 23:36:21 INFO - 'TMOUT': '86400', 23:36:21 INFO - 'USER': 'cltbld', 23:36:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', 23:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:21 INFO - '_': '/tools/buildbot/bin/python'} 23:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:22 INFO - Downloading/unpacking jsonschema==2.5.1 23:36:22 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 23:36:22 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 23:36:22 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 23:36:22 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 23:36:22 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 23:36:22 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 23:36:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:36:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:36:24 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 23:36:24 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 23:36:24 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 23:36:24 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 23:36:24 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 23:36:24 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 23:36:24 INFO - Downloading functools32-3.2.3-2.tar.gz 23:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:36:24 INFO - warning: no files found matching '*.txt' 23:36:24 INFO - no previously-included directories found matching 'build' 23:36:24 INFO - no previously-included directories found matching 'dist' 23:36:24 INFO - no previously-included directories found matching '.git*' 23:36:24 INFO - Installing collected packages: jsonschema, functools32 23:36:24 INFO - Running setup.py install for functools32 23:36:24 INFO - warning: no files found matching '*.txt' 23:36:24 INFO - no previously-included directories found matching 'build' 23:36:24 INFO - no previously-included directories found matching 'dist' 23:36:24 INFO - no previously-included directories found matching '.git*' 23:36:24 INFO - Successfully installed jsonschema functools32 23:36:24 INFO - Cleaning up... 23:36:24 INFO - Return code: 0 23:36:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:36:24 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')]} 23:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:24 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')]} 23:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:24 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 0x27f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a26400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab5570>, '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 0x2ab6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', '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 23:36:24 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 23:36:24 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 23:36:24 INFO - Using env: {'DISPLAY': ':0', 23:36:24 INFO - 'HOME': '/home/cltbld', 23:36:24 INFO - 'LANG': 'en_US.UTF-8', 23:36:24 INFO - 'LANGUAGE': 'en_US:en', 23:36:24 INFO - 'LOGNAME': 'cltbld', 23:36:24 INFO - 'MAIL': '/var/mail/cltbld', 23:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:24 INFO - 'MOZ_NO_REMOTE': '1', 23:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:24 INFO - 'NO_EM_RESTART': '1', 23:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:24 INFO - 'PWD': '/builds/slave/test', 23:36:24 INFO - 'SHELL': '/bin/bash', 23:36:24 INFO - 'SHLVL': '1', 23:36:24 INFO - 'TERM': 'linux', 23:36:24 INFO - 'TMOUT': '86400', 23:36:24 INFO - 'USER': 'cltbld', 23:36:24 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', 23:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:24 INFO - '_': '/tools/buildbot/bin/python'} 23:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:24 INFO - Downloading/unpacking blobuploader==1.2.4 23:36:24 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 23:36:24 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 23:36:24 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 23:36:24 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 23:36:24 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 23:36:24 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 23:36:26 INFO - Downloading blobuploader-1.2.4.tar.gz 23:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:36:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:36:26 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 23:36:26 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 23:36:26 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 23:36:26 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 23:36:26 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 23:36:26 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 23:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:36:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:36:27 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 23:36:27 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 23:36:27 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 23:36:27 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 23:36:27 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 23:36:27 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 23:36:27 INFO - Downloading docopt-0.6.1.tar.gz 23:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:36:27 INFO - Installing collected packages: blobuploader, requests, docopt 23:36:27 INFO - Running setup.py install for blobuploader 23:36:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:36:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:36:27 INFO - Running setup.py install for requests 23:36:27 INFO - Running setup.py install for docopt 23:36:27 INFO - Successfully installed blobuploader requests docopt 23:36:27 INFO - Cleaning up... 23:36:27 INFO - Return code: 0 23:36:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:36:27 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')]} 23:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:27 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')]} 23:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:27 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 0x27f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a26400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab5570>, '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 0x2ab6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', '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 23:36:27 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 23:36:27 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 23:36:27 INFO - Using env: {'DISPLAY': ':0', 23:36:27 INFO - 'HOME': '/home/cltbld', 23:36:27 INFO - 'LANG': 'en_US.UTF-8', 23:36:27 INFO - 'LANGUAGE': 'en_US:en', 23:36:27 INFO - 'LOGNAME': 'cltbld', 23:36:27 INFO - 'MAIL': '/var/mail/cltbld', 23:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:27 INFO - 'MOZ_NO_REMOTE': '1', 23:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:27 INFO - 'NO_EM_RESTART': '1', 23:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:27 INFO - 'PWD': '/builds/slave/test', 23:36:27 INFO - 'SHELL': '/bin/bash', 23:36:27 INFO - 'SHLVL': '1', 23:36:27 INFO - 'TERM': 'linux', 23:36:27 INFO - 'TMOUT': '86400', 23:36:27 INFO - 'USER': 'cltbld', 23:36:27 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', 23:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:27 INFO - '_': '/tools/buildbot/bin/python'} 23:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:36:28 INFO - Running setup.py (path:/tmp/pip-chZe99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:36:28 INFO - Running setup.py (path:/tmp/pip-kSH1yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:36:28 INFO - Running setup.py (path:/tmp/pip-4VHTCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:36:28 INFO - Running setup.py (path:/tmp/pip-NrYgP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:36:28 INFO - Running setup.py (path:/tmp/pip-Qw5VVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:36:28 INFO - Running setup.py (path:/tmp/pip-cfo0FN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:36:28 INFO - Running setup.py (path:/tmp/pip-lulRe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:36:28 INFO - Running setup.py (path:/tmp/pip-RXH_bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:36:28 INFO - Running setup.py (path:/tmp/pip-Y067HU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:36:28 INFO - Running setup.py (path:/tmp/pip-9HnKNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:36:28 INFO - Running setup.py (path:/tmp/pip-dqJdQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:36:28 INFO - Running setup.py (path:/tmp/pip-hWSO4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:36:29 INFO - Running setup.py (path:/tmp/pip-Upp8n0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:36:29 INFO - Running setup.py (path:/tmp/pip-ulbebq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:36:29 INFO - Running setup.py (path:/tmp/pip-XsPLXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:36:29 INFO - Running setup.py (path:/tmp/pip-95kL3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:36:29 INFO - Running setup.py (path:/tmp/pip-YnVT4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:36:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:36:29 INFO - Running setup.py install for manifestparser 23:36:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:36:29 INFO - Running setup.py install for mozcrash 23:36:29 INFO - Running setup.py install for mozdebug 23:36:29 INFO - Running setup.py install for mozdevice 23:36:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:36:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:36:29 INFO - Running setup.py install for mozfile 23:36:29 INFO - Running setup.py install for mozhttpd 23:36:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Running setup.py install for mozinfo 23:36:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Running setup.py install for mozInstall 23:36:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Running setup.py install for mozleak 23:36:30 INFO - Running setup.py install for mozlog 23:36:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Running setup.py install for moznetwork 23:36:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Running setup.py install for mozprocess 23:36:30 INFO - Running setup.py install for mozprofile 23:36:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Running setup.py install for mozrunner 23:36:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Running setup.py install for mozscreenshot 23:36:30 INFO - Running setup.py install for moztest 23:36:31 INFO - Running setup.py install for mozversion 23:36:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:36:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:36:31 INFO - Cleaning up... 23:36:31 INFO - Return code: 0 23:36:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:31 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 0x27f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a26400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab5570>, '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 0x2ab6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', '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 23:36:31 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 23:36:31 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 23:36:31 INFO - Using env: {'DISPLAY': ':0', 23:36:31 INFO - 'HOME': '/home/cltbld', 23:36:31 INFO - 'LANG': 'en_US.UTF-8', 23:36:31 INFO - 'LANGUAGE': 'en_US:en', 23:36:31 INFO - 'LOGNAME': 'cltbld', 23:36:31 INFO - 'MAIL': '/var/mail/cltbld', 23:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:31 INFO - 'MOZ_NO_REMOTE': '1', 23:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:31 INFO - 'NO_EM_RESTART': '1', 23:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:31 INFO - 'PWD': '/builds/slave/test', 23:36:31 INFO - 'SHELL': '/bin/bash', 23:36:31 INFO - 'SHLVL': '1', 23:36:31 INFO - 'TERM': 'linux', 23:36:31 INFO - 'TMOUT': '86400', 23:36:31 INFO - 'USER': 'cltbld', 23:36:31 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', 23:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:31 INFO - '_': '/tools/buildbot/bin/python'} 23:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:36:31 INFO - Running setup.py (path:/tmp/pip-gAxDtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:36:31 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)) 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:36:31 INFO - Running setup.py (path:/tmp/pip-opL0pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:36:31 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)) 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:36:31 INFO - Running setup.py (path:/tmp/pip-Rf6ctF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:36:31 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)) 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:36:31 INFO - Running setup.py (path:/tmp/pip-YqAuQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:36:31 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)) 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:36:31 INFO - Running setup.py (path:/tmp/pip-plRvQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:36:31 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)) 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:36:31 INFO - Running setup.py (path:/tmp/pip-abWjli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:36:31 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)) 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:36:31 INFO - Running setup.py (path:/tmp/pip-IsHW4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:36:31 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)) 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:36:31 INFO - Running setup.py (path:/tmp/pip-Y6q5JU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:36:31 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)) 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:36:31 INFO - Running setup.py (path:/tmp/pip-v7xo4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:36:32 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)) 23:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:36:32 INFO - Running setup.py (path:/tmp/pip-6P558e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:36:32 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)) 23:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:36:32 INFO - Running setup.py (path:/tmp/pip-yP4qmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:36:32 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)) 23:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:36:32 INFO - Running setup.py (path:/tmp/pip-hoRjtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:36:32 INFO - Running setup.py (path:/tmp/pip-_HIwlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:36:32 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)) 23:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:36:32 INFO - Running setup.py (path:/tmp/pip-88x9Cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:36:32 INFO - Running setup.py (path:/tmp/pip-J08gAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:36:32 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)) 23:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:36:32 INFO - Running setup.py (path:/tmp/pip-kYzwkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:36:32 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)) 23:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:36:32 INFO - Running setup.py (path:/tmp/pip-wTWJJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:36:32 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)) 23:36:32 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)) 23:36:32 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)) 23:36:32 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)) 23:36:32 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)) 23:36:32 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)) 23:36:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:34 INFO - Downloading blessings-1.6.tar.gz 23:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:36:34 INFO - Installing collected packages: blessings 23:36:34 INFO - Running setup.py install for blessings 23:36:34 INFO - Successfully installed blessings 23:36:34 INFO - Cleaning up... 23:36:34 INFO - Return code: 0 23:36:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:36:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:36:34 INFO - Reading from file tmpfile_stdout 23:36:34 INFO - Current package versions: 23:36:34 INFO - argparse == 1.2.1 23:36:34 INFO - blessings == 1.6 23:36:34 INFO - blobuploader == 1.2.4 23:36:34 INFO - docopt == 0.6.1 23:36:34 INFO - functools32 == 3.2.3-2 23:36:34 INFO - jsonschema == 2.5.1 23:36:34 INFO - manifestparser == 1.1 23:36:34 INFO - mozInstall == 1.12 23:36:34 INFO - mozcrash == 0.17 23:36:34 INFO - mozdebug == 0.1 23:36:34 INFO - mozdevice == 0.48 23:36:34 INFO - mozfile == 1.2 23:36:34 INFO - mozhttpd == 0.7 23:36:34 INFO - mozinfo == 0.9 23:36:34 INFO - mozleak == 0.1 23:36:34 INFO - mozlog == 3.2 23:36:34 INFO - moznetwork == 0.27 23:36:34 INFO - mozprocess == 0.22 23:36:34 INFO - mozprofile == 0.28 23:36:34 INFO - mozrunner == 6.11 23:36:34 INFO - mozscreenshot == 0.1 23:36:34 INFO - mozsystemmonitor == 0.3 23:36:34 INFO - moztest == 0.7 23:36:34 INFO - mozversion == 1.4 23:36:34 INFO - psutil == 3.1.1 23:36:34 INFO - requests == 1.2.3 23:36:34 INFO - wsgiref == 0.1.2 23:36:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:34 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 0x27f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a26400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab5570>, '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 0x2ab6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', '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 23:36:34 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 23:36:34 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 23:36:34 INFO - Using env: {'DISPLAY': ':0', 23:36:34 INFO - 'HOME': '/home/cltbld', 23:36:34 INFO - 'LANG': 'en_US.UTF-8', 23:36:34 INFO - 'LANGUAGE': 'en_US:en', 23:36:34 INFO - 'LOGNAME': 'cltbld', 23:36:34 INFO - 'MAIL': '/var/mail/cltbld', 23:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:34 INFO - 'MOZ_NO_REMOTE': '1', 23:36:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:34 INFO - 'NO_EM_RESTART': '1', 23:36:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:34 INFO - 'PWD': '/builds/slave/test', 23:36:34 INFO - 'SHELL': '/bin/bash', 23:36:34 INFO - 'SHLVL': '1', 23:36:34 INFO - 'TERM': 'linux', 23:36:34 INFO - 'TMOUT': '86400', 23:36:34 INFO - 'USER': 'cltbld', 23:36:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', 23:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:34 INFO - '_': '/tools/buildbot/bin/python'} 23:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 INFO - Cleaning up... 23:36:35 INFO - Return code: 0 23:36:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:36:35 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')]} 23:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:35 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')]} 23:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:35 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 0x27f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a26400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab5570>, '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 0x2ab6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', '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 23:36:35 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 23:36:35 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 23:36:35 INFO - Using env: {'DISPLAY': ':0', 23:36:35 INFO - 'HOME': '/home/cltbld', 23:36:35 INFO - 'LANG': 'en_US.UTF-8', 23:36:35 INFO - 'LANGUAGE': 'en_US:en', 23:36:35 INFO - 'LOGNAME': 'cltbld', 23:36:35 INFO - 'MAIL': '/var/mail/cltbld', 23:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:35 INFO - 'MOZ_NO_REMOTE': '1', 23:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:35 INFO - 'NO_EM_RESTART': '1', 23:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:35 INFO - 'PWD': '/builds/slave/test', 23:36:35 INFO - 'SHELL': '/bin/bash', 23:36:35 INFO - 'SHLVL': '1', 23:36:35 INFO - 'TERM': 'linux', 23:36:35 INFO - 'TMOUT': '86400', 23:36:35 INFO - 'USER': 'cltbld', 23:36:35 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', 23:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:35 INFO - '_': '/tools/buildbot/bin/python'} 23:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:36:35 INFO - Cleaning up... 23:36:35 INFO - Return code: 0 23:36:35 INFO - Running post-action listener: _resource_record_post_action 23:36:35 INFO - Running post-action listener: _start_resource_monitoring 23:36:35 INFO - Starting resource monitoring. 23:36:35 INFO - ##### 23:36:35 INFO - ##### Finished create-virtualenv step (success) 23:36:35 INFO - ##### 23:36:35 INFO - ##### 23:36:35 INFO - ##### Running install step. 23:36:35 INFO - ##### 23:36:35 INFO - Running pre-action listener: _resource_record_pre_action 23:36:35 INFO - Running main action method: install 23:36:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:36:35 INFO - Reading from file tmpfile_stdout 23:36:35 INFO - Detecting whether we're running mozinstall >=1.0... 23:36:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:36:35 INFO - Reading from file tmpfile_stdout 23:36:35 INFO - Output received: 23:36:35 INFO - Usage: mozinstall [options] installer 23:36:35 INFO - Options: 23:36:35 INFO - -h, --help show this help message and exit 23:36:35 INFO - -d DEST, --destination=DEST 23:36:35 INFO - Directory to install application into. [default: 23:36:35 INFO - "/builds/slave/test"] 23:36:35 INFO - --app=APP Application being installed. [default: firefox] 23:36:35 INFO - mkdir: /builds/slave/test/build/application 23:36:35 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'] 23:36:35 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 23:36:51 INFO - Reading from file tmpfile_stdout 23:36:51 INFO - Output received: 23:36:51 INFO - /builds/slave/test/build/application/firefox/firefox 23:36:51 INFO - Running post-action listener: _resource_record_post_action 23:36:51 INFO - ##### 23:36:51 INFO - ##### Finished install step (success) 23:36:51 INFO - ##### 23:36:51 INFO - ##### 23:36:51 INFO - ##### Running run-tests step. 23:36:51 INFO - ##### 23:36:51 INFO - Running pre-action listener: _resource_record_pre_action 23:36:52 INFO - Running main action method: run_tests 23:36:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:36:52 INFO - Python 2.7.3 23:36:52 INFO - Return code: 0 23:36:52 INFO - grabbing minidump binary from tooltool 23:36:52 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')]} 23:36:52 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 0x2ab5570>, '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 0x2ab6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:36:52 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 23:36:52 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 23:36:52 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 23:36:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:36:52 INFO - Return code: 0 23:36:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:36:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:36:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:36:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:36:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:36:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 23:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 23:36:52 INFO - Using env: {'DISPLAY': ':0', 23:36:52 INFO - 'HOME': '/home/cltbld', 23:36:52 INFO - 'LANG': 'en_US.UTF-8', 23:36:52 INFO - 'LANGUAGE': 'en_US:en', 23:36:52 INFO - 'LOGNAME': 'cltbld', 23:36:52 INFO - 'MAIL': '/var/mail/cltbld', 23:36:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:36:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:52 INFO - 'MOZ_NO_REMOTE': '1', 23:36:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:36:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:52 INFO - 'NO_EM_RESTART': '1', 23:36:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:52 INFO - 'PWD': '/builds/slave/test', 23:36:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:36:52 INFO - 'SHELL': '/bin/bash', 23:36:52 INFO - 'SHLVL': '1', 23:36:52 INFO - 'TERM': 'linux', 23:36:52 INFO - 'TMOUT': '86400', 23:36:52 INFO - 'USER': 'cltbld', 23:36:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415', 23:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:52 INFO - '_': '/tools/buildbot/bin/python'} 23:36:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 23:36:52 INFO - mozversion application_buildid: 20160702144223 23:36:52 INFO - mozversion application_changeset: b8b3b1c92085c1f8b74c13203289360932182da4 23:36:52 INFO - mozversion application_display_name: Nightly 23:36:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:36:52 INFO - mozversion application_name: Firefox 23:36:52 INFO - mozversion application_remotingname: firefox 23:36:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 23:36:52 INFO - mozversion application_vendor: Mozilla 23:36:52 INFO - mozversion application_version: 50.0a1 23:36:52 INFO - mozversion platform_buildid: 20160702144223 23:36:52 INFO - mozversion platform_changeset: b8b3b1c92085c1f8b74c13203289360932182da4 23:36:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 23:36:52 INFO - mozversion platform_version: 50.0a1 23:36:52 INFO - using testdate: 1467527812 23:36:52 INFO - actual date: 1467527812 23:36:52 INFO - starting webserver on 'localhost:37008' 23:36:52 INFO - SUITE-START | Running 2 tests 23:36:52 INFO - TEST-START | dromaeo_css 23:36:52 INFO - operating with platform_type : linux_ 23:36:52 INFO - Initialising browser for dromaeo_css test... 23:36:52 INFO - TEST-INFO | started process 3638 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4OwMfO/profile http://localhost:37008/getInfo.html) 23:36:56 INFO - PROCESS | 3638 | __metrics Screen width/height:1600/1200 23:36:56 INFO - PROCESS | 3638 | colorDepth:24 23:36:56 INFO - PROCESS | 3638 | Browser inner width/height: 1024/697 23:36:56 INFO - PROCESS | 3638 | __metrics 23:36:57 ERROR - PROCESS | 3638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 23:36:58 INFO - TEST-INFO | 3638: exit 0 23:36:58 INFO - Browser initialized. 23:36:58 INFO - Running cycle 1/1 for dromaeo_css test... 23:36:58 INFO - TEST-INFO | started process 3758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4OwMfO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:37:10 INFO - PROCESS | 3758 | RSS: Main: 169693184 23:37:10 INFO - PROCESS | 3758 | 23:37:59 INFO - PROCESS | 3758 | 1467527879886 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] 23:40:12 INFO - PROCESS | 3758 | Cycle 1(1): loaded http://localhost:37008/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37008/tests/dromaeo/cssquery-ext.html) 23:40:13 INFO - PROCESS | 3758 | RSS: Main: 171741184 23:40:13 INFO - PROCESS | 3758 | 23:43:15 INFO - PROCESS | 3758 | Cycle 1(1): loaded http://localhost:37008/tests/dromaeo/cssquery-ext.html (next: http://localhost:37008/tests/dromaeo/cssquery-jquery.html) 23:43:16 INFO - PROCESS | 3758 | RSS: Main: 168824832 23:43:16 INFO - PROCESS | 3758 | 23:46:18 INFO - PROCESS | 3758 | Cycle 1(1): loaded http://localhost:37008/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37008/tests/dromaeo/cssquery-mootools.html) 23:46:18 INFO - PROCESS | 3758 | RSS: Main: 172150784 23:46:18 INFO - PROCESS | 3758 | 23:49:20 INFO - PROCESS | 3758 | Cycle 1(1): loaded http://localhost:37008/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37008/tests/dromaeo/cssquery-prototype.html) 23:49:21 INFO - PROCESS | 3758 | RSS: Main: 167841792 23:49:21 INFO - PROCESS | 3758 | 23:52:23 INFO - PROCESS | 3758 | Cycle 1(1): loaded http://localhost:37008/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37008/tests/dromaeo/cssquery-yui.html) 23:52:24 INFO - PROCESS | 3758 | RSS: Main: 169000960 23:52:24 INFO - PROCESS | 3758 | 23:55:27 INFO - PROCESS | 3758 | Cycle 1(1): loaded http://localhost:37008/tests/dromaeo/cssquery-yui.html (next: http://localhost:37008/tests/dromaeo/cssquery-dojo.html) 23:55:27 INFO - PROCESS | 3758 | RSS: Main: 170369024 23:55:27 INFO - PROCESS | 3758 | 23:55:27 INFO - PROCESS | 3758 | __start_tp_report 23:55:27 INFO - PROCESS | 3758 | _x_x_mozilla_page_load 23:55:27 INFO - PROCESS | 3758 | _x_x_mozilla_page_load_details 23:55:27 INFO - PROCESS | 3758 | |i|pagename|runs| 23:55:27 INFO - PROCESS | 3758 | |0;dojo.html;2658.9601155982664;2692.0577797770775;2703.9864800675996;2732.6037724529942;2735.521283775339;4803.9519604803945;4863.635227357949;4929.753512324383;4944.2089265717495;4965.28003439501;4754.191787396142;4776.617870570355;4793.089313030522;4810.39870016248;4845.127876982142;4378.430803995476;4457.777111144446;4497.550244975492;4516.18708632446;4569.040501494674;563.9193634663624;4380.299152135659;4500.774961251941;4525.773711314438;4536.34223037661;4401.9119617607785;4407.294832826765;4409.206342858284;4424.093060922503;4468.620167285784;4430.11397720454;4439.445069366329;4439.511653718088;4449.087936972913;4492.550744925514;4450.10997800438;4491.92193873468;4499.1901457737595;4547.499775024745;4559.74921379324;4903.166461701519;4915.311856340115;4931.260310953386;4946.72792996385;4960.479149689303;5018.7992480300745;5112.667676601009;5146.922796158061;5159.432462429129;5296.894062118736;5279.076161671692;5289.259503669489;5299.6025298102795;5300.151975683911;5337.092694241988;4878.536539028786;4885.340479035356;4897.730624815598;4898.24077268024;4938.728369939616;5186.429492755794;5359.5712343012465;5381.461853814587;5397.568194544427;5436.592255580768;5184.222366644958;5202.76587553561;5206.271122042841;5214.270002199695;5217.191335343028;5288.206768984683;5294.364676238876;5301.787928482818;5304.92042619361;5337.172738225581;5123.692578445305;5139.743012849342;5186.792528298901;5199.246109314128;5204.531592156724;5061.190209566452;5121.4622464641425;5151.407588127413;5162.096633089194;5234.42421333653;4378.343248512749;4394.846180383671;4395.1868904252815;4396.076823867023;4428.734275943454;3794.8102594870147;3824;3856.7107466940092;3873.24471728016;3881.9611803882162;4600.7929643166135;4608.631309495299;4617.238155704338;4628.5371462853445;4629.375034370317;5099;5269.762860671279;5315.4950279724135;5316.840494785162;5342.305500284938;4542.909141817145;4589.449266088091;4597.287420449836;4612.538746125428;4622.098690755338;4723.858284251478;4734.668573199843;4745.9050818984115;4751.667383283137;4771.5228477152;4705.12955103307;4845.079434907357;5001.399832020181;5006.07387633289;5027.4721154279005;5180.430152683277;5211.791528338976;5234.319538459976;5238.580913526833;5297.5232229099565;4895.8041678332465;4914.5822605078965;4919.680220785781;4931.0630980113665;4971.279164521196;5085.160948443466;5125.333706618116;5126.6923984561045;5135.922961155511;5175.482451754794;5252.5535329497425;5254.13306804373;5257;5257.973710131425;5263.131583288715;5124.846254612367;5125.718085505333;5126.487351264993;5128.1794912813775;5165.018646457161;4888.902221955612;5091.363579552556;5113.565346945551;5144.485551444825;5155.510226528624;4914.287428322802;4948.752562371939;4966.900661986668;4987.625928055338;5051.090803655377;5129.179331306973;5151.922721159111;5155.639105262596;5157.406898206755;5158.329417175743;4925.0396172747405;5016.046951079284;5057.873553161053;5058.291839142449;5088.745562721923 23:55:27 INFO - PROCESS | 3758 | |1;ext.html;545.141906957409;579.2325169150876;587.2688502813998;602.3765402808092;622.7789134857128;35824.64175358249;40561.79719101404;40729.7963510182;40795.79602101993;40901.795491022574;40198.59801401985;40618;40724.18551628965;40742;41009.17981640365;7857.174996625344;7986.800329991738;8008.319292860114;8014.67941282348;8022.799430014238;7862.449628526006;7903.604819759018;7929.762107136795;7955.840883182333;7960.880586791202;7906.960465197666;7960.840783184332;7977.760667179965;8011.399145064114;8016.959915200416;7937.087234967966;7972.202779722011;7981.640826162837;7982.24168703978;7988.680452781882;7910.050793904711;7969.681212751483;7969.920300796975;7971.242731940514;7974.840503189962;39013.60986390128;39135.41296880549;39374.40938385927;39668.20663586741;39772.403413948814;3171.6035495563056;3283.3761585298716;3295.670432956709;3296.175956010997;3310.7682462227654;29823.552646710315;30296.394072118434;30297.242568935733;30543.541846872315;31130.37739245225;3353.252824696841;3359.445691460906;3377.3245350929665;3398.847051882671;3453.2920751245933;253507;253757;255072;255159;255408;32611.18472038218;54757.72621136869;55184.44815551873;55326.44673553293;55375.72312138414;32314;34543.4818477723;34546.82726586401;34785;34795.13012174665;13477.258750768802;13656.65858353549;13673.521426750016;13710.588682339545;13710.588682339545;11010.339379637247;11114.11087113029;11174.776504469864;11205.551777928791;11215.383153926612;8121.512709237465;8136.0643525995265;8173.754787356389;8191.631376588068;8232.300254478436;3172.159377764894;3182.2839861031084;3217.3565286942703;3240.3357311751033;3257.039173443792;893.2898345815092;993.1657407777501;995.4525011243787;1002.869626948492;1034.963776267827;28435.28911777181;28866.567001494994;28906;29028.12915612535;29278.707212928024;1001.6544292219173;1005.1154983614373;1030.4796077980723;1033.1992705653179;1039.9428031458192;15203.391864325304;15389.307481163374;15568.844311556966;15580;15874.365025398854;401878;403924;404473;405779;406254;32765.50851737226;33792.83103584466;33846.49230261548;33860.49209261863;33920.66079339224;1176.923499972516;1202.9338386388833;1205.2949024820578;1214.872438393956;1216.0514798457218;27315.180544582898;27679.308017298925;28502.57246141351;28699.28251793722;28699.856500717364;44512.777436112614;44711.329330060726;44926;44999.550004499535;45089.323660144466;320462;324631;328289;329136;329345;25478.617820733074;25832;25897;26014.739852601233;26020.479590408464;42808.14383712246;44131.57276349831;47187.528124718316;47745.28382074202;48391.51608484011;37136.25727485381;38000.429993549566;38428.615713843625;38522.422163667004;38536.229275413774;37932.62067379291;38121;38376.80811595924;38409.615903840604;39350.40974385444;36297.27405451823;37229.6277037237;37583.81208093942;37700.43449348207;37707.81146094252;31165.53251701181;33874.83062584671;34368.82815585906;34691.826540867136;34843;26427.207183783747;26500;26595;26780.732192678603;26831.463370732865 23:55:27 INFO - PROCESS | 3758 | |2;jquery.html;352.8359312919492;363.26076434455877;363.3006462559573;364.10611947668446;379.5824592947758;16878.32486700532;17264.82735172648;17877.463676089705;17930.641387172247;17958.742887997847;15946.601334966632;16060.518184454486;16609.252583633734;16648.75026874595;16677.24952377146;5203.19350500672;5263.973525162595;5367.409584945673;5371.623986320959;5383.43473935237;5260.894782104356;5273.419923808378;5284.313039304885;5342.465753424665;5369.919451208235;5152.510511501401;5226.895462090756;5228.398734145565;5247.2653828464045;5263.526282634562;5155.097857874857;5214.009338225725;5226.895462090756;5245.344331958505;5264.42091369949;4581.63346932248;4671.34601155835;4699.976500117477;4703.858884233478;4710.152172608929;20333.694994575093;20607;20900;21205.575888482144;21207.363779086652;1912.7513423255027;2107.9473013174793;2111.862728922615;2264.1735766445295;2319.2810228829117;13453.192808431526;13557.59327220185;13661.112027718265;13715;13861.09902856311;1538.7230298546258;1739.2347367158536;1766.0198589782665;1770.7963584187855;1774.5829730013436;71907.28092719059;73846;74861.62569187119;75327.24672753258;76057.61971190109;9786.706398808046;9872.851907221397;9889.901100989042;9935.80128397428;10046.095851373411;13022.674433139058;13217.73564528704;13226.404811783494;13611.659708507366;13628.795568066487;7425.368843648243;7465.29079737424;7493.463839912804;7565.43259255558;7565.470417070862;7267.563946163247;7302;7323.340899319087;7448.217937116633;7464.70141194357;4093.9590604094174;4165.229432554987;4191.077962848169;4325.740455572675;4558.5897269245925;1765.4615342320458;1812.1030090105482;1823.881447705895;1836.2104295152944;1865.5709186887093;873.733511279066;891.233539156325;913.1827014821697;949.4303417949175;950.1163917556601;16992.915035424743;17235.91382043082;17328.220230089675;17352.132393380532;17365.82634173642;862.4652715316544;884.8186121845006;885.5350940756155;920.2867777472512;921.5438358012826;9320.347575669774;9552.856707149398;9807.313488055768;9831.803363932824;10007.799844003079;432229;434397;435042;443497;445985;69306.30693692999;78594.21405785983;79070;81515.5924220387;84340;888.9866652000354;900.6352427266968;901.6168128545341;930.1907340613709;930.3534043839467;15638.45265415705;15735.68528629444;15783.842161578697;15896.364145434052;16386.918065409598;35763;36612;37849.4322585156;39928;41139.177216456104;54218.728906355216;56480.717596411756;57267.42732572788;57396.71301643465;57528.71235643795;7443.18125006238;7531.510451820614;7605.23947605235;7696.961515192388;7713.730019449293;12238.44926978306;12306.569270075504;12342.13605047638;12599.370031498573;12726.554570589984;10759.731006724582;10787.244892857425;10828.837567436653;11016.559337626406;11118.944405277922;10738.463076846283;10761.569537218424;10775.94612026935;10871.075958543295;11077.390743509184;10109.545070471993;11025.283356581796;11143.777124457303;11180.608678696206;11381.089512839118;7842;8035.758927232192;8040.557769322743;8086.231807978233;8170.182981701782;11003.504842282277;11055.613053543088;11080.113590912546;11225.270357426742;11356.0915126788 23:55:27 INFO - PROCESS | 3758 | |3;mootools.html;1335.185536822538;1392.9135274485902;1440.841507434182;1676.1786724504996;1707.2061491406494;7124.145102587684;7654.578998155106;7759.844803103934;8169.877451838227;8176.427650064498;7925.564093974829;8063.677452901891;8175.5503447310375;8192.467489613171;8224.465409748376;2174.20641465865;2210.5136869888597;2214.070090561968;2215.5679642469727;2218.8779617121054;2244.5735310290993;2273.193016479151;2281.931542053741;2284.7829456201634;2287.977120228793;2257.604919139152;2265.7734226577295;2274.7611500792345;2279.1225378229337;2279.1225378229337;2108.0513768803944;2123.331150687536;2132;2142.5929073476145;2146.7638559758416;2187.628103222456;2191.430228140695;2201.0975500045065;2207.293666026872;2207.404000919759;8158.510489370657;8211.05572859123;8219.794505137419;8253.546054966975;8304.584770761438;4720.645951553647;4842.854714358575;4868.634852386085;4873.829415970424;4880.072786170616;2854.785891058158;3042.8326442045677;3061.7091376319436;3061.755059595227;3099.6900309969046;991.8859331176935;1020.8417695257247;1042.4370839746528;1048.486241741541;1049.9265051446403;11185.944070279678;11204;11205.047570956478;11234.943825280821;11247.60633377836;4242.215190189825;4271.145770845843;4406.25093734066;4482.731036137842;4526.23054080807;9530.475823829756;9540.85688714656;9544.809103817885;9547.188488978514;9554.570044347882;4780.306855505932;4789.161896668069;4791.856244312677;4795;4799.496052914464;3806.1245913440066;4221.387898754663;4376.606105450524;4390.3414487827085;4391.714538554984;3792.1467669774634;3840.8271627776817;3896.922061558753;3925.725199236083;3974.006498375406;1148.9200151857228;1234.8394708687993;1244.4773195258012;1252.0546987024738;1255.5480027190204;835.853725598018;837.6105111123356;841.0916210492653;861.1560670542777;870.991290087091;5372.274742909735;5387.542058924957;5441.428649991773;5501.092319767274;5529.170624406372;418.13654802832053;419.96640268778424;422.44870444070784;898.5507246376811;938.3009657804979;3540.3627347077772;3616.81915904209;3689.7786132832116;3697.4638677391627;3701.5188025557045;9733.17268032211;10031.347962382422;10044.497775111215;10121;10122.898771012344;9841.753956151011;9958.950205249072;10017.248706347053;10026.097651211427;10059.094681478702;7408.62956852166;7471.813204669927;7570.16728159902;7577.446623442292;7584.089909210819;5202.505761952609;5230.110881150137;5240.240165175952;5285.867853303698;5345.412004679404;9137.680181193626;9311.255099591881;9416.95291523538;9497.572609232462;9502.66740664101;9398.718038458857;9509.904900950902;9517.952410237904;9698.515074246401;9699.17557007634;5791.0734282514595;6450.258220304725;6694.799156025327;6715.395614394728;6863.519553631198;7853.057633084067;7907.406944479072;7917.722879699183;7933.8413231736195;8003.6798528058225;6840.760573379908;7105.18290396611;7121.893171602326;7203.747868824776;7250.41996640257;6912.412444942035;6993.2657071006815;7138.072050633385;7158.2841715828;7228.457865660202;6615.4376877965915;6718.421171024707;6726.630035348103;6730.932690673227;6742.056112144206;4662.603678687349;4680.297955306732;4756.881077973078;4811.374521312207;4824.614030877591;4817.156997525349;4841.75791210431;4881.8535443936735;4903.656744027884;4923.483034281349 23:55:27 INFO - PROCESS | 3758 | |4;prototype.html;296.94209629122304;306.1611185352135;312.6373406848055;317.0599173450718;319.2736524406974;4966.428860681022;4978.55193032627;5125.487451254878;5144.742762861861;5165.845024649262;5062.215356619729;5064.924026139602;5069.569086627641;5104.642675012741;5122.207227470383;3964.7422917510344;3992.3412636914873;4008.0781420273356;4018.5378681451716;4038;3917.1969746202103;3999.4200840878057;4023.8792836214816;4029.435878976946;4044.5955404459614;3956.863293821333;3962.445257663929;3962.7027972902006;3984.462097616828;3996.7601943883315;3983.780892050936;3993.5223967132347;4002.3596224604216;4004.299247631667;4014.8193331300163;3516.2791627716256;3532;3533.646635336446;3537.726418489342;3546.8758593449106;4837.564619184255;4937.21004639256;4991.975040124777;4998.9500104999215;5019.4227663818765;4530.728156310599;4546.431266334511;4547.909041819145;4553;4575.9771201143785;5320.14877619579;5328.254044433782;5378.973105134489;5382.381026182;5383.784648614051;3777.6033516480647;3799.25914446683;3810.066533699234;3837.7313588048846;3884.4367566702954;5571.192177134293;5594.042085270164;5600.299962504687;5634;5649.265595472562;3900.6099390060767;3911.6088391160656;3918.45141680165;3919.412088186795;3940;3840.731148819556;3977.661898738582;3994.981279773639;3998.520177578709;3998.960010399917;4491.550844915548;4492.887677808016;4495.88760280989;4545.931811022837;4547.658925580595;5330.280412144389;5348.973255133699;5356.625036247426;5365.275687782099;5389.676619402849;1276.8914642255513;1356.5862411964445;1378.9931050344685;1381.2196109198271;1390.867867552581;932.5570354081757;941.4445477168504;963.2679163835536;964.1515466389533;967.4533888353058;4636.304554316879;4642.280446530793;4656.486641841415;4670.089332580183;4691.62467002639;5389.67661940277;5422.024035673538;5450.155225939986;5459.235707000944;5468.398476167618;4526.253168227206;4669.906601867943;4673.7429441381055;4686.906261874743;4709.317149013374;2942.735153836165;2945.4403663303906;2945.867435965387;2958;2963.125877866035;5198.610104242197;5211.628708937425;5261.710605916634;5298.311219541512;5308.256844041837;5398.703071331114;5610.186522954149;5661.235733176051;5704.543636509069;5705.7147142643535;5209.921851172236;5249.763760630781;5280.498352656491;5290.788368465218;5297.735113244245;5576.860578485408;5585.748641311232;5588.2455868458865;5616.775328986795;5619.775208991595;5188.325517682677;5445.40100588927;5454.890902182014;5474.288342515448;5498.752556135064;5215.791368345223;5223.660462069954;5230.084735171406;5232.633715640021;5245.790168393221;3832.6358995895343;3866;3867.640739149173;3873.35382462458;3888.5528164261473;5217.217417387422;5240.947590524046;5410.756515956713;5555.694436806015;5556.72216389187;5353.625246232882;5360.70516121617;5375.81184658535;5387.703676297841;5428.697112693004;5335.786568537215;5342.866428339323;5354.143337066051;5369.6509726867625;5380.811671591476;5157.859488312309;5282.366116066097;5298.44366341544;5299.39057008449;5322.935412917354;5393.303348325837;5452.2094296327605;5460.563154947674;5467.343918729778;5483.890322193454;5238.71651445383;5250.18622113573;5266.97366513165;5273.551748101454;5328.3605967284175 23:55:27 INFO - PROCESS | 3758 | |5;yui.html;664.1565212180531;729.4784229276066;730.9451791115664;742.4431676242818;748.913874904386;11661.825072623897;13197.340132993348;13980.091294065878;14276;14296.928515357422;14007.439702411892;14616.4884229052;14618.561443156696;14652.560423187322;14743.26283685814;745.5675708089309;766.6741634805213;767.1752865669428;770.2297702297702;771.6103367799253;776.770852598482;777.6422845491081;782.4014628808937;782.86299897518;783.5651213576463;827.6317038917684;827.755812035451;829.2122483640535;830.3108420011376;831.476170012894;759.9012128423325;823.0247157118833;824.517657170553;825.8100636853527;829.3613917283718;592.0734051209843;596.4959609130278;596.6897213449025;598.2252982387819;599.7810799058356;14940.62648433787;15028.699426011419;15045.097294162275;15048.322825472771;15078.170700611461;13494.730105397935;13987.860121398757;13994.930025349808;14040.929795350958;14064.929675351661;11138.164637652128;11140.665780026531;11147.275427097213;11189.160812939062;11272.718182045432;3376.2403459221478;3414.6585341465902;3442.845071971767;3465.151037995682;3554.377983852841;73310.26689733088;73679;74275;75813;76293.61853190699;10517.9474102629;10570.207234457446;10660.626878059385;10688.251822372515;10872.891271087346;19198.904005479882;19265.51836204106;19353;19914.800851991586;19976.700349494768;6691.531592788556;6881.10545629075;6965.686544105527;6967.198772141167;7078.858422831515;4005.6995725320135;4109.91780164395;4129.958700413017;4157.168566286755;4158.542560318362;3054.648715397713;3133.4046531159006;3159.684031596822;3165.525171224289;3170.9841450792596;513.0841448015275;538.785039735402;542.8208691131917;555.3585608622049;588.7821506042792;489.48114998101414;530.3291336459382;545.1985581195636;584.0538327908815;619.3342157181048;8194.139615340422;8240.917590824134;8425.325973922194;8485.703000394957;8761.780955476164;484.849696594057;523.4425337016065;560.4087687489738;600.942910423509;607.4988134788729;3962.623550762673;4010.5387880393546;4084.1219137885496;4135.875923722293;4282.332900874509;98437.50781246192;99136;99866.50066749619;100022;101935.4903225479;84496.15503845006;84621.57689211515;84730.57634711787;85276.57361713276;85279.5736021316;72834.63582682052;75219.62390188123;75738;76107.61946190345;76299;7968.322692571196;8107.756767296991;8231;8287.461315014505;8390.993080830096;31231.84384078065;39315.213695726496;40193.1961360777;41873;43688.34467482927;56756.14865776934;61896;64399.67800160969;65334.67332663306;65885;11475.254108483256;11566.65300041;11684.18210725241;11813.966502778194;11998.40007999579;13170.143940643828;13231.139975901535;13339.866601333862;13545.645435456376;13574.04981651275;11993.520259189883;12027.15809893299;12064.276143431422;12205.389730513261;12685.4291556882;12062.698432539257;12130.393480325773;12207.206531575419;12619.9904007681;12928.224306541637;11659.125565582446;11823.76352472963;12226.20529665569;12363.32001739913;12364.319962402154;9946.801063978824;10467.005634464713;10627.521761520904;10666.8399974002;10757.46212689378;9681.612735490502;9802.803943921224;9818.45998470091;10174.041474562426;10231.079202871777 23:55:27 INFO - PROCESS | 3758 | __end_tp_report 23:55:27 INFO - PROCESS | 3758 | __start_cc_report 23:55:27 INFO - PROCESS | 3758 | _x_x_mozilla_cycle_collect,389 23:55:27 INFO - PROCESS | 3758 | __end_cc_report 23:55:27 INFO - PROCESS | 3758 | __startTimestamp1467528927599__endTimestamp 23:55:27 INFO - PROCESS | 3758 | 23:55:27 INFO - PROCESS | 3758 | ------- Summary: start ------- 23:55:27 INFO - PROCESS | 3758 | Number of tests: 6 23:55:27 INFO - PROCESS | 3758 | 23:55:27 INFO - PROCESS | 3758 | [#0] dojo.html Cycles:165 Average:4809.86 Median:4960.48 stddev:611.74 (12.3%) stddev-sans-first:589.89 23:55:27 INFO - PROCESS | 3758 | Values: 2659.0 2692.1 2704.0 2732.6 2735.5 4804.0 4863.6 4929.8 4944.2 4965.3 4754.2 4776.6 4793.1 4810.4 4845.1 4378.4 4457.8 4497.6 4516.2 4569.0 563.9 4380.3 4500.8 4525.8 4536.3 4401.9 4407.3 4409.2 4424.1 4468.6 4430.1 4439.4 4439.5 4449.1 4492.6 4450.1 4491.9 4499.2 4547.5 4559.7 4903.2 4915.3 4931.3 4946.7 4960.5 5018.8 5112.7 5146.9 5159.4 5296.9 5279.1 5289.3 5299.6 5300.2 5337.1 4878.5 4885.3 4897.7 4898.2 4938.7 5186.4 5359.6 5381.5 5397.6 5436.6 5184.2 5202.8 5206.3 5214.3 5217.2 5288.2 5294.4 5301.8 5304.9 5337.2 5123.7 5139.7 5186.8 5199.2 5204.5 5061.2 5121.5 5151.4 5162.1 5234.4 4378.3 4394.8 4395.2 4396.1 4428.7 3794.8 3824.0 3856.7 3873.2 3882.0 4600.8 4608.6 4617.2 4628.5 4629.4 5099.0 5269.8 5315.5 5316.8 5342.3 4542.9 4589.4 4597.3 4612.5 4622.1 4723.9 4734.7 4745.9 4751.7 4771.5 4705.1 4845.1 5001.4 5006.1 5027.5 5180.4 5211.8 5234.3 5238.6 5297.5 4895.8 4914.6 4919.7 4931.1 4971.3 5085.2 5125.3 5126.7 5135.9 5175.5 5252.6 5254.1 5257.0 5258.0 5263.1 5124.8 5125.7 5126.5 5128.2 5165.0 4888.9 5091.4 5113.6 5144.5 5155.5 4914.3 4948.8 4966.9 4987.6 5051.1 5129.2 5151.9 5155.6 5157.4 5158.3 4925.0 5016.0 5057.9 5058.3 5088.7 23:55:27 INFO - PROCESS | 3758 | 23:55:27 INFO - PROCESS | 3758 | [#1] ext.html Cycles:180 Average:47339.08 Median:34790.07 stddev:88201.35 (253.5%) stddev-sans-first:88378.81 23:55:27 INFO - PROCESS | 3758 | Values: 545.1 579.2 587.3 602.4 622.8 35824.6 40561.8 40729.8 40795.8 40901.8 40198.6 40618.0 40724.2 40742.0 41009.2 7857.2 7986.8 8008.3 8014.7 8022.8 7862.4 7903.6 7929.8 7955.8 7960.9 7907.0 7960.8 7977.8 8011.4 8017.0 7937.1 7972.2 7981.6 7982.2 7988.7 7910.1 7969.7 7969.9 7971.2 7974.8 39013.6 39135.4 39374.4 39668.2 39772.4 3171.6 3283.4 3295.7 3296.2 3310.8 29823.6 30296.4 30297.2 30543.5 31130.4 3353.3 3359.4 3377.3 3398.8 3453.3 253507.0 253757.0 255072.0 255159.0 255408.0 32611.2 54757.7 55184.4 55326.4 55375.7 32314.0 34543.5 34546.8 34785.0 34795.1 13477.3 13656.7 13673.5 13710.6 13710.6 11010.3 11114.1 11174.8 11205.6 11215.4 8121.5 8136.1 8173.8 8191.6 8232.3 3172.2 3182.3 3217.4 3240.3 3257.0 893.3 993.2 995.5 1002.9 1035.0 28435.3 28866.6 28906.0 29028.1 29278.7 1001.7 1005.1 1030.5 1033.2 1039.9 15203.4 15389.3 15568.8 15580.0 15874.4 401878.0 403924.0 404473.0 405779.0 406254.0 32765.5 33792.8 33846.5 33860.5 33920.7 1176.9 1202.9 1205.3 1214.9 1216.1 27315.2 27679.3 28502.6 28699.3 28699.9 44512.8 44711.3 44926.0 44999.6 45089.3 320462.0 324631.0 328289.0 329136.0 329345.0 25478.6 25832.0 25897.0 26014.7 26020.5 42808.1 44131.6 47187.5 47745.3 48391.5 37136.3 38000.4 38428.6 38522.4 38536.2 37932.6 38121.0 38376.8 38409.6 39350.4 36297.3 37229.6 37583.8 37700.4 37707.8 31165.5 33874.8 34368.8 34691.8 34843.0 26427.2 26500.0 26595.0 26780.7 26831.5 23:55:27 INFO - PROCESS | 3758 | 23:55:27 INFO - PROCESS | 3758 | [#2] jquery.html Cycles:180 Average:26282.60 Median:218277.37 stddev:72228.42 (33.1%) stddev-sans-first:72404.80 23:55:27 INFO - PROCESS | 3758 | Values: 352.8 363.3 363.3 364.1 379.6 16878.3 17264.8 17877.5 17930.6 17958.7 15946.6 16060.5 16609.3 16648.8 16677.2 5203.2 5264.0 5367.4 5371.6 5383.4 5260.9 5273.4 5284.3 5342.5 5369.9 5152.5 5226.9 5228.4 5247.3 5263.5 5155.1 5214.0 5226.9 5245.3 5264.4 4581.6 4671.3 4700.0 4703.9 4710.2 20333.7 20607.0 20900.0 21205.6 21207.4 1912.8 2107.9 2111.9 2264.2 2319.3 13453.2 13557.6 13661.1 13715.0 13861.1 1538.7 1739.2 1766.0 1770.8 1774.6 71907.3 73846.0 74861.6 75327.2 76057.6 9786.7 9872.9 9889.9 9935.8 10046.1 13022.7 13217.7 13226.4 13611.7 13628.8 7425.4 7465.3 7493.5 7565.4 7565.5 7267.6 7302.0 7323.3 7448.2 7464.7 4094.0 4165.2 4191.1 4325.7 4558.6 1765.5 1812.1 1823.9 1836.2 1865.6 873.7 891.2 913.2 949.4 950.1 16992.9 17235.9 17328.2 17352.1 17365.8 862.5 884.8 885.5 920.3 921.5 9320.3 9552.9 9807.3 9831.8 10007.8 432229.0 434397.0 435042.0 443497.0 445985.0 69306.3 78594.2 79070.0 81515.6 84340.0 889.0 900.6 901.6 930.2 930.4 15638.5 15735.7 15783.8 15896.4 16386.9 35763.0 36612.0 37849.4 39928.0 41139.2 54218.7 56480.7 57267.4 57396.7 57528.7 7443.2 7531.5 7605.2 7697.0 7713.7 12238.4 12306.6 12342.1 12599.4 12726.6 10759.7 10787.2 10828.8 11016.6 11118.9 10738.5 10761.6 10775.9 10871.1 11077.4 10109.5 11025.3 11143.8 11180.6 11381.1 7842.0 8035.8 8040.6 8086.2 8170.2 11003.5 11055.6 11080.1 11225.3 11356.1 23:55:27 INFO - PROCESS | 3758 | 23:55:27 INFO - PROCESS | 3758 | [#3] mootools.html Cycles:180 Average:5336.51 Median:4833.19 stddev:3027.19 (62.6%) stddev-sans-first:3020.75 23:55:27 INFO - PROCESS | 3758 | Values: 1335.2 1392.9 1440.8 1676.2 1707.2 7124.1 7654.6 7759.8 8169.9 8176.4 7925.6 8063.7 8175.6 8192.5 8224.5 2174.2 2210.5 2214.1 2215.6 2218.9 2244.6 2273.2 2281.9 2284.8 2288.0 2257.6 2265.8 2274.8 2279.1 2279.1 2108.1 2123.3 2132.0 2142.6 2146.8 2187.6 2191.4 2201.1 2207.3 2207.4 8158.5 8211.1 8219.8 8253.5 8304.6 4720.6 4842.9 4868.6 4873.8 4880.1 2854.8 3042.8 3061.7 3061.8 3099.7 991.9 1020.8 1042.4 1048.5 1049.9 11185.9 11204.0 11205.0 11234.9 11247.6 4242.2 4271.1 4406.3 4482.7 4526.2 9530.5 9540.9 9544.8 9547.2 9554.6 4780.3 4789.2 4791.9 4795.0 4799.5 3806.1 4221.4 4376.6 4390.3 4391.7 3792.1 3840.8 3896.9 3925.7 3974.0 1148.9 1234.8 1244.5 1252.1 1255.5 835.9 837.6 841.1 861.2 871.0 5372.3 5387.5 5441.4 5501.1 5529.2 418.1 420.0 422.4 898.6 938.3 3540.4 3616.8 3689.8 3697.5 3701.5 9733.2 10031.3 10044.5 10121.0 10122.9 9841.8 9959.0 10017.2 10026.1 10059.1 7408.6 7471.8 7570.2 7577.4 7584.1 5202.5 5230.1 5240.2 5285.9 5345.4 9137.7 9311.3 9417.0 9497.6 9502.7 9398.7 9509.9 9518.0 9698.5 9699.2 5791.1 6450.3 6694.8 6715.4 6863.5 7853.1 7907.4 7917.7 7933.8 8003.7 6840.8 7105.2 7121.9 7203.7 7250.4 6912.4 6993.3 7138.1 7158.3 7228.5 6615.4 6718.4 6726.6 6730.9 6742.1 4662.6 4680.3 4756.9 4811.4 4824.6 4817.2 4841.8 4881.9 4903.7 4923.5 23:55:27 INFO - PROCESS | 3758 | 23:55:27 INFO - PROCESS | 3758 | [#4] prototype.html Cycles:180 Average:4456.10 Median:5113.42 stddev:1292.16 (25.3%) stddev-sans-first:1257.51 23:55:27 INFO - PROCESS | 3758 | Values: 296.9 306.2 312.6 317.1 319.3 4966.4 4978.6 5125.5 5144.7 5165.8 5062.2 5064.9 5069.6 5104.6 5122.2 3964.7 3992.3 4008.1 4018.5 4038.0 3917.2 3999.4 4023.9 4029.4 4044.6 3956.9 3962.4 3962.7 3984.5 3996.8 3983.8 3993.5 4002.4 4004.3 4014.8 3516.3 3532.0 3533.6 3537.7 3546.9 4837.6 4937.2 4992.0 4999.0 5019.4 4530.7 4546.4 4547.9 4553.0 4576.0 5320.1 5328.3 5379.0 5382.4 5383.8 3777.6 3799.3 3810.1 3837.7 3884.4 5571.2 5594.0 5600.3 5634.0 5649.3 3900.6 3911.6 3918.5 3919.4 3940.0 3840.7 3977.7 3995.0 3998.5 3999.0 4491.6 4492.9 4495.9 4545.9 4547.7 5330.3 5349.0 5356.6 5365.3 5389.7 1276.9 1356.6 1379.0 1381.2 1390.9 932.6 941.4 963.3 964.2 967.5 4636.3 4642.3 4656.5 4670.1 4691.6 5389.7 5422.0 5450.2 5459.2 5468.4 4526.3 4669.9 4673.7 4686.9 4709.3 2942.7 2945.4 2945.9 2958.0 2963.1 5198.6 5211.6 5261.7 5298.3 5308.3 5398.7 5610.2 5661.2 5704.5 5705.7 5209.9 5249.8 5280.5 5290.8 5297.7 5576.9 5585.7 5588.2 5616.8 5619.8 5188.3 5445.4 5454.9 5474.3 5498.8 5215.8 5223.7 5230.1 5232.6 5245.8 3832.6 3866.0 3867.6 3873.4 3888.6 5217.2 5240.9 5410.8 5555.7 5556.7 5353.6 5360.7 5375.8 5387.7 5428.7 5335.8 5342.9 5354.1 5369.7 5380.8 5157.9 5282.4 5298.4 5299.4 5322.9 5393.3 5452.2 5460.6 5467.3 5483.9 5238.7 5250.2 5267.0 5273.6 5328.4 23:55:27 INFO - PROCESS | 3758 | 23:55:27 INFO - PROCESS | 3758 | [#5] yui.html Cycles:180 Average:18383.50 Median:23077.67 stddev:26123.45 (113.2%) stddev-sans-first:26162.85 23:55:27 INFO - PROCESS | 3758 | Values: 664.2 729.5 730.9 742.4 748.9 11661.8 13197.3 13980.1 14276.0 14296.9 14007.4 14616.5 14618.6 14652.6 14743.3 745.6 766.7 767.2 770.2 771.6 776.8 777.6 782.4 782.9 783.6 827.6 827.8 829.2 830.3 831.5 759.9 823.0 824.5 825.8 829.4 592.1 596.5 596.7 598.2 599.8 14940.6 15028.7 15045.1 15048.3 15078.2 13494.7 13987.9 13994.9 14040.9 14064.9 11138.2 11140.7 11147.3 11189.2 11272.7 3376.2 3414.7 3442.8 3465.2 3554.4 73310.3 73679.0 74275.0 75813.0 76293.6 10517.9 10570.2 10660.6 10688.3 10872.9 19198.9 19265.5 19353.0 19914.8 19976.7 6691.5 6881.1 6965.7 6967.2 7078.9 4005.7 4109.9 4130.0 4157.2 4158.5 3054.6 3133.4 3159.7 3165.5 3171.0 513.1 538.8 542.8 555.4 588.8 489.5 530.3 545.2 584.1 619.3 8194.1 8240.9 8425.3 8485.7 8761.8 484.8 523.4 560.4 600.9 607.5 3962.6 4010.5 4084.1 4135.9 4282.3 98437.5 99136.0 99866.5 100022.0 101935.5 84496.2 84621.6 84730.6 85276.6 85279.6 72834.6 75219.6 75738.0 76107.6 76299.0 7968.3 8107.8 8231.0 8287.5 8391.0 31231.8 39315.2 40193.2 41873.0 43688.3 56756.1 61896.0 64399.7 65334.7 65885.0 11475.3 11566.7 11684.2 11814.0 11998.4 13170.1 13231.1 13339.9 13545.6 13574.0 11993.5 12027.2 12064.3 12205.4 12685.4 12062.7 12130.4 12207.2 12620.0 12928.2 11659.1 11823.8 12226.2 12363.3 12364.3 9946.8 10467.0 10627.5 10666.8 10757.5 9681.6 9802.8 9818.5 10174.0 10231.1 23:55:27 INFO - PROCESS | 3758 | -------- Summary: end -------- 23:55:27 INFO - PROCESS | 3758 | 23:55:28 INFO - TEST-INFO | 3758: exit 0 23:55:28 INFO - TEST-OK | dromaeo_css | took 1116086ms 23:55:28 INFO - TEST-START | kraken 23:55:28 INFO - operating with platform_type : linux_ 23:55:28 INFO - Initialising browser for kraken test... 23:55:28 INFO - TEST-INFO | started process 4008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW18K0N/profile http://localhost:37008/getInfo.html) 23:55:33 INFO - PROCESS | 4008 | __metrics Screen width/height:1600/1200 23:55:33 INFO - PROCESS | 4008 | colorDepth:24 23:55:33 INFO - PROCESS | 4008 | Browser inner width/height: 1024/697 23:55:33 INFO - PROCESS | 4008 | __metrics 23:55:33 ERROR - PROCESS | 4008 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 23:55:34 INFO - TEST-INFO | 4008: exit 0 23:55:34 INFO - Browser initialized. 23:55:34 INFO - Running cycle 1/1 for kraken test... 23:55:34 INFO - TEST-INFO | started process 4128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW18K0N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:55:46 INFO - PROCESS | 4128 | RSS: Main: 169508864 23:55:46 INFO - PROCESS | 4128 | 23:55:49 INFO - PROCESS | 4128 | Cycle 1(1): loaded http://localhost:37008/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37008/tests/kraken/driver.html?testName=audio-beat-detection) 23:55:50 INFO - PROCESS | 4128 | RSS: Main: 174637056 23:55:50 INFO - PROCESS | 4128 | 23:55:52 INFO - PROCESS | 4128 | Cycle 1(1): loaded http://localhost:37008/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37008/tests/kraken/driver.html?testName=audio-dft) 23:55:53 INFO - PROCESS | 4128 | RSS: Main: 174129152 23:55:53 INFO - PROCESS | 4128 | 23:55:56 INFO - PROCESS | 4128 | Cycle 1(1): loaded http://localhost:37008/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37008/tests/kraken/driver.html?testName=audio-fft) 23:55:56 INFO - PROCESS | 4128 | RSS: Main: 168615936 23:55:56 INFO - PROCESS | 4128 | 23:55:59 INFO - PROCESS | 4128 | Cycle 1(1): loaded http://localhost:37008/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37008/tests/kraken/driver.html?testName=audio-oscillator) 23:55:59 INFO - PROCESS | 4128 | RSS: Main: 169803776 23:55:59 INFO - PROCESS | 4128 | 23:56:02 INFO - PROCESS | 4128 | Cycle 1(1): loaded http://localhost:37008/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37008/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:56:02 INFO - PROCESS | 4128 | RSS: Main: 169570304 23:56:02 INFO - PROCESS | 4128 | 23:56:05 INFO - PROCESS | 4128 | Cycle 1(1): loaded http://localhost:37008/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37008/tests/kraken/driver.html?testName=imaging-darkroom) 23:56:06 INFO - PROCESS | 4128 | RSS: Main: 170373120 23:56:06 INFO - PROCESS | 4128 | 23:56:10 INFO - PROCESS | 4128 | Cycle 1(1): loaded http://localhost:37008/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37008/tests/kraken/driver.html?testName=imaging-desaturate) 23:56:10 INFO - PROCESS | 4128 | RSS: Main: 167600128 23:56:10 INFO - PROCESS | 4128 | 23:56:13 INFO - PROCESS | 4128 | Cycle 1(1): loaded http://localhost:37008/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37008/tests/kraken/driver.html?testName=json-parse-financial) 23:56:14 INFO - PROCESS | 4128 | RSS: Main: 169209856 23:56:14 INFO - PROCESS | 4128 | 23:56:15 INFO - PROCESS | 4128 | Cycle 1(1): loaded http://localhost:37008/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37008/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:56:16 INFO - PROCESS | 4128 | RSS: Main: 169533440 23:56:16 INFO - PROCESS | 4128 | 23:56:18 INFO - PROCESS | 4128 | Cycle 1(1): loaded http://localhost:37008/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37008/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:56:19 INFO - PROCESS | 4128 | RSS: Main: 169684992 23:56:19 INFO - PROCESS | 4128 | 23:56:21 INFO - PROCESS | 4128 | Cycle 1(1): loaded http://localhost:37008/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37008/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:56:22 INFO - PROCESS | 4128 | RSS: Main: 170147840 23:56:22 INFO - PROCESS | 4128 | 23:56:24 INFO - PROCESS | 4128 | Cycle 1(1): loaded http://localhost:37008/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:56:25 INFO - PROCESS | 4128 | RSS: Main: 170242048 23:56:25 INFO - PROCESS | 4128 | 23:56:28 INFO - PROCESS | 4128 | Cycle 1(1): loaded http://localhost:37008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:56:28 INFO - PROCESS | 4128 | RSS: Main: 170041344 23:56:28 INFO - PROCESS | 4128 | 23:56:30 INFO - PROCESS | 4128 | Cycle 1(1): loaded http://localhost:37008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37008/tests/kraken/driver.html?testName=ai-astar) 23:56:30 INFO - PROCESS | 4128 | RSS: Main: 171130880 23:56:30 INFO - PROCESS | 4128 | 23:56:30 INFO - PROCESS | 4128 | __start_tp_report 23:56:30 INFO - PROCESS | 4128 | _x_x_mozilla_page_load 23:56:30 INFO - PROCESS | 4128 | _x_x_mozilla_page_load_details 23:56:30 INFO - PROCESS | 4128 | |i|pagename|runs| 23:56:30 INFO - PROCESS | 4128 | |0;ai-astar;106;114;106;113;115;114;115;114;112;114 23:56:30 INFO - PROCESS | 4128 | |1;audio-beat-detection;154;121;149;172;124;160;154;123;191;125 23:56:30 INFO - PROCESS | 4128 | |2;audio-dft;162;163;162;164;180;165;163;161;162;161 23:56:30 INFO - PROCESS | 4128 | |3;audio-fft;74;76;77;153;78;77;78;75;175;77 23:56:30 INFO - PROCESS | 4128 | |4;audio-oscillator;86;87;138;88;85;85;133;85;86;145 23:56:30 INFO - PROCESS | 4128 | |5;imaging-gaussian-blur;118;118;118;119;118;119;120;122;118;118 23:56:30 INFO - PROCESS | 4128 | |6;imaging-darkroom;147;149;150;149;148;148;148;148;149;147 23:56:30 INFO - PROCESS | 4128 | |7;imaging-desaturate;95;95;95;96;95;96;95;96;95;96 23:56:30 INFO - PROCESS | 4128 | |8;json-parse-financial;64;65;69;65;65;65;65;66;64;65 23:56:30 INFO - PROCESS | 4128 | |9;json-stringify-tinderbox;64;65;64;65;66;65;64;69;66;64 23:56:30 INFO - PROCESS | 4128 | |10;stanford-crypto-aes;80;80;82;79;79;79;83;82;80;82 23:56:30 INFO - PROCESS | 4128 | |11;stanford-crypto-ccm;143;138;136;140;137;134;134;130;172;128 23:56:30 INFO - PROCESS | 4128 | |12;stanford-crypto-pbkdf2;166;169;167;173;169;168;169;170;174;167 23:56:30 INFO - PROCESS | 4128 | |13;stanford-crypto-sha256-iterative;67;67;68;65;67;69;68;70;66;66 23:56:30 INFO - PROCESS | 4128 | __end_tp_report 23:56:30 INFO - PROCESS | 4128 | __start_cc_report 23:56:30 INFO - PROCESS | 4128 | _x_x_mozilla_cycle_collect,1002 23:56:30 INFO - PROCESS | 4128 | __end_cc_report 23:56:30 INFO - PROCESS | 4128 | __startTimestamp1467528990979__endTimestamp 23:56:30 INFO - PROCESS | 4128 | 23:56:30 INFO - PROCESS | 4128 | ------- Summary: start ------- 23:56:30 INFO - PROCESS | 4128 | Number of tests: 14 23:56:30 INFO - PROCESS | 4128 | 23:56:30 INFO - PROCESS | 4128 | [#0] ai-astar Cycles:10 Average:112.30 Median:114.00 stddev:3.43 (3.0%) stddev-sans-first:2.78 23:56:30 INFO - PROCESS | 4128 | Values: 106.0 114.0 106.0 113.0 115.0 114.0 115.0 114.0 112.0 114.0 23:56:30 INFO - PROCESS | 4128 | 23:56:30 INFO - PROCESS | 4128 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:154.00 stddev:23.80 (15.5%) stddev-sans-first:25.12 23:56:30 INFO - PROCESS | 4128 | Values: 154.0 121.0 149.0 172.0 124.0 160.0 154.0 123.0 191.0 125.0 23:56:30 INFO - PROCESS | 4128 | 23:56:30 INFO - PROCESS | 4128 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.00 stddev:5.66 (3.5%) stddev-sans-first:5.94 23:56:30 INFO - PROCESS | 4128 | Values: 162.0 163.0 162.0 164.0 180.0 165.0 163.0 161.0 162.0 161.0 23:56:30 INFO - PROCESS | 4128 | 23:56:30 INFO - PROCESS | 4128 | [#3] audio-fft Cycles:10 Average:94.00 Median:77.00 stddev:37.28 (48.4%) stddev-sans-first:38.83 23:56:30 INFO - PROCESS | 4128 | Values: 74.0 76.0 77.0 153.0 78.0 77.0 78.0 75.0 175.0 77.0 23:56:30 INFO - PROCESS | 4128 | 23:56:30 INFO - PROCESS | 4128 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:85.50 stddev:25.62 (30.0%) stddev-sans-first:26.52 23:56:30 INFO - PROCESS | 4128 | Values: 86.0 87.0 138.0 88.0 85.0 85.0 133.0 85.0 86.0 145.0 23:56:30 INFO - PROCESS | 4128 | 23:56:30 INFO - PROCESS | 4128 | [#5] imaging-gaussian-blur Cycles:10 Average:118.80 Median:118.50 stddev:1.32 (1.1%) stddev-sans-first:1.36 23:56:30 INFO - PROCESS | 4128 | Values: 118.0 118.0 118.0 119.0 118.0 119.0 120.0 122.0 118.0 118.0 23:56:30 INFO - PROCESS | 4128 | 23:56:30 INFO - PROCESS | 4128 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 23:56:30 INFO - PROCESS | 4128 | Values: 147.0 149.0 150.0 149.0 148.0 148.0 148.0 148.0 149.0 147.0 23:56:30 INFO - PROCESS | 4128 | 23:56:30 INFO - PROCESS | 4128 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:56:30 INFO - PROCESS | 4128 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 23:56:30 INFO - PROCESS | 4128 | 23:56:30 INFO - PROCESS | 4128 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:1.42 (2.2%) stddev-sans-first:1.42 23:56:30 INFO - PROCESS | 4128 | Values: 64.0 65.0 69.0 65.0 65.0 65.0 65.0 66.0 64.0 65.0 23:56:30 INFO - PROCESS | 4128 | 23:56:30 INFO - PROCESS | 4128 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:1.55 (2.4%) stddev-sans-first:1.58 23:56:30 INFO - PROCESS | 4128 | Values: 64.0 65.0 64.0 65.0 66.0 65.0 64.0 69.0 66.0 64.0 23:56:30 INFO - PROCESS | 4128 | 23:56:30 INFO - PROCESS | 4128 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:81.00 stddev:1.51 (1.9%) stddev-sans-first:1.58 23:56:30 INFO - PROCESS | 4128 | Values: 80.0 80.0 82.0 79.0 79.0 79.0 83.0 82.0 80.0 82.0 23:56:30 INFO - PROCESS | 4128 | 23:56:30 INFO - PROCESS | 4128 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:137.50 stddev:12.35 (9.0%) stddev-sans-first:13.02 23:56:30 INFO - PROCESS | 4128 | Values: 143.0 138.0 136.0 140.0 137.0 134.0 134.0 130.0 172.0 128.0 23:56:30 INFO - PROCESS | 4128 | 23:56:30 INFO - PROCESS | 4128 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:169.00 stddev:2.57 (1.5%) stddev-sans-first:2.46 23:56:30 INFO - PROCESS | 4128 | Values: 166.0 169.0 167.0 173.0 169.0 168.0 169.0 170.0 174.0 167.0 23:56:30 INFO - PROCESS | 4128 | 23:56:30 INFO - PROCESS | 4128 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.49 (2.2%) stddev-sans-first:1.58 23:56:30 INFO - PROCESS | 4128 | Values: 67.0 67.0 68.0 65.0 67.0 69.0 68.0 70.0 66.0 66.0 23:56:30 INFO - PROCESS | 4128 | -------- Summary: end -------- 23:56:30 INFO - PROCESS | 4128 | 23:56:32 INFO - TEST-INFO | 4128: exit 0 23:56:32 INFO - TEST-OK | kraken | took 63697ms 23:56:32 INFO - SUITE-END | took 1179s 23:56:32 INFO - Completed test suite (00:19:39) 23:56:32 INFO - javascript benchmark 23:56:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6556.171398518269, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2658.9601155982664, 2692.0577797770775, 2703.9864800675996, 2732.6037724529942, 2735.521283775339, 4803.9519604803945, 4863.635227357949, 4929.753512324383, 4944.2089265717495, 4965.28003439501, 4754.191787396142, 4776.617870570355, 4793.089313030522, 4810.39870016248, 4845.127876982142, 4378.430803995476, 4457.777111144446, 4497.550244975492, 4516.18708632446, 4569.040501494674, 563.9193634663624, 4380.299152135659, 4500.774961251941, 4525.773711314438, 4536.34223037661, 4401.9119617607785, 4407.294832826765, 4409.206342858284, 4424.093060922503, 4468.620167285784, 4430.11397720454, 4439.445069366329, 4439.511653718088, 4449.087936972913, 4492.550744925514, 4450.10997800438, 4491.92193873468, 4499.1901457737595, 4547.499775024745, 4559.74921379324, 4903.166461701519, 4915.311856340115, 4931.260310953386, 4946.72792996385, 4960.479149689303, 5018.7992480300745, 5112.667676601009, 5146.922796158061, 5159.432462429129, 5296.894062118736, 5279.076161671692, 5289.259503669489, 5299.6025298102795, 5300.151975683911, 5337.092694241988, 4878.536539028786, 4885.340479035356, 4897.730624815598, 4898.24077268024, 4938.728369939616, 5186.429492755794, 5359.5712343012465, 5381.461853814587, 5397.568194544427, 5436.592255580768, 5184.222366644958, 5202.76587553561, 5206.271122042841, 5214.270002199695, 5217.191335343028, 5288.206768984683, 5294.364676238876, 5301.787928482818, 5304.92042619361, 5337.172738225581, 5123.692578445305, 5139.743012849342, 5186.792528298901, 5199.246109314128, 5204.531592156724, 5061.190209566452, 5121.4622464641425, 5151.407588127413, 5162.096633089194, 5234.42421333653, 4378.343248512749, 4394.846180383671, 4395.1868904252815, 4396.076823867023, 4428.734275943454, 3794.8102594870147, 3824.0, 3856.7107466940092, 3873.24471728016, 3881.9611803882162, 4600.7929643166135, 4608.631309495299, 4617.238155704338, 4628.5371462853445, 4629.375034370317, 5099.0, 5269.762860671279, 5315.4950279724135, 5316.840494785162, 5342.305500284938, 4542.909141817145, 4589.449266088091, 4597.287420449836, 4612.538746125428, 4622.098690755338, 4723.858284251478, 4734.668573199843, 4745.9050818984115, 4751.667383283137, 4771.5228477152, 4705.12955103307, 4845.079434907357, 5001.399832020181, 5006.07387633289, 5027.4721154279005, 5180.430152683277, 5211.791528338976, 5234.319538459976, 5238.580913526833, 5297.5232229099565, 4895.8041678332465, 4914.5822605078965, 4919.680220785781, 4931.0630980113665, 4971.279164521196, 5085.160948443466, 5125.333706618116, 5126.6923984561045, 5135.922961155511, 5175.482451754794, 5252.5535329497425, 5254.13306804373, 5257.0, 5257.973710131425, 5263.131583288715, 5124.846254612367, 5125.718085505333, 5126.487351264993, 5128.1794912813775, 5165.018646457161, 4888.902221955612, 5091.363579552556, 5113.565346945551, 5144.485551444825, 5155.510226528624, 4914.287428322802, 4948.752562371939, 4966.900661986668, 4987.625928055338, 5051.090803655377, 5129.179331306973, 5151.922721159111, 5155.639105262596, 5157.406898206755, 5158.329417175743, 4925.0396172747405, 5016.046951079284, 5057.873553161053, 5058.291839142449, 5088.745562721923], "value": 4772.310691580264, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.141906957409, 579.2325169150876, 587.2688502813998, 602.3765402808092, 622.7789134857128, 35824.64175358249, 40561.79719101404, 40729.7963510182, 40795.79602101993, 40901.795491022574, 40198.59801401985, 40618.0, 40724.18551628965, 40742.0, 41009.17981640365, 7857.174996625344, 7986.800329991738, 8008.319292860114, 8014.67941282348, 8022.799430014238, 7862.449628526006, 7903.604819759018, 7929.762107136795, 7955.840883182333, 7960.880586791202, 7906.960465197666, 7960.840783184332, 7977.760667179965, 8011.399145064114, 8016.959915200416, 7937.087234967966, 7972.202779722011, 7981.640826162837, 7982.24168703978, 7988.680452781882, 7910.050793904711, 7969.681212751483, 7969.920300796975, 7971.242731940514, 7974.840503189962, 39013.60986390128, 39135.41296880549, 39374.40938385927, 39668.20663586741, 39772.403413948814, 3171.6035495563056, 3283.3761585298716, 3295.670432956709, 3296.175956010997, 3310.7682462227654, 29823.552646710315, 30296.394072118434, 30297.242568935733, 30543.541846872315, 31130.37739245225, 3353.252824696841, 3359.445691460906, 3377.3245350929665, 3398.847051882671, 3453.2920751245933, 253507.0, 253757.0, 255072.0, 255159.0, 255408.0, 32611.18472038218, 54757.72621136869, 55184.44815551873, 55326.44673553293, 55375.72312138414, 32314.0, 34543.4818477723, 34546.82726586401, 34785.0, 34795.13012174665, 13477.258750768802, 13656.65858353549, 13673.521426750016, 13710.588682339545, 13710.588682339545, 11010.339379637247, 11114.11087113029, 11174.776504469864, 11205.551777928791, 11215.383153926612, 8121.512709237465, 8136.0643525995265, 8173.754787356389, 8191.631376588068, 8232.300254478436, 3172.159377764894, 3182.2839861031084, 3217.3565286942703, 3240.3357311751033, 3257.039173443792, 893.2898345815092, 993.1657407777501, 995.4525011243787, 1002.869626948492, 1034.963776267827, 28435.28911777181, 28866.567001494994, 28906.0, 29028.12915612535, 29278.707212928024, 1001.6544292219173, 1005.1154983614373, 1030.4796077980723, 1033.1992705653179, 1039.9428031458192, 15203.391864325304, 15389.307481163374, 15568.844311556966, 15580.0, 15874.365025398854, 401878.0, 403924.0, 404473.0, 405779.0, 406254.0, 32765.50851737226, 33792.83103584466, 33846.49230261548, 33860.49209261863, 33920.66079339224, 1176.923499972516, 1202.9338386388833, 1205.2949024820578, 1214.872438393956, 1216.0514798457218, 27315.180544582898, 27679.308017298925, 28502.57246141351, 28699.28251793722, 28699.856500717364, 44512.777436112614, 44711.329330060726, 44926.0, 44999.550004499535, 45089.323660144466, 320462.0, 324631.0, 328289.0, 329136.0, 329345.0, 25478.617820733074, 25832.0, 25897.0, 26014.739852601233, 26020.479590408464, 42808.14383712246, 44131.57276349831, 47187.528124718316, 47745.28382074202, 48391.51608484011, 37136.25727485381, 38000.429993549566, 38428.615713843625, 38522.422163667004, 38536.229275413774, 37932.62067379291, 38121.0, 38376.80811595924, 38409.615903840604, 39350.40974385444, 36297.27405451823, 37229.6277037237, 37583.81208093942, 37700.43449348207, 37707.81146094252, 31165.53251701181, 33874.83062584671, 34368.82815585906, 34691.826540867136, 34843.0, 26427.207183783747, 26500.0, 26595.0, 26780.732192678603, 26831.463370732865], "value": 16793.281334821637, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.8359312919492, 363.26076434455877, 363.3006462559573, 364.10611947668446, 379.5824592947758, 16878.32486700532, 17264.82735172648, 17877.463676089705, 17930.641387172247, 17958.742887997847, 15946.601334966632, 16060.518184454486, 16609.252583633734, 16648.75026874595, 16677.24952377146, 5203.19350500672, 5263.973525162595, 5367.409584945673, 5371.623986320959, 5383.43473935237, 5260.894782104356, 5273.419923808378, 5284.313039304885, 5342.465753424665, 5369.919451208235, 5152.510511501401, 5226.895462090756, 5228.398734145565, 5247.2653828464045, 5263.526282634562, 5155.097857874857, 5214.009338225725, 5226.895462090756, 5245.344331958505, 5264.42091369949, 4581.63346932248, 4671.34601155835, 4699.976500117477, 4703.858884233478, 4710.152172608929, 20333.694994575093, 20607.0, 20900.0, 21205.575888482144, 21207.363779086652, 1912.7513423255027, 2107.9473013174793, 2111.862728922615, 2264.1735766445295, 2319.2810228829117, 13453.192808431526, 13557.59327220185, 13661.112027718265, 13715.0, 13861.09902856311, 1538.7230298546258, 1739.2347367158536, 1766.0198589782665, 1770.7963584187855, 1774.5829730013436, 71907.28092719059, 73846.0, 74861.62569187119, 75327.24672753258, 76057.61971190109, 9786.706398808046, 9872.851907221397, 9889.901100989042, 9935.80128397428, 10046.095851373411, 13022.674433139058, 13217.73564528704, 13226.404811783494, 13611.659708507366, 13628.795568066487, 7425.368843648243, 7465.29079737424, 7493.463839912804, 7565.43259255558, 7565.470417070862, 7267.563946163247, 7302.0, 7323.340899319087, 7448.217937116633, 7464.70141194357, 4093.9590604094174, 4165.229432554987, 4191.077962848169, 4325.740455572675, 4558.5897269245925, 1765.4615342320458, 1812.1030090105482, 1823.881447705895, 1836.2104295152944, 1865.5709186887093, 873.733511279066, 891.233539156325, 913.1827014821697, 949.4303417949175, 950.1163917556601, 16992.915035424743, 17235.91382043082, 17328.220230089675, 17352.132393380532, 17365.82634173642, 862.4652715316544, 884.8186121845006, 885.5350940756155, 920.2867777472512, 921.5438358012826, 9320.347575669774, 9552.856707149398, 9807.313488055768, 9831.803363932824, 10007.799844003079, 432229.0, 434397.0, 435042.0, 443497.0, 445985.0, 69306.30693692999, 78594.21405785983, 79070.0, 81515.5924220387, 84340.0, 888.9866652000354, 900.6352427266968, 901.6168128545341, 930.1907340613709, 930.3534043839467, 15638.45265415705, 15735.68528629444, 15783.842161578697, 15896.364145434052, 16386.918065409598, 35763.0, 36612.0, 37849.4322585156, 39928.0, 41139.177216456104, 54218.728906355216, 56480.717596411756, 57267.42732572788, 57396.71301643465, 57528.71235643795, 7443.18125006238, 7531.510451820614, 7605.23947605235, 7696.961515192388, 7713.730019449293, 12238.44926978306, 12306.569270075504, 12342.13605047638, 12599.370031498573, 12726.554570589984, 10759.731006724582, 10787.244892857425, 10828.837567436653, 11016.559337626406, 11118.944405277922, 10738.463076846283, 10761.569537218424, 10775.94612026935, 10871.075958543295, 11077.390743509184, 10109.545070471993, 11025.283356581796, 11143.777124457303, 11180.608678696206, 11381.089512839118, 7842.0, 8035.758927232192, 8040.557769322743, 8086.231807978233, 8170.182981701782, 11003.504842282277, 11055.613053543088, 11080.113590912546, 11225.270357426742, 11356.0915126788], "value": 8487.47810846071, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.185536822538, 1392.9135274485902, 1440.841507434182, 1676.1786724504996, 1707.2061491406494, 7124.145102587684, 7654.578998155106, 7759.844803103934, 8169.877451838227, 8176.427650064498, 7925.564093974829, 8063.677452901891, 8175.5503447310375, 8192.467489613171, 8224.465409748376, 2174.20641465865, 2210.5136869888597, 2214.070090561968, 2215.5679642469727, 2218.8779617121054, 2244.5735310290993, 2273.193016479151, 2281.931542053741, 2284.7829456201634, 2287.977120228793, 2257.604919139152, 2265.7734226577295, 2274.7611500792345, 2279.1225378229337, 2279.1225378229337, 2108.0513768803944, 2123.331150687536, 2132.0, 2142.5929073476145, 2146.7638559758416, 2187.628103222456, 2191.430228140695, 2201.0975500045065, 2207.293666026872, 2207.404000919759, 8158.510489370657, 8211.05572859123, 8219.794505137419, 8253.546054966975, 8304.584770761438, 4720.645951553647, 4842.854714358575, 4868.634852386085, 4873.829415970424, 4880.072786170616, 2854.785891058158, 3042.8326442045677, 3061.7091376319436, 3061.755059595227, 3099.6900309969046, 991.8859331176935, 1020.8417695257247, 1042.4370839746528, 1048.486241741541, 1049.9265051446403, 11185.944070279678, 11204.0, 11205.047570956478, 11234.943825280821, 11247.60633377836, 4242.215190189825, 4271.145770845843, 4406.25093734066, 4482.731036137842, 4526.23054080807, 9530.475823829756, 9540.85688714656, 9544.809103817885, 9547.188488978514, 9554.570044347882, 4780.306855505932, 4789.161896668069, 4791.856244312677, 4795.0, 4799.496052914464, 3806.1245913440066, 4221.387898754663, 4376.606105450524, 4390.3414487827085, 4391.714538554984, 3792.1467669774634, 3840.8271627776817, 3896.922061558753, 3925.725199236083, 3974.006498375406, 1148.9200151857228, 1234.8394708687993, 1244.4773195258012, 1252.0546987024738, 1255.5480027190204, 835.853725598018, 837.6105111123356, 841.0916210492653, 861.1560670542777, 870.991290087091, 5372.274742909735, 5387.542058924957, 5441.428649991773, 5501.092319767274, 5529.170624406372, 418.13654802832053, 419.96640268778424, 422.44870444070784, 898.5507246376811, 938.3009657804979, 3540.3627347077772, 3616.81915904209, 3689.7786132832116, 3697.4638677391627, 3701.5188025557045, 9733.17268032211, 10031.347962382422, 10044.497775111215, 10121.0, 10122.898771012344, 9841.753956151011, 9958.950205249072, 10017.248706347053, 10026.097651211427, 10059.094681478702, 7408.62956852166, 7471.813204669927, 7570.16728159902, 7577.446623442292, 7584.089909210819, 5202.505761952609, 5230.110881150137, 5240.240165175952, 5285.867853303698, 5345.412004679404, 9137.680181193626, 9311.255099591881, 9416.95291523538, 9497.572609232462, 9502.66740664101, 9398.718038458857, 9509.904900950902, 9517.952410237904, 9698.515074246401, 9699.17557007634, 5791.0734282514595, 6450.258220304725, 6694.799156025327, 6715.395614394728, 6863.519553631198, 7853.057633084067, 7907.406944479072, 7917.722879699183, 7933.8413231736195, 8003.6798528058225, 6840.760573379908, 7105.18290396611, 7121.893171602326, 7203.747868824776, 7250.41996640257, 6912.412444942035, 6993.2657071006815, 7138.072050633385, 7158.2841715828, 7228.457865660202, 6615.4376877965915, 6718.421171024707, 6726.630035348103, 6730.932690673227, 6742.056112144206, 4662.603678687349, 4680.297955306732, 4756.881077973078, 4811.374521312207, 4824.614030877591, 4817.156997525349, 4841.75791210431, 4881.8535443936735, 4903.656744027884, 4923.483034281349], "value": 4253.070657486042, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.94209629122304, 306.1611185352135, 312.6373406848055, 317.0599173450718, 319.2736524406974, 4966.428860681022, 4978.55193032627, 5125.487451254878, 5144.742762861861, 5165.845024649262, 5062.215356619729, 5064.924026139602, 5069.569086627641, 5104.642675012741, 5122.207227470383, 3964.7422917510344, 3992.3412636914873, 4008.0781420273356, 4018.5378681451716, 4038.0, 3917.1969746202103, 3999.4200840878057, 4023.8792836214816, 4029.435878976946, 4044.5955404459614, 3956.863293821333, 3962.445257663929, 3962.7027972902006, 3984.462097616828, 3996.7601943883315, 3983.780892050936, 3993.5223967132347, 4002.3596224604216, 4004.299247631667, 4014.8193331300163, 3516.2791627716256, 3532.0, 3533.646635336446, 3537.726418489342, 3546.8758593449106, 4837.564619184255, 4937.21004639256, 4991.975040124777, 4998.9500104999215, 5019.4227663818765, 4530.728156310599, 4546.431266334511, 4547.909041819145, 4553.0, 4575.9771201143785, 5320.14877619579, 5328.254044433782, 5378.973105134489, 5382.381026182, 5383.784648614051, 3777.6033516480647, 3799.25914446683, 3810.066533699234, 3837.7313588048846, 3884.4367566702954, 5571.192177134293, 5594.042085270164, 5600.299962504687, 5634.0, 5649.265595472562, 3900.6099390060767, 3911.6088391160656, 3918.45141680165, 3919.412088186795, 3940.0, 3840.731148819556, 3977.661898738582, 3994.981279773639, 3998.520177578709, 3998.960010399917, 4491.550844915548, 4492.887677808016, 4495.88760280989, 4545.931811022837, 4547.658925580595, 5330.280412144389, 5348.973255133699, 5356.625036247426, 5365.275687782099, 5389.676619402849, 1276.8914642255513, 1356.5862411964445, 1378.9931050344685, 1381.2196109198271, 1390.867867552581, 932.5570354081757, 941.4445477168504, 963.2679163835536, 964.1515466389533, 967.4533888353058, 4636.304554316879, 4642.280446530793, 4656.486641841415, 4670.089332580183, 4691.62467002639, 5389.67661940277, 5422.024035673538, 5450.155225939986, 5459.235707000944, 5468.398476167618, 4526.253168227206, 4669.906601867943, 4673.7429441381055, 4686.906261874743, 4709.317149013374, 2942.735153836165, 2945.4403663303906, 2945.867435965387, 2958.0, 2963.125877866035, 5198.610104242197, 5211.628708937425, 5261.710605916634, 5298.311219541512, 5308.256844041837, 5398.703071331114, 5610.186522954149, 5661.235733176051, 5704.543636509069, 5705.7147142643535, 5209.921851172236, 5249.763760630781, 5280.498352656491, 5290.788368465218, 5297.735113244245, 5576.860578485408, 5585.748641311232, 5588.2455868458865, 5616.775328986795, 5619.775208991595, 5188.325517682677, 5445.40100588927, 5454.890902182014, 5474.288342515448, 5498.752556135064, 5215.791368345223, 5223.660462069954, 5230.084735171406, 5232.633715640021, 5245.790168393221, 3832.6358995895343, 3866.0, 3867.640739149173, 3873.35382462458, 3888.5528164261473, 5217.217417387422, 5240.947590524046, 5410.756515956713, 5555.694436806015, 5556.72216389187, 5353.625246232882, 5360.70516121617, 5375.81184658535, 5387.703676297841, 5428.697112693004, 5335.786568537215, 5342.866428339323, 5354.143337066051, 5369.6509726867625, 5380.811671591476, 5157.859488312309, 5282.366116066097, 5298.44366341544, 5299.39057008449, 5322.935412917354, 5393.303348325837, 5452.2094296327605, 5460.563154947674, 5467.343918729778, 5483.890322193454, 5238.71651445383, 5250.18622113573, 5266.97366513165, 5273.551748101454, 5328.3605967284175], "value": 4045.74906258265, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.1565212180531, 729.4784229276066, 730.9451791115664, 742.4431676242818, 748.913874904386, 11661.825072623897, 13197.340132993348, 13980.091294065878, 14276.0, 14296.928515357422, 14007.439702411892, 14616.4884229052, 14618.561443156696, 14652.560423187322, 14743.26283685814, 745.5675708089309, 766.6741634805213, 767.1752865669428, 770.2297702297702, 771.6103367799253, 776.770852598482, 777.6422845491081, 782.4014628808937, 782.86299897518, 783.5651213576463, 827.6317038917684, 827.755812035451, 829.2122483640535, 830.3108420011376, 831.476170012894, 759.9012128423325, 823.0247157118833, 824.517657170553, 825.8100636853527, 829.3613917283718, 592.0734051209843, 596.4959609130278, 596.6897213449025, 598.2252982387819, 599.7810799058356, 14940.62648433787, 15028.699426011419, 15045.097294162275, 15048.322825472771, 15078.170700611461, 13494.730105397935, 13987.860121398757, 13994.930025349808, 14040.929795350958, 14064.929675351661, 11138.164637652128, 11140.665780026531, 11147.275427097213, 11189.160812939062, 11272.718182045432, 3376.2403459221478, 3414.6585341465902, 3442.845071971767, 3465.151037995682, 3554.377983852841, 73310.26689733088, 73679.0, 74275.0, 75813.0, 76293.61853190699, 10517.9474102629, 10570.207234457446, 10660.626878059385, 10688.251822372515, 10872.891271087346, 19198.904005479882, 19265.51836204106, 19353.0, 19914.800851991586, 19976.700349494768, 6691.531592788556, 6881.10545629075, 6965.686544105527, 6967.198772141167, 7078.858422831515, 4005.6995725320135, 4109.91780164395, 4129.958700413017, 4157.168566286755, 4158.542560318362, 3054.648715397713, 3133.4046531159006, 3159.684031596822, 3165.525171224289, 3170.9841450792596, 513.0841448015275, 538.785039735402, 542.8208691131917, 555.3585608622049, 588.7821506042792, 489.48114998101414, 530.3291336459382, 545.1985581195636, 584.0538327908815, 619.3342157181048, 8194.139615340422, 8240.917590824134, 8425.325973922194, 8485.703000394957, 8761.780955476164, 484.849696594057, 523.4425337016065, 560.4087687489738, 600.942910423509, 607.4988134788729, 3962.623550762673, 4010.5387880393546, 4084.1219137885496, 4135.875923722293, 4282.332900874509, 98437.50781246192, 99136.0, 99866.50066749619, 100022.0, 101935.4903225479, 84496.15503845006, 84621.57689211515, 84730.57634711787, 85276.57361713276, 85279.5736021316, 72834.63582682052, 75219.62390188123, 75738.0, 76107.61946190345, 76299.0, 7968.322692571196, 8107.756767296991, 8231.0, 8287.461315014505, 8390.993080830096, 31231.84384078065, 39315.213695726496, 40193.1961360777, 41873.0, 43688.34467482927, 56756.14865776934, 61896.0, 64399.67800160969, 65334.67332663306, 65885.0, 11475.254108483256, 11566.65300041, 11684.18210725241, 11813.966502778194, 11998.40007999579, 13170.143940643828, 13231.139975901535, 13339.866601333862, 13545.645435456376, 13574.04981651275, 11993.520259189883, 12027.15809893299, 12064.276143431422, 12205.389730513261, 12685.4291556882, 12062.698432539257, 12130.393480325773, 12207.206531575419, 12619.9904007681, 12928.224306541637, 11659.125565582446, 11823.76352472963, 12226.20529665569, 12363.32001739913, 12364.319962402154, 9946.801063978824, 10467.005634464713, 10627.521761520904, 10666.8399974002, 10757.46212689378, 9681.612735490502, 9802.803943921224, 9818.45998470091, 10174.041474562426, 10231.079202871777], "value": 6784.428540814981, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 106.0, 113.0, 115.0, 114.0, 115.0, 114.0, 112.0, 114.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 149.0, 172.0, 124.0, 160.0, 154.0, 123.0, 191.0, 125.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 164.0, 180.0, 165.0, 163.0, 161.0, 162.0, 161.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 77.0, 153.0, 78.0, 77.0, 78.0, 75.0, 175.0, 77.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 138.0, 88.0, 85.0, 85.0, 133.0, 85.0, 86.0, 145.0], "value": 101.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 119.0, 118.0, 119.0, 120.0, 122.0, 118.0, 118.0], "value": 118.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 150.0, 149.0, 148.0, 148.0, 148.0, 148.0, 149.0, 147.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 69.0, 65.0, 65.0, 65.0, 65.0, 66.0, 64.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 66.0, 65.0, 64.0, 69.0, 66.0, 64.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 82.0, 79.0, 79.0, 79.0, 83.0, 82.0, 80.0, 82.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 138.0, 136.0, 140.0, 137.0, 134.0, 134.0, 130.0, 172.0, 128.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 169.0, 167.0, 173.0, 169.0, 168.0, 169.0, 170.0, 174.0, 167.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 65.0, 67.0, 69.0, 68.0, 70.0, 66.0, 66.0], "value": 67.3, "unit": "score"}]}]} 23:56:32 INFO - Return code: 0 23:56:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:56:32 ERROR - # TBPL SUCCESS # 23:56:32 INFO - Running post-action listener: _resource_record_post_action 23:56:32 INFO - ##### 23:56:32 INFO - ##### Finished run-tests step (success) 23:56:32 INFO - ##### 23:56:32 INFO - Running post-run listener: _resource_record_post_run 23:56:32 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 542490624; Read time: 20; Write time: 481816 23:56:32 INFO - TinderboxPrint: CPU usage
13.3% 23:56:32 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 23:56:32 INFO - TinderboxPrint: I/O write bytes / time
542,490,624 / 481,816 23:56:32 INFO - TinderboxPrint: CPU idle
8,276.2 (86.7%) 23:56:32 INFO - TinderboxPrint: CPU user
1,216.9 (12.7%) 23:56:32 INFO - TinderboxPrint: Swap in / out
0 / 0 23:56:32 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 259137536; Read time: 0; Write time: 270016 23:56:32 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283353088; Read time: 12; Write time: 211800 23:56:32 INFO - Running post-run listener: _upload_blobber_files 23:56:32 INFO - Blob upload gear active. 23:56:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:56:32 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 23:56:32 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:56:32 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:56:33 INFO - (blobuploader) - INFO - Open directory for files ... 23:56:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:56:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:56:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:56:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:56:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:56:34 INFO - (blobuploader) - INFO - Done attempting. 23:56:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:56:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:56:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:56:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:56:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:56:37 INFO - (blobuploader) - INFO - Done attempting. 23:56:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:56:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:56:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:56:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:56:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:56:39 INFO - (blobuploader) - INFO - Done attempting. 23:56:39 INFO - (blobuploader) - INFO - Iteration through files over. 23:56:39 INFO - Return code: 0 23:56:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:56:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:56:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d8b6e371570e88fbedc4addc820d62e25d3576a1c3a62e65e4d59cf554eef8a2f340f81a7169b95c9d0bb60438d99f1accad2e1e20111202b22eac89980a7fb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0d0c1dfd7078ad677b26b883662747d5259873593cf681e6ca336e1f3351a8a685b9c6814f6deb6e8c3c2ce00094b777de9c5200210ed782ac2a61a6c86d6624", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/987d81301372c42bf335b1e00dd45a79d7aa80e3e624d5765edc6ff198871089ba3b65677cf3d67b0b1486dbcd52daa50a6b967a852b405dad1f0d06935a2955"} 23:56:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:56:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:56:39 INFO - Contents: 23:56:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d8b6e371570e88fbedc4addc820d62e25d3576a1c3a62e65e4d59cf554eef8a2f340f81a7169b95c9d0bb60438d99f1accad2e1e20111202b22eac89980a7fb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0d0c1dfd7078ad677b26b883662747d5259873593cf681e6ca336e1f3351a8a685b9c6814f6deb6e8c3c2ce00094b777de9c5200210ed782ac2a61a6c86d6624", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/987d81301372c42bf335b1e00dd45a79d7aa80e3e624d5765edc6ff198871089ba3b65677cf3d67b0b1486dbcd52daa50a6b967a852b405dad1f0d06935a2955"} 23:56:39 INFO - Running post-run listener: copy_logs_to_upload_dir 23:56:39 INFO - Copying logs to upload dir... 23:56:39 INFO - mkdir: /builds/slave/test/build/upload/logs 23:56:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.191700 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-02 23:56:38.663487) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:56:38.670976) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415 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/Autoland-Non-PGO/sha512/d8b6e371570e88fbedc4addc820d62e25d3576a1c3a62e65e4d59cf554eef8a2f340f81a7169b95c9d0bb60438d99f1accad2e1e20111202b22eac89980a7fb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0d0c1dfd7078ad677b26b883662747d5259873593cf681e6ca336e1f3351a8a685b9c6814f6deb6e8c3c2ce00094b777de9c5200210ed782ac2a61a6c86d6624", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/987d81301372c42bf335b1e00dd45a79d7aa80e3e624d5765edc6ff198871089ba3b65677cf3d67b0b1486dbcd52daa50a6b967a852b405dad1f0d06935a2955"} build_url:https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011614 build_url: 'https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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/Autoland-Non-PGO/sha512/d8b6e371570e88fbedc4addc820d62e25d3576a1c3a62e65e4d59cf554eef8a2f340f81a7169b95c9d0bb60438d99f1accad2e1e20111202b22eac89980a7fb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0d0c1dfd7078ad677b26b883662747d5259873593cf681e6ca336e1f3351a8a685b9c6814f6deb6e8c3c2ce00094b777de9c5200210ed782ac2a61a6c86d6624", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/987d81301372c42bf335b1e00dd45a79d7aa80e3e624d5765edc6ff198871089ba3b65677cf3d67b0b1486dbcd52daa50a6b967a852b405dad1f0d06935a2955"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:56:38.702223) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:56:38.702565) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467527760.572845-1540915415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:56:38.785776) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:56:38.786107) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:56:38.786392) ========= ========= Total master_lag: 0.19 =========