builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1461034964.58 results: success (0) buildid: 20160418173022 builduid: 142b371ba97349e398251785efadfd86 revision: 05a9daa3368cb8e32c7393fcb5ff7179023c6c50 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 20:02:44.577637) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 20:02:44.578050) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 20:02:44.578336) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 20:02:44.595249) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 20:02:44.595564) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 20:02:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-04-18 20:02:45 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085716 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 20:02:44.694491) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 20:02:44.694803) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018059 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 20:02:44.744629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 20:02:44.745043) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 05a9daa3368cb8e32c7393fcb5ff7179023c6c50 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 05a9daa3368cb8e32c7393fcb5ff7179023c6c50 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 20:02:45,824 truncating revision to first 12 chars 2016-04-18 20:02:45,824 Setting DEBUG logging. 2016-04-18 20:02:45,824 attempt 1/10 2016-04-18 20:02:45,824 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/05a9daa3368c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 20:02:46,768 unpacking tar archive at: fx-team-05a9daa3368c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.205437 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 20:02:45.963980) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 20:02:45.964308) ========= script_repo_revision: 05a9daa3368cb8e32c7393fcb5ff7179023c6c50 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 20:02:45.964718) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 20:02:45.964999) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 20:02:45.973562) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-18 20:02:45.973845) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:02:47 INFO - MultiFileLogger online at 20160418 20:02:47 in /builds/slave/test 20:02:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:02:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:02:47 INFO - {'append_to_log': False, 20:02:47 INFO - 'base_work_dir': '/builds/slave/test', 20:02:47 INFO - 'blob_upload_branch': 'Fx-Team', 20:02:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:02:47 INFO - 'branch': 'Fx-Team', 20:02:47 INFO - 'buildbot_json_path': 'buildprops.json', 20:02:47 INFO - 'config_files': ('talos/linux_config.py',), 20:02:47 INFO - 'default_actions': ('clobber', 20:02:47 INFO - 'read-buildbot-config', 20:02:47 INFO - 'download-and-extract', 20:02:47 INFO - 'populate-webroot', 20:02:47 INFO - 'create-virtualenv', 20:02:47 INFO - 'install', 20:02:47 INFO - 'run-tests'), 20:02:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:02:47 INFO - 'download_minidump_stackwalk': True, 20:02:47 INFO - 'download_symbols': 'ondemand', 20:02:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:02:47 INFO - 'tooltool.py': '/tools/tooltool.py', 20:02:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:02:47 INFO - '/tools/misc-python/virtualenv.py')}, 20:02:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:02:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:02:47 INFO - 'installer_path': 'installer.exe', 20:02:47 INFO - 'log_level': 'info', 20:02:47 INFO - 'log_name': 'talos', 20:02:47 INFO - 'log_to_console': True, 20:02:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:02:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:02:47 INFO - 'opt_config_files': (), 20:02:47 INFO - 'pip_index': False, 20:02:47 INFO - 'sps_profile': False, 20:02:47 INFO - 'sps_profile_interval': 0, 20:02:47 INFO - 'suite': 'dromaeojs', 20:02:47 INFO - 'system_bits': '32', 20:02:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:02:47 INFO - 'title': 'talos-linux64-ix-057', 20:02:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:02:47 INFO - 'use_talos_json': True, 20:02:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:02:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:02:47 INFO - 'work_dir': 'build'} 20:02:47 INFO - ##### 20:02:47 INFO - ##### Running clobber step. 20:02:47 INFO - ##### 20:02:47 INFO - Running pre-action listener: _resource_record_pre_action 20:02:47 INFO - Running main action method: clobber 20:02:47 INFO - rmtree: /builds/slave/test/build 20:02:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:02:48 INFO - Running post-action listener: _resource_record_post_action 20:02:48 INFO - ##### 20:02:48 INFO - ##### Running read-buildbot-config step. 20:02:48 INFO - ##### 20:02:48 INFO - Running pre-action listener: _resource_record_pre_action 20:02:48 INFO - Running main action method: read_buildbot_config 20:02:48 INFO - Using buildbot properties: 20:02:48 INFO - { 20:02:48 INFO - "project": "", 20:02:48 INFO - "product": "firefox", 20:02:48 INFO - "script_repo_revision": "production", 20:02:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:02:48 INFO - "repository": "", 20:02:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:02:48 INFO - "buildid": "20160418173022", 20:02:48 INFO - "pgo_build": "True", 20:02:48 INFO - "basedir": "/builds/slave/test", 20:02:48 INFO - "buildnumber": 585, 20:02:48 INFO - "slavename": "talos-linux64-ix-057", 20:02:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:02:48 INFO - "platform": "ubuntu64_hw", 20:02:48 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:02:48 INFO - "branch": "fx-team", 20:02:48 INFO - "repo_path": "integration/fx-team", 20:02:48 INFO - "revision": "05a9daa3368cb8e32c7393fcb5ff7179023c6c50", 20:02:48 INFO - "stage_platform": "linux64-pgo", 20:02:48 INFO - "builduid": "142b371ba97349e398251785efadfd86", 20:02:48 INFO - "slavebuilddir": "test" 20:02:48 INFO - } 20:02:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 20:02:48 INFO - Running post-action listener: _resource_record_post_action 20:02:48 INFO - ##### 20:02:48 INFO - ##### Running download-and-extract step. 20:02:48 INFO - ##### 20:02:48 INFO - Running pre-action listener: _resource_record_pre_action 20:02:48 INFO - Running main action method: download_and_extract 20:02:48 INFO - mkdir: /builds/slave/test/build/tests 20:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:48 INFO - https://queue.taskcluster.net/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:02:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:02:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:02:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:02:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:02:50 INFO - Downloaded 1361 bytes. 20:02:50 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:02:50 INFO - Using the following test package requirements: 20:02:50 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:02:50 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:02:50 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:02:50 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:50 INFO - u'jsshell-linux-x86_64.zip'], 20:02:50 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:02:50 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:02:50 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:02:50 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:02:50 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:02:50 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:02:50 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:50 INFO - https://queue.taskcluster.net/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:02:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:02:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:02:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:02:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:02:51 INFO - Downloaded 23780753 bytes. 20:02:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:02:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:02:52 INFO - Return code: 0 20:02:52 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:02: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')]} 20:02:52 INFO - https://queue.taskcluster.net/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:02:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:02:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:02:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:02:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:02:57 INFO - Downloaded 23780753 bytes. 20:02:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:02:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:02:58 INFO - Return code: 0 20:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:58 INFO - https://queue.taskcluster.net/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:02:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:02:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:02:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:02:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:02:59 INFO - Downloaded 10845952 bytes. 20:02:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:02:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:02:59 INFO - Return code: 0 20:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:59 INFO - https://queue.taskcluster.net/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:02:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:02:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:02:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:02:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:03:01 INFO - Downloaded 58251888 bytes. 20:03:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:03:01 INFO - mkdir: /builds/slave/test/properties 20:03:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:03:01 INFO - Writing to file /builds/slave/test/properties/build_url 20:03:01 INFO - Contents: 20:03:01 INFO - build_url:https://queue.taskcluster.net/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:03:02 INFO - Running post-action listener: _resource_record_post_action 20:03:02 INFO - Running post-action listener: set_extra_try_arguments 20:03:02 INFO - ##### 20:03:02 INFO - ##### Running populate-webroot step. 20:03:02 INFO - ##### 20:03:02 INFO - Running pre-action listener: _resource_record_pre_action 20:03:02 INFO - Running main action method: populate_webroot 20:03:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:03:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:03:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:03:02 INFO - '--tppagecycles', 20:03:02 INFO - '7'], 20:03:02 INFO - 'tests': ['tsvgm']}}, 20:03:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:03:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:03:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:03:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:03:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:03:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:03:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:02 INFO - 'talos_options': ['--disable-e10s'], 20:03:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:02 INFO - 'talos_options': ['--disable-e10s'], 20:03:02 INFO - 'tests': ['damp', 'tps']}, 20:03:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:02 INFO - 'tests': ['damp', 'tps']}, 20:03:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:03:02 INFO - 'tests': ['dromaeo_dom']}, 20:03:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:03:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:03:02 INFO - 'tests': ['a11yr', 20:03:02 INFO - 'ts_paint', 20:03:02 INFO - 'tpaint', 20:03:02 INFO - 'sessionrestore', 20:03:02 INFO - 'sessionrestore_no_auto_restore', 20:03:02 INFO - 'tabpaint']}, 20:03:02 INFO - 'other-e10s': {'tests': ['a11yr', 20:03:02 INFO - 'ts_paint', 20:03:02 INFO - 'tpaint', 20:03:02 INFO - 'sessionrestore', 20:03:02 INFO - 'sessionrestore_no_auto_restore', 20:03:02 INFO - 'tabpaint']}, 20:03:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:03:02 INFO - 'ts_paint', 20:03:02 INFO - 'tpaint', 20:03:02 INFO - 'sessionrestore', 20:03:02 INFO - 'sessionrestore_no_auto_restore', 20:03:02 INFO - 'tabpaint']}, 20:03:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:03:02 INFO - 'ts_paint', 20:03:02 INFO - 'tpaint', 20:03:02 INFO - 'sessionrestore', 20:03:02 INFO - 'sessionrestore_no_auto_restore', 20:03:02 INFO - 'tabpaint']}, 20:03:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:03:02 INFO - 'tests': ['a11yr', 20:03:02 INFO - 'ts_paint', 20:03:02 INFO - 'tpaint', 20:03:02 INFO - 'sessionrestore', 20:03:02 INFO - 'sessionrestore_no_auto_restore', 20:03:02 INFO - 'tabpaint']}, 20:03:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:03:02 INFO - 'tests': ['a11yr', 20:03:02 INFO - 'ts_paint', 20:03:02 INFO - 'tpaint', 20:03:02 INFO - 'sessionrestore', 20:03:02 INFO - 'sessionrestore_no_auto_restore', 20:03:02 INFO - 'tabpaint']}, 20:03:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:03:02 INFO - 'tests': ['tsvgx', 20:03:02 INFO - 'tsvgr_opacity', 20:03:02 INFO - 'tart', 20:03:02 INFO - 'tscrollx', 20:03:02 INFO - 'cart']}, 20:03:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:03:02 INFO - 'tsvgr_opacity', 20:03:02 INFO - 'tart', 20:03:02 INFO - 'tscrollx', 20:03:02 INFO - 'cart']}, 20:03:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:02 INFO - 'talos_options': ['--disable-e10s'], 20:03:02 INFO - 'tests': ['tp5o']}, 20:03:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:02 INFO - 'tests': ['tp5o']}, 20:03:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:02 INFO - 'talos_options': ['--disable-e10s', 20:03:02 INFO - '--xperf_path', 20:03:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:02 INFO - 'tests': ['tp5n']}, 20:03:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:02 INFO - 'talos_options': ['--xperf_path', 20:03:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:02 INFO - 'tests': ['tp5n']}}, 20:03:02 INFO - 'talos.zip': {'path': '', 20:03:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:03:02 INFO - Running post-action listener: _resource_record_post_action 20:03:02 INFO - ##### 20:03:02 INFO - ##### Running create-virtualenv step. 20:03:02 INFO - ##### 20:03:02 INFO - Running pre-action listener: _resource_record_pre_action 20:03:02 INFO - Running main action method: create_virtualenv 20:03:02 INFO - Creating virtualenv /builds/slave/test/build/venv 20:03:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:03:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:03:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:03:02 INFO - Using real prefix '/usr' 20:03:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:03:02 INFO - Installing distribute.............................................................................................................................................................................................done. 20:03:04 INFO - Installing pip.................done. 20:03:04 INFO - Return code: 0 20:03:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:03: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')]} 20:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03: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')]} 20:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:04 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 0x7fec3e9d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce810>, '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 0x2bcf710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcfba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:03:04 INFO - Using env: {'DISPLAY': ':0', 20:03:04 INFO - 'HOME': '/home/cltbld', 20:03:04 INFO - 'LANG': 'en_US.UTF-8', 20:03:04 INFO - 'LANGUAGE': 'en_US:en', 20:03:04 INFO - 'LOGNAME': 'cltbld', 20:03:04 INFO - 'MAIL': '/var/mail/cltbld', 20:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:04 INFO - 'MOZ_NO_REMOTE': '1', 20:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:04 INFO - 'NO_EM_RESTART': '1', 20:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:04 INFO - 'PWD': '/builds/slave/test', 20:03:04 INFO - 'SHELL': '/bin/bash', 20:03:04 INFO - 'SHLVL': '1', 20:03:04 INFO - 'TERM': 'linux', 20:03:04 INFO - 'TMOUT': '86400', 20:03:04 INFO - 'USER': 'cltbld', 20:03:04 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 20:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:04 INFO - '_': '/tools/buildbot/bin/python'} 20:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:03:04 INFO - Cleaning up... 20:03:05 INFO - Return code: 0 20:03:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec3e9d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce810>, '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 0x2bcf710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcfba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 20:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:03:05 INFO - Using env: {'DISPLAY': ':0', 20:03:05 INFO - 'HOME': '/home/cltbld', 20:03:05 INFO - 'LANG': 'en_US.UTF-8', 20:03:05 INFO - 'LANGUAGE': 'en_US:en', 20:03:05 INFO - 'LOGNAME': 'cltbld', 20:03:05 INFO - 'MAIL': '/var/mail/cltbld', 20:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:05 INFO - 'MOZ_NO_REMOTE': '1', 20:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:05 INFO - 'NO_EM_RESTART': '1', 20:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:05 INFO - 'PWD': '/builds/slave/test', 20:03:05 INFO - 'SHELL': '/bin/bash', 20:03:05 INFO - 'SHLVL': '1', 20:03:05 INFO - 'TERM': 'linux', 20:03:05 INFO - 'TMOUT': '86400', 20:03:05 INFO - 'USER': 'cltbld', 20:03:05 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 20:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:05 INFO - '_': '/tools/buildbot/bin/python'} 20:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:05 INFO - Downloading/unpacking psutil>=0.7.1 20:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:03:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:07 INFO - Installing collected packages: psutil 20:03:07 INFO - Running setup.py install for psutil 20:03:07 INFO - building 'psutil._psutil_linux' extension 20:03:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:03:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:03:07 INFO - building 'psutil._psutil_posix' extension 20:03:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:03:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:03:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:07 INFO - Successfully installed psutil 20:03:07 INFO - Cleaning up... 20:03:07 INFO - Return code: 0 20:03:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:03: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')]} 20:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03: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')]} 20:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:07 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec3e9d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce810>, '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 0x2bcf710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcfba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:07 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.0.0'] in /builds/slave/test/build 20:03:07 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.0.0 20:03:07 INFO - Using env: {'DISPLAY': ':0', 20:03:07 INFO - 'HOME': '/home/cltbld', 20:03:07 INFO - 'LANG': 'en_US.UTF-8', 20:03:07 INFO - 'LANGUAGE': 'en_US:en', 20:03:07 INFO - 'LOGNAME': 'cltbld', 20:03:07 INFO - 'MAIL': '/var/mail/cltbld', 20:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:07 INFO - 'MOZ_NO_REMOTE': '1', 20:03:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:07 INFO - 'NO_EM_RESTART': '1', 20:03:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:07 INFO - 'PWD': '/builds/slave/test', 20:03:07 INFO - 'SHELL': '/bin/bash', 20:03:07 INFO - 'SHLVL': '1', 20:03:07 INFO - 'TERM': 'linux', 20:03:07 INFO - 'TMOUT': '86400', 20:03:07 INFO - 'USER': 'cltbld', 20:03:07 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 20:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:07 INFO - '_': '/tools/buildbot/bin/python'} 20:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:03:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:03:09 INFO - Installing collected packages: mozsystemmonitor 20:03:09 INFO - Running setup.py install for mozsystemmonitor 20:03:10 INFO - Successfully installed mozsystemmonitor 20:03:10 INFO - Cleaning up... 20:03:10 INFO - Return code: 0 20:03:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:03: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')]} 20:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03: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')]} 20:03:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fec3e9d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce810>, '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 0x2bcf710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcfba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:03:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:03:10 INFO - Using env: {'DISPLAY': ':0', 20:03:10 INFO - 'HOME': '/home/cltbld', 20:03:10 INFO - 'LANG': 'en_US.UTF-8', 20:03:10 INFO - 'LANGUAGE': 'en_US:en', 20:03:10 INFO - 'LOGNAME': 'cltbld', 20:03:10 INFO - 'MAIL': '/var/mail/cltbld', 20:03:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:10 INFO - 'MOZ_NO_REMOTE': '1', 20:03:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:10 INFO - 'NO_EM_RESTART': '1', 20:03:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:10 INFO - 'PWD': '/builds/slave/test', 20:03:10 INFO - 'SHELL': '/bin/bash', 20:03:10 INFO - 'SHLVL': '1', 20:03:10 INFO - 'TERM': 'linux', 20:03:10 INFO - 'TMOUT': '86400', 20:03:10 INFO - 'USER': 'cltbld', 20:03:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 20:03:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:10 INFO - '_': '/tools/buildbot/bin/python'} 20:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:10 INFO - Downloading/unpacking blobuploader==1.2.4 20:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:12 INFO - Downloading blobuploader-1.2.4.tar.gz 20:03:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:03:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:03:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:13 INFO - Downloading docopt-0.6.1.tar.gz 20:03:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:03:13 INFO - Installing collected packages: blobuploader, requests, docopt 20:03:13 INFO - Running setup.py install for blobuploader 20:03:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:03:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:03:13 INFO - Running setup.py install for requests 20:03:13 INFO - Running setup.py install for docopt 20:03:13 INFO - Successfully installed blobuploader requests docopt 20:03:13 INFO - Cleaning up... 20:03:13 INFO - Return code: 0 20:03:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:13 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 0x7fec3e9d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce810>, '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 0x2bcf710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcfba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:03:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:03:13 INFO - Using env: {'DISPLAY': ':0', 20:03:13 INFO - 'HOME': '/home/cltbld', 20:03:13 INFO - 'LANG': 'en_US.UTF-8', 20:03:13 INFO - 'LANGUAGE': 'en_US:en', 20:03:13 INFO - 'LOGNAME': 'cltbld', 20:03:13 INFO - 'MAIL': '/var/mail/cltbld', 20:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:13 INFO - 'MOZ_NO_REMOTE': '1', 20:03:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:13 INFO - 'NO_EM_RESTART': '1', 20:03:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:13 INFO - 'PWD': '/builds/slave/test', 20:03:13 INFO - 'SHELL': '/bin/bash', 20:03:13 INFO - 'SHLVL': '1', 20:03:13 INFO - 'TERM': 'linux', 20:03:13 INFO - 'TMOUT': '86400', 20:03:13 INFO - 'USER': 'cltbld', 20:03:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 20:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:13 INFO - '_': '/tools/buildbot/bin/python'} 20:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:03:13 INFO - Running setup.py (path:/tmp/pip-R3DXq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:03:13 INFO - Running setup.py (path:/tmp/pip-abQCVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:03:14 INFO - Running setup.py (path:/tmp/pip-X2pgrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:03:14 INFO - Running setup.py (path:/tmp/pip-hHrQrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:03:14 INFO - Running setup.py (path:/tmp/pip-ejb1n0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:03:14 INFO - Running setup.py (path:/tmp/pip-3qJy52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:03:14 INFO - Running setup.py (path:/tmp/pip-WhI2qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:03:14 INFO - Running setup.py (path:/tmp/pip-cFdBL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:03:14 INFO - Running setup.py (path:/tmp/pip-Ry_3Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:03:14 INFO - Running setup.py (path:/tmp/pip-57v7r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:03:14 INFO - Running setup.py (path:/tmp/pip-2lNSbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:03:14 INFO - Running setup.py (path:/tmp/pip-YUnqAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:03:14 INFO - Running setup.py (path:/tmp/pip-pCSAYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:03:14 INFO - Running setup.py (path:/tmp/pip-F1Iwer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:14 INFO - Running setup.py (path:/tmp/pip-gmRCJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:03:14 INFO - Running setup.py (path:/tmp/pip-jupJbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:03:15 INFO - Running setup.py (path:/tmp/pip-qgukoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:03:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:03:15 INFO - Running setup.py install for manifestparser 20:03:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:03:15 INFO - Running setup.py install for mozcrash 20:03:15 INFO - Running setup.py install for mozdebug 20:03:15 INFO - Running setup.py install for mozdevice 20:03:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:03:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:03:15 INFO - Running setup.py install for mozfile 20:03:15 INFO - Running setup.py install for mozhttpd 20:03:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:03:15 INFO - Running setup.py install for mozinfo 20:03:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:03:15 INFO - Running setup.py install for mozInstall 20:03:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:03:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:03:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:03:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:03:15 INFO - Running setup.py install for mozleak 20:03:16 INFO - Running setup.py install for mozlog 20:03:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:03:16 INFO - Running setup.py install for moznetwork 20:03:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:03:16 INFO - Running setup.py install for mozprocess 20:03:16 INFO - Running setup.py install for mozprofile 20:03:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:03:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:03:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:03:16 INFO - Running setup.py install for mozrunner 20:03:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:03:16 INFO - Running setup.py install for mozscreenshot 20:03:16 INFO - Running setup.py install for moztest 20:03:16 INFO - Running setup.py install for mozversion 20:03:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:03:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:03:16 INFO - Cleaning up... 20:03:16 INFO - Return code: 0 20:03:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:16 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 0x7fec3e9d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce810>, '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 0x2bcf710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcfba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:03:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:03:16 INFO - Using env: {'DISPLAY': ':0', 20:03:16 INFO - 'HOME': '/home/cltbld', 20:03:16 INFO - 'LANG': 'en_US.UTF-8', 20:03:16 INFO - 'LANGUAGE': 'en_US:en', 20:03:16 INFO - 'LOGNAME': 'cltbld', 20:03:16 INFO - 'MAIL': '/var/mail/cltbld', 20:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:16 INFO - 'MOZ_NO_REMOTE': '1', 20:03:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:16 INFO - 'NO_EM_RESTART': '1', 20:03:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:16 INFO - 'PWD': '/builds/slave/test', 20:03:16 INFO - 'SHELL': '/bin/bash', 20:03:16 INFO - 'SHLVL': '1', 20:03:16 INFO - 'TERM': 'linux', 20:03:16 INFO - 'TMOUT': '86400', 20:03:16 INFO - 'USER': 'cltbld', 20:03:16 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 20:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:16 INFO - '_': '/tools/buildbot/bin/python'} 20:03:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:03:17 INFO - Running setup.py (path:/tmp/pip-Zch5QH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:03:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:03:17 INFO - Running setup.py (path:/tmp/pip-GiuUQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:03:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:03:17 INFO - Running setup.py (path:/tmp/pip-qrFmb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:03:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:03:17 INFO - Running setup.py (path:/tmp/pip-bp16BB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:03:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:03:17 INFO - Running setup.py (path:/tmp/pip-JCclgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:03:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:03:17 INFO - Running setup.py (path:/tmp/pip-Cr9vSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:03:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:03:17 INFO - Running setup.py (path:/tmp/pip-hYauGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:03:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:03:17 INFO - Running setup.py (path:/tmp/pip-se0HrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:03:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:03:17 INFO - Running setup.py (path:/tmp/pip-76jhsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:03:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:03:17 INFO - Running setup.py (path:/tmp/pip-tagFT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:03:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:03:17 INFO - Running setup.py (path:/tmp/pip-lDGpyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:03:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:03:17 INFO - Running setup.py (path:/tmp/pip-FavvkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:03:18 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)) 20:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:03:18 INFO - Running setup.py (path:/tmp/pip-FevoVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:03:18 INFO - Running setup.py (path:/tmp/pip-B5oUVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:03:18 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)) 20:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:18 INFO - Running setup.py (path:/tmp/pip-y2siux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:03:18 INFO - Running setup.py (path:/tmp/pip-cmsYbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:03:18 INFO - Running setup.py (path:/tmp/pip-vxLnPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:03:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:20 INFO - Downloading blessings-1.6.tar.gz 20:03:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:03:20 INFO - Installing collected packages: blessings 20:03:20 INFO - Running setup.py install for blessings 20:03:20 INFO - Successfully installed blessings 20:03:20 INFO - Cleaning up... 20:03:20 INFO - Return code: 0 20:03:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:03:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:03:20 INFO - Reading from file tmpfile_stdout 20:03:20 INFO - Current package versions: 20:03:20 INFO - argparse == 1.2.1 20:03:20 INFO - blessings == 1.6 20:03:20 INFO - blobuploader == 1.2.4 20:03:20 INFO - docopt == 0.6.1 20:03:20 INFO - manifestparser == 1.1 20:03:20 INFO - mozInstall == 1.12 20:03:20 INFO - mozcrash == 0.17 20:03:20 INFO - mozdebug == 0.1 20:03:20 INFO - mozdevice == 0.48 20:03:20 INFO - mozfile == 1.2 20:03:20 INFO - mozhttpd == 0.7 20:03:20 INFO - mozinfo == 0.9 20:03:20 INFO - mozleak == 0.1 20:03:20 INFO - mozlog == 3.1 20:03:20 INFO - moznetwork == 0.27 20:03:20 INFO - mozprocess == 0.22 20:03:20 INFO - mozprofile == 0.28 20:03:20 INFO - mozrunner == 6.11 20:03:20 INFO - mozscreenshot == 0.1 20:03:20 INFO - mozsystemmonitor == 0.0 20:03:20 INFO - moztest == 0.7 20:03:20 INFO - mozversion == 1.4 20:03:20 INFO - psutil == 3.1.1 20:03:20 INFO - requests == 1.2.3 20:03:20 INFO - wsgiref == 0.1.2 20:03:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:20 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 0x7fec3e9d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce810>, '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 0x2bcf710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcfba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:03:20 INFO - Using env: {'DISPLAY': ':0', 20:03:20 INFO - 'HOME': '/home/cltbld', 20:03:20 INFO - 'LANG': 'en_US.UTF-8', 20:03:20 INFO - 'LANGUAGE': 'en_US:en', 20:03:20 INFO - 'LOGNAME': 'cltbld', 20:03:20 INFO - 'MAIL': '/var/mail/cltbld', 20:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:20 INFO - 'MOZ_NO_REMOTE': '1', 20:03:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:20 INFO - 'NO_EM_RESTART': '1', 20:03:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:20 INFO - 'PWD': '/builds/slave/test', 20:03:20 INFO - 'SHELL': '/bin/bash', 20:03:20 INFO - 'SHLVL': '1', 20:03:20 INFO - 'TERM': 'linux', 20:03:20 INFO - 'TMOUT': '86400', 20:03:20 INFO - 'USER': 'cltbld', 20:03:20 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 20:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:20 INFO - '_': '/tools/buildbot/bin/python'} 20:03:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:03:20 INFO - Cleaning up... 20:03:20 INFO - Return code: 0 20:03:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:20 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 0x7fec3e9d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce810>, '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 0x2bcf710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcfba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:03:20 INFO - Using env: {'DISPLAY': ':0', 20:03:20 INFO - 'HOME': '/home/cltbld', 20:03:20 INFO - 'LANG': 'en_US.UTF-8', 20:03:20 INFO - 'LANGUAGE': 'en_US:en', 20:03:20 INFO - 'LOGNAME': 'cltbld', 20:03:20 INFO - 'MAIL': '/var/mail/cltbld', 20:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:20 INFO - 'MOZ_NO_REMOTE': '1', 20:03:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:20 INFO - 'NO_EM_RESTART': '1', 20:03:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:20 INFO - 'PWD': '/builds/slave/test', 20:03:20 INFO - 'SHELL': '/bin/bash', 20:03:20 INFO - 'SHLVL': '1', 20:03:20 INFO - 'TERM': 'linux', 20:03:20 INFO - 'TMOUT': '86400', 20:03:20 INFO - 'USER': 'cltbld', 20:03:20 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 20:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:20 INFO - '_': '/tools/buildbot/bin/python'} 20:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:21 INFO - Downloading/unpacking jsonschema 20:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:03:22 INFO - Downloading/unpacking functools32 (from jsonschema) 20:03: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 20:03: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 20:03: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 20:03: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 20:03: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 20:03: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 20:03:23 INFO - Downloading functools32-3.2.3-2.tar.gz 20:03:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:03:23 INFO - warning: no files found matching '*.txt' 20:03:23 INFO - no previously-included directories found matching 'build' 20:03:23 INFO - no previously-included directories found matching 'dist' 20:03:23 INFO - no previously-included directories found matching '.git*' 20:03:23 INFO - Installing collected packages: jsonschema, functools32 20:03:23 INFO - Running setup.py install for functools32 20:03:23 INFO - warning: no files found matching '*.txt' 20:03:23 INFO - no previously-included directories found matching 'build' 20:03:23 INFO - no previously-included directories found matching 'dist' 20:03:23 INFO - no previously-included directories found matching '.git*' 20:03:23 INFO - Successfully installed jsonschema functools32 20:03:23 INFO - Cleaning up... 20:03:23 INFO - Return code: 0 20:03:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:23 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec3e9d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce810>, '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 0x2bcf710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcfba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:23 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', 'flake8'] in /builds/slave/test/build 20:03:23 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 flake8 20:03:23 INFO - Using env: {'DISPLAY': ':0', 20:03:23 INFO - 'HOME': '/home/cltbld', 20:03:23 INFO - 'LANG': 'en_US.UTF-8', 20:03:23 INFO - 'LANGUAGE': 'en_US:en', 20:03:23 INFO - 'LOGNAME': 'cltbld', 20:03:23 INFO - 'MAIL': '/var/mail/cltbld', 20:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:23 INFO - 'MOZ_NO_REMOTE': '1', 20:03:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:23 INFO - 'NO_EM_RESTART': '1', 20:03:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:23 INFO - 'PWD': '/builds/slave/test', 20:03:23 INFO - 'SHELL': '/bin/bash', 20:03:23 INFO - 'SHLVL': '1', 20:03:23 INFO - 'TERM': 'linux', 20:03:23 INFO - 'TMOUT': '86400', 20:03:23 INFO - 'USER': 'cltbld', 20:03:23 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 20:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:23 INFO - '_': '/tools/buildbot/bin/python'} 20:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:23 INFO - Downloading/unpacking flake8 20:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:03:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:03:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:03:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:03:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:03:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:03:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:03:26 INFO - no previously-included directories found matching 'docs/_build' 20:03:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:03:26 INFO - Running setup.py install for pep8 20:03:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:03:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:03:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:03:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:03:26 INFO - no previously-included directories found matching 'docs/_build' 20:03:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:03:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:03:26 INFO - Cleaning up... 20:03:26 INFO - Return code: 0 20:03:26 INFO - Running post-action listener: _resource_record_post_action 20:03:26 INFO - Running post-action listener: _start_resource_monitoring 20:03:26 INFO - Starting resource monitoring. 20:03:26 INFO - ##### 20:03:26 INFO - ##### Running install step. 20:03:26 INFO - ##### 20:03:26 INFO - Running pre-action listener: _resource_record_pre_action 20:03:26 INFO - Running main action method: install 20:03:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:03:26 INFO - Reading from file tmpfile_stdout 20:03:26 INFO - Detecting whether we're running mozinstall >=1.0... 20:03:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:03:26 INFO - Reading from file tmpfile_stdout 20:03:26 INFO - Output received: 20:03:26 INFO - Usage: mozinstall [options] installer 20:03:26 INFO - Options: 20:03:26 INFO - -h, --help show this help message and exit 20:03:26 INFO - -d DEST, --destination=DEST 20:03:26 INFO - Directory to install application into. [default: 20:03:26 INFO - "/builds/slave/test"] 20:03:26 INFO - --app=APP Application being installed. [default: firefox] 20:03:26 INFO - mkdir: /builds/slave/test/build/application 20:03:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:03:43 INFO - Reading from file tmpfile_stdout 20:03:43 INFO - Output received: 20:03:43 INFO - /builds/slave/test/build/application/firefox/firefox 20:03:43 INFO - Running post-action listener: _resource_record_post_action 20:03:43 INFO - ##### 20:03:43 INFO - ##### Running run-tests step. 20:03:43 INFO - ##### 20:03:43 INFO - Running pre-action listener: _resource_record_pre_action 20:03:43 INFO - Running main action method: run_tests 20:03:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:03:43 INFO - Python 2.7.3 20:03:43 INFO - Return code: 0 20:03:43 INFO - grabbing minidump binary from tooltool 20:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:43 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce810>, '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 0x2bcf710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcfba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:03:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:03:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:03:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:03:43 INFO - Return code: 0 20:03:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:03:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:03:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:03:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:03:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:03:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:03:44 INFO - Return code: 0 20:03:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:03:44 INFO - Using env: {'DISPLAY': ':0', 20:03:44 INFO - 'HOME': '/home/cltbld', 20:03:44 INFO - 'LANG': 'en_US.UTF-8', 20:03:44 INFO - 'LANGUAGE': 'en_US:en', 20:03:44 INFO - 'LOGNAME': 'cltbld', 20:03:44 INFO - 'MAIL': '/var/mail/cltbld', 20:03:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:03:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:44 INFO - 'MOZ_NO_REMOTE': '1', 20:03:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:03:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:44 INFO - 'NO_EM_RESTART': '1', 20:03:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:44 INFO - 'PWD': '/builds/slave/test', 20:03:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:03:44 INFO - 'SHELL': '/bin/bash', 20:03:44 INFO - 'SHLVL': '1', 20:03:44 INFO - 'TERM': 'linux', 20:03:44 INFO - 'TMOUT': '86400', 20:03:44 INFO - 'USER': 'cltbld', 20:03:44 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074', 20:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:44 INFO - '_': '/tools/buildbot/bin/python'} 20:03:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:03:44 INFO - mozversion application_buildid: 20160418173022 20:03:44 INFO - mozversion application_changeset: 05a9daa3368cb8e32c7393fcb5ff7179023c6c50 20:03:44 INFO - mozversion application_display_name: Nightly 20:03:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:03:44 INFO - mozversion application_name: Firefox 20:03:44 INFO - mozversion application_remotingname: firefox 20:03:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:03:44 INFO - mozversion application_vendor: Mozilla 20:03:44 INFO - mozversion application_version: 48.0a1 20:03:44 INFO - mozversion platform_buildid: 20160418173022 20:03:44 INFO - mozversion platform_changeset: 05a9daa3368cb8e32c7393fcb5ff7179023c6c50 20:03:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:03:44 INFO - mozversion platform_version: 48.0a1 20:03:44 INFO - using testdate: 1461035024 20:03:44 INFO - actual date: 1461035024 20:03:44 INFO - starting webserver on 'localhost:39844' 20:03:44 INFO - SUITE-START | Running 2 tests 20:03:44 INFO - TEST-START | dromaeo_css 20:03:44 INFO - operating with platform_type : linux_ 20:03:44 INFO - Initialising browser for dromaeo_css test... 20:03:44 INFO - TEST-INFO | started process 16832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm2yCBf/profile http://localhost:39844/getInfo.html) 20:03:48 INFO - PROCESS | 16832 | __metrics Screen width/height:1600/1200 20:03:48 INFO - PROCESS | 16832 | colorDepth:24 20:03:48 INFO - PROCESS | 16832 | Browser inner width/height: 1024/697 20:03:48 INFO - PROCESS | 16832 | __metrics 20:03:49 ERROR - PROCESS | 16832 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:03:50 INFO - TEST-INFO | 16832: exit 0 20:03:50 INFO - Browser initialized. 20:03:50 INFO - Running cycle 1/1 for dromaeo_css test... 20:03:50 INFO - TEST-INFO | started process 16915 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm2yCBf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:04:02 INFO - PROCESS | 16915 | RSS: Main: 152436736 20:04:02 INFO - PROCESS | 16915 | 20:04:53 INFO - PROCESS | 16915 | 1461035093863 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:07:00 INFO - PROCESS | 16915 | Cycle 1(1): loaded http://localhost:39844/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39844/tests/dromaeo/cssquery-ext.html) 20:07:01 INFO - PROCESS | 16915 | RSS: Main: 239738880 20:07:01 INFO - PROCESS | 16915 | 20:10:03 INFO - PROCESS | 16915 | Cycle 1(1): loaded http://localhost:39844/tests/dromaeo/cssquery-ext.html (next: http://localhost:39844/tests/dromaeo/cssquery-jquery.html) 20:10:03 INFO - PROCESS | 16915 | RSS: Main: 243404800 20:10:03 INFO - PROCESS | 16915 | 20:13:05 INFO - PROCESS | 16915 | Cycle 1(1): loaded http://localhost:39844/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39844/tests/dromaeo/cssquery-mootools.html) 20:13:06 INFO - PROCESS | 16915 | RSS: Main: 238759936 20:13:06 INFO - PROCESS | 16915 | 20:16:08 INFO - PROCESS | 16915 | Cycle 1(1): loaded http://localhost:39844/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39844/tests/dromaeo/cssquery-prototype.html) 20:16:09 INFO - PROCESS | 16915 | RSS: Main: 228167680 20:16:09 INFO - PROCESS | 16915 | 20:19:11 INFO - PROCESS | 16915 | Cycle 1(1): loaded http://localhost:39844/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39844/tests/dromaeo/cssquery-yui.html) 20:19:12 INFO - PROCESS | 16915 | RSS: Main: 221724672 20:19:12 INFO - PROCESS | 16915 | 20:22:14 INFO - PROCESS | 16915 | Cycle 1(1): loaded http://localhost:39844/tests/dromaeo/cssquery-yui.html (next: http://localhost:39844/tests/dromaeo/cssquery-dojo.html) 20:22:15 INFO - PROCESS | 16915 | RSS: Main: 263245824 20:22:15 INFO - PROCESS | 16915 | 20:22:15 INFO - PROCESS | 16915 | __start_tp_report 20:22:15 INFO - PROCESS | 16915 | _x_x_mozilla_page_load 20:22:15 INFO - PROCESS | 16915 | _x_x_mozilla_page_load_details 20:22:15 INFO - PROCESS | 16915 | |i|pagename|runs| 20:22:15 INFO - PROCESS | 16915 | |0;dojo.html;3015.849207539623;3041.0572722456027;3090.320129571495;3093.5669006339117;3122.4067427188825;5139.229115632647;5161.200013997827;5233.7121458319825;5234.7644356003975;5240.580753539717;5254.710990895499;5311.256424100629;5328.387235467922;5333.493318134781;5366;4658.301254811771;4708.69393489423;4767.499412561683;4814.6870453420415;4837.467878533358;4643.326717625942;4796.568308852203;4819.638527110464;4848.53938875808;4855.878603034935;4697.342372067913;4704.764761761915;4846.1034708578845;4852.951470485285;4865.854024379239;4746.572808447257;4747.8575642730775;4748.5251474852585;4752.453467851206;4799.712017278975;4717.198076327033;4720.740359280238;4723.504032076617;4724.078804633098;4730.290456431529;5080.110980578421;5191.0656081905245;5276.630635855492;5294.232336311214;5294.285271488338;5579.6652200867675;5579.69311687857;5581.441855814386;5583.05088135018;5585.553155747531;5584.5253153482;5595.664260144405;5597.216389705444;5617.185508101303;5617.859553511195;5141.177411614124;5269.7365131743645;5346.304980352529;5385.78456861725;5394.703291318976;5733.913991290134;5756.481916627524;5756.597038207369;5762.769489220468;5808.215890854681;5392.083345831218;5525.972370138204;5537.058700021006;5538.252335934597;5545.72271386429;5564.10974244119;5619.8595035124445;5629.521490673339;5636.746346414421;5668.518175955008;5537.197106419547;5587.1339942309005;5590.161475778585;5591.4688104629995;5593.188987596775;5363.436839131913;5552.11166213412;5589.524890384281;5595.21666966625;5602.2717046783655;4276.893077673083;4279.465066866642;4290.742555446684;4305.138972205571;4307.3754305626135;3813.2564149990485;3814.6185381461632;3835.616438356142;3861.787601681878;3879.7866117363815;5099.107656160157;5114.693118412907;5303.575713942875;5417.918731219035;5438.211459338374;5635.746391412315;5659.377468478464;5662.490375866109;5695.743691533891;5712.971435142881;5356.946430535645;5366.356037275474;5367.275417818622;5367.597430192751;5369.543588794996;4731.905361892743;4782.33047373361;4869.14789911764;4873.512648735169;4903.975480122576;5760.53915686744;5770.336411312753;5771.797987070432;5778.306603207642;5806.854828629233;5558.499735023867;5563.02647036775;5563.916541251965;5571.387147413781;5572.442755724557;5600.663960162403;5751.683657398883;5764.365919748908;5816.651000939957;5851.531877449879;5470.425605311385;5470.64440811346;5474.534664553557;5480.424555421623;5487.890242195054;5524.944750552443;5566;5566.276384070207;5576.247206627054;5576.7211639417055;5339.733013349394;5435.184722291688;5492.780288788404;5515.310586176728;5536.584756143225;5446.645968012067;5448.618596698193;5449.291592093003;5452.91820622683;5460.672359658433;5260.86847828792;5374.355077390738;5379.381371142369;5379.731013449234;5425.104857698593;5497.862553436036;5538.47384498472;5553.888922221614;5583;5601.887962240814;5360.249565060816;5363.41002489718;5370.087085195604;5371.5971302153275;5419.3225846769155 20:22:15 INFO - PROCESS | 16915 | |1;ext.html;603.0622382195684;634.6287421858212;641.2081079866364;651.9674016299184;656.8062421585635;29956.70043299566;30706.692933070663;36955.44566831496;37617.62382376175;37657.246855062884;39716.60283397165;40120.598794012054;40289.194216115735;40439;40472.59527404725;8543.786405339884;8726.127387261287;8735.781605459882;8740.388172827905;8741.344399170088;8610.956945215265;8744.562771861414;8746.912530874706;8748.212660860521;8751.168638979287;8721.084286149959;8822.64709411626;9009.234215091725;9014.504202268872;9015.684451044215;8864.512451815148;8921.910780892173;8948.194662480375;8952.328575356874;8960.507172105532;8768.386212965095;8890.555472226428;8892.777680557972;8893.555322233862;8896.154865287852;39838.402423963664;40088.79955600233;40330.193396131916;40384.39423408651;40404.59595404038;3268.1829542614346;3469.5663042119736;3517.8416971236356;3580.4629305604108;3799.392097264452;29942.85028574865;30981.380372392425;31120.487529308124;31467.055988320386;31692;4053.4279266038543;4124.422580838685;4250.06498570314;4261.062566235423;4263;287450;288748;289067;289193;291494.9999999979;34488.310233795186;35273.118172045906;53534.7323263389;53694.46305536895;53705.73147134318;33523.4971475428;33543.16142096467;33606;33637.15907102342;33646.831765841016;13552.932235338958;13610.931945340408;13631.182129072287;13690.041697081308;13800.792988105186;11761.353125578004;11837.88162118385;11838.88161118395;11843.28940263587;11846.407679615984;8343.8331233375;8365.623546940402;8398.244158025685;8423.831523369621;8468.576571171418;3286.1620286827183;3319.618243901934;3356.110630682871;3359.2945481448683;3385.2044769479153;1064.5901327988624;1085.3867564825848;1150.7295785490403;1150.7928572856965;1153.3944679043568;31248;31762.523562146587;32035.839820800746;32084.679153208635;32496.83751581227;1149.1381463902073;1152.464104191555;1164.545827127421;1221.096388672394;1243.347242697591;16752.664946701;17141.400050998403;17176.82823171752;17203;17219.22513486896;417944;419220;420005;420505;421515;54215.45784542183;56087.43912560904;56173.43826561764;56255;56314;1259.6976725585794;1315.283170671986;1388.0422508469326;1389.534505940501;1429.3925081840177;27755.306117347227;30869.382612347177;31302.217444563157;31749.682503174674;32058;43651.781741091094;44288.33567496554;44501.554984449744;44586;44625.55374446344;264392;267117;267149;267153;267679;22927.395082344075;25000.249992500256;25050.498990019732;26952.595711063957;27384.178474645792;40007.39988900227;41338;41648.3752743703;41681;41784.58215417928;34646.13384665403;42877.44953789892;44175.33736993883;44442.77778611086;45341.31988020116;38952.6104738949;39536.60463395329;39917.40123898202;39992.40011399773;40236.3964540538;41621.58378416177;42209;42276.57723422726;43098.353524696526;45518.544814552755;41513.37729934114;41667.7916610415;42461.36307955445;42566;42708.57291427046;28505.42989140247;29637.5554366689;29852.552211717277;29961.400771984874;30072.24819379533 20:22:15 INFO - PROCESS | 16915 | |2;jquery.html;393.6398195650979;394.24502078519635;396.59349167103716;401.9115794525204;403.5117507815543;14643;15561.455349062786;16610.25253863576;17483.038432886202;17517.474475765717;17423.91288043561;17432;18093.81906180938;18095.18571664275;18399.632007359844;5430.185472179165;5560.86097847553;5586.190002449643;5600.0759874620635;5616.550675945915;3948.940765888514;5514.393416724157;5570.498655121039;5836.795712150076;6150.876982460348;6088.056351265539;6099.298580663236;6100.23747031621;6110.358412366704;6143.631382117065;5214.843554693365;5500.724963751836;5549.1676248562835;5552.972235138839;6098.08528720691;5349.973250133725;5351.598630102758;5363.973180134113;5365.946340536622;5369.570434365241;11486;11709.238899471593;11996;12077.698057548543;12187.512499500099;2099.769025407204;2209.0942713487393;2209.193644319828;2211.612967730641;2304.43541332373;9180.6786762463;9691.515424228832;9874.16069634082;9903.05920937517;10029.398236105857;1856.303886042734;1866.9719954200698;1965.9017049147628;1997.300944669354;2030.3198428526462;67827.66086169587;69344.30655693429;70042.64978675074;70399.64800176017;70709.64645176793;10215.387076775418;10224.903894701569;10332.53503592325;10382.065614094618;10601.257911946244;14116.647083822781;14116.929415352857;14134.64663383403;14283.714325713636;14300.570982870531;7811.375089992787;7880.172581878935;7918;8050.718224862102;8059.314958228616;7634.6182690865235;7702.653380597886;7724.459287849909;7825.647845846951;7826.726064587712;4528.162289976365;4565.33802598628;4568.132054909556;4668.743219122981;4736.4316282046375;1873.3911478769455;1933.719610656447;1939.4957311098933;1991.084101313412;2018.5559176981042;962.3119469579284;963.2438535749403;972.1736523954582;972.7130496503548;1040.6669865643073;16829.83170168307;17619;17750.644987100186;18135.72796408055;18512.537186570444;997.2570435025807;1010.3432768700403;1047.3035431438161;1068.1828401273033;1097.5719469406938;9676.322657414054;9987.450690211963;10120.797584048278;10131.949340253252;10291.125254353465;500753;505569;506700;508637;545521;89543.55228223818;94517.05482945082;94937;97069;97252;1092.1972350322508;1105.2318638546133;1120.467777805536;1157.7163594919298;1164.7670465906851;16152.919235403748;16155.75766363482;16316.347346106497;16415;16421.42525011619;28184.577231341136;37459.81270093632;38456.615433845305;38858.61141388663;39459.40810887782;52609.73695131653;55818;56024.15963760465;56074;56079;7060.870260758254;8110.513369197631;8199.467034642728;8307.501549907025;8500.957495212484;9313.25493960495;11944.581939632071;12679.93660031694;12920.353982301036;12945.029122815638;6145.477634400947;8284.46151000183;10977.780444391226;11196.496157673088;11506.424678766196;11131.944340278571;11304.943475282571;11416.086713063101;11735.823962640738;12029.338386388832;11127.777444450903;11353.48909299067;11891.167618266983;12328.07539434528;12595.244285342542;8333.791655208668;8377.246047855722;8384.748457546284;8418.410711250399;8503.532305723245;6201;9607.991160928003;11118.722031949266;11919.46362413676;12044.819327710267 20:22:15 INFO - PROCESS | 16915 | |3;mootools.html;1308.6139588821297;1464.875485583725;1484.8589384008521;1641.958951026225;1814.9818501814987;8076.555789431579;8380.539070351128;8392.370572207086;8396.790080247996;8402.789930251747;8182;8315.708950186745;8318.043425006126;8325.167483251671;8328.541930193836;2002.7596688397414;2194.3416974907504;2218.179273668745;2252.763459836718;2303.1574740207852;2321.570509455756;2337.3104934044413;2339.9766002340016;2340.216027630746;2347.94130146746;2252.966205506919;2294.8623082615095;2295.0819672131115;2300.5398920216026;2302.7466978632337;1977.3375919067057;2273.874936878471;2328.8136949044206;2330.5921463743775;2338.240071976614;2230.9107635694554;2245.438640339915;2246.0791075658904;2246.1689175005354;2276.8747718875456;8463.788405289855;8549.743507694779;8564.528950907697;8579.142085791433;8586.441881277697;5049.64652474327;5179.766910488999;5181.922271165936;5190.429052804188;5217.817376391846;3322.700956913865;3340.3987282289177;3395.066356751888;3400.387930172568;3430.4168291390524;1056.3978532236629;1066.695991642386;1067.2742535076145;1073.693997210799;1102.939338336391;11865.40672966357;11875.584354547636;11877.22798018126;11884.168108232427;11895.821562676567;4440.977795111004;4470.463544374696;4596.333531637893;4639.257718765049;4641.791119399635;10017.749556261151;10092.091711745832;10103.444310562989;10111.191104711605;10113.848292275621;4530.29780384041;5113.642045056885;5128.1282182029145;5132.358455193101;5145.434002259748;4488.618467430305;4587.082583483317;4589.65577581676;4595.126925884071;4622.306654001926;3850.6534411903062;3883.786391748481;3946.881593552198;3963.7027222958395;3998.100427403811;1240.3612139748036;1245.9688507787196;1260.2312589320507;1295.5465587044648;1316.493150137185;932.9486878221627;952.3238500664468;966.3332300712626;969.8642190093393;988.1501908358806;5558.166275058693;5587.1339942309005;5617.691026993472;5669.036263835158;5788.392218817048;417.8725488725907;427.8395601649381;429.1652735429622;432.2932006169872;438.2330920888445;3962.841486340514;3978.8806335809973;4066.9389959150635;4112.074783173762;4333.804978775963;9982.201423886072;10422.635207767844;10489.632862849763;10527.894721052844;10594.629187978539;10348.482575871176;10464.790704185874;10470.842937355794;10480.056794888496;10486.213533984981;7716.2669546393;7947.960260198662;7992.3606111510935;8014.438989270695;8132.9186708132165;5737.91393129095;5824.097264923944;5882.441168089024;5958.6424814511265;6017.699115044143;9771.511424428892;9821.508924553887;9852.605895764089;9862.358946668444;9967.40195588267;9556.95221523888;9952.800943981225;10159.136473399843;10169.796604068026;10295.588176472857;7204.0994875640545;8027.879581806161;8211.21993410625;8310.418270721233;8483.533405662747;8222.17778222173;8288.58557072132;8320.459170153921;8350.540720260202;8363.247307742333;7657.119431265476;7875.724349647735;7896.09194942566;7984.8802267967185;8036.517808931483;7725.5364678119495;7790.5325680459355;7811.296983271305;7895.171007044408;7897;7115.964420177866;7153.749618763319;7176.7488137914925;7184.9640751795905;7189.245129261352;4961.479044700399;5126.026055049678;5230.607704422107;5232.215167724872;5370.3287089113865;5218.086834803818;5267.762950667306;5319.47083070851;5359.169328754049;5521.972390138184 20:22:15 INFO - PROCESS | 16915 | |4;prototype.html;316.4588553573391;323.1291668952174;325.9771815972882;327.6903326356594;333.1969952414678;5663.801766938158;5698.373178950312;5722.685252311121;5725.4847063764255;5728.484436400723;5283.577313814895;5376.4085950545505;5568.777248910039;5611.615063597975;5650;4278.37963495293;4290.099079193373;4293.677974151936;4318.632916202118;4326.935095973563;4294.763787991659;4296.634786043174;4296.763677997709;4305.354196870463;4323.740575565461;4014.1971605678837;4104.445899803533;4289.892752681177;4293.742375457467;4298.935515967263;4238.046439551107;4250.213710463574;4276.465441819772;4286.507051689049;4292.205941900743;3754.511913451234;3763.5295588051495;3767.5290588676417;3779.281936432069;3794.810259487042;5256.26412302278;5337.332833395825;5365;5385.946140538584;5386.865328366783;4889.29105279736;4894.877628059327;4906.803727850882;4929.383827021622;4930.876728081791;5771.394003629601;5783.971080144573;5795;5801.361850196475;5810.477057064884;3982;4152.563980782004;4157.459530261077;4166.83332666693;4166.8749937501925;6046.820869930365;6077.176846945943;6084.30030546484;6092.72582733778;6096.207493025922;4250.23495770758;4264.253755592759;4264.486107431879;4269.658427325807;4273.273543497613;4223.324268117087;4232.090100628379;4305.6749355347765;4317.805698743564;4322.5677432256525;4883.536064073907;4885.60915126789;4893.510648935078;4922.950770492249;4929.827456039093;5842;5853.707314634251;5856.6486010838635;5863.179154918314;5893.823185304448;1391.3808355282006;1425.102185623051;1470.919099449519;1495.4167874528941;1500.8048953635957;1020.4285600063988;1022.9335093218917;1024.7386916336286;1048.6591857646295;1060.984085238722;5615.2700148981185;5657.236273103161;5661.943380566224;5663.159473171236;5665.3768085510565;5967.343592204854;5971.164037034819;5987.221661184105;5997.430244126801;5998.340182579913;5438.5377242934;5656.886862262814;5666.291713535808;5728.283964504437;5753.1370294456165;3247.5128730690585;3256.918577035593;3269.1990462336403;3272.7727102336626;3278.4098862204555;6262.467690246289;6356.332585078592;6358.33237510064;6366.299707032223;6407.167068281094;6260.655663938527;6273.1844860167885;6293.402126797947;6300.936990630126;6301.873962520724;6356.45970092538;6371.585846919936;6380.808575742735;6387.968060159669;6404.391582799627;5888.411158884077;6066.696665166813;6092.543059270483;6093.166677494986;6101.481374083252;6017.669028203491;6019.367966363644;6024.487918526975;6027.547933905063;6038.5169186465855;5952.702364881825;6327.303996560283;6346.524010699309;6382.042693595998;6389.63583474099;4163.604457576525;4174.499060112806;4190.539040705581;4192.392103144966;4200.075983283673;5851.385604511465;6149.72326245329;6153.046277826944;6155.72299246526;6164.167837341902;5572.91640625399;5893.764249429974;5902.321233058082;5943;5944.494717949023;5876.294844618673;5892.911606325994;5909.940900590939;5935.703214839327;5935.732892019956;5579.386267510652;5848.327442344185;5853.473187412983;5871.823845284648;5899.144624029577;5938.73275702603;5969.462748352669;5994.730237139252;6017.638941663514;6034.426729460694;5826.184334193132;5843.766249349978;5872.265966754156;5881.852953676193;5883.117532370179 20:22:15 INFO - PROCESS | 16915 | |5;yui.html;759.4493991855906;774.9305957778267;834.7860736165762;848.7793173774817;869.1612593846936;14102.788458173136;14401.13593184407;14411;14429.494967676133;14469;12977.740445191113;13007.544735934243;13020.153690010166;13056.738865222713;13072.673183170426;792.7661339904728;823.6993497373476;824.1552408780988;824.7484517222244;825.3067423364373;681.2642346266045;791.5448617045193;798.0981490915258;809.4212637963855;809.8987626546682;851.2891735400948;851.8381507513584;855.1875718067861;857.939944203906;858.6050416808245;848.0671261612208;848.0713618587637;848.9108643592426;849.0193826130798;850.3537311643196;523.9738013099368;602.286290745468;620.6369273974685;622.0265284829228;623.0467384901063;14293.499727509592;14297.71404571913;14306.785398219035;14359.066660667024;14383.640408989859;12419;12565.811512827315;12823.679408014781;12923.356045237675;12952.611421657366;10567.841482377771;10593;10616.893831061669;10631;10878;3764.604716504782;3818.3890577507464;3849.345611246095;3876.8643097491454;3890.8054597270025;56572.43427565713;56973.145402818576;57450.42549574492;57558.7122064387;57650.423495764924;10074.848877266846;10364.844527332096;10398.844017339747;10470.319429237075;10478.895211047944;18846.811531884505;18944.81055189458;18947;19576.119074641676;19709.211631534865;8116.8782468263025;8144.958202327482;8209.425340226127;8399.748007559783;8627.007894092134;4336.479622445327;4524.23088075028;4532.0482698632995;4629.8842528936375;4630.907381852344;3255.886043988449;3357.2949680566867;3370.8820191293676;3372.898813035613;3372.9494057589154;614.7295190116334;621.273110460762;623.037407205868;628.745358129958;630.5964182922933;592.2981267198384;644.7324360390386;683.5625199872086;756.8107973006748;763.94270429718;8877.378583499221;9159;9333.160015598629;9398.357800447873;9689.41863488193;650.677914432359;697.2713514377386;727.6470911607865;745.407401116114;780.3172224303735;4253.659707223414;4269;4319.892002699958;4410.933835992462;4430.800613972379;59167.70416147892;59905.70047149823;60314.39685603176;60604.393956060754;62374.37625623777;48381;50910.74544627253;51042.48957510378;51210.74394628003;51953;45501.54498455039;46140;46769;46883.5311646886;48222.9999999993;8797.164269394398;9021.548922553977;9202.125798049176;9328.673496427593;9453.858192127262;31246;31741;31999.68000319967;32150.678493214768;32411.51382729308;41768;44466.55533444624;44616.55383446254;45104;45188.09623807571;11748.353840538852;11887;12029.518819247132;12068.517259309529;12355.011599071873;12047.578334758242;12947.352632368156;13133;13260.734785304046;13427.731445370842;12609.117361784587;12693.301868397326;12712.491500340253;13352.532661356807;13528;12534.811977820522;12650.493980241055;12938.159019663692;12966.481340746264;13856.113398796055;12004.579839705568;12218.0225581955;12457.314847683465;12478;13017.609471715863;10511.632092876713;10521.263511554424;10585.100266477435;10632.681019569425;10656.094231990057;10546.78906421852;10728.409937453203;10947.452627368759;10958.671239862817;11007.669769906915 20:22:15 INFO - PROCESS | 16915 | __end_tp_report 20:22:15 INFO - PROCESS | 16915 | __start_cc_report 20:22:15 INFO - PROCESS | 16915 | _x_x_mozilla_cycle_collect,800 20:22:15 INFO - PROCESS | 16915 | __end_cc_report 20:22:15 INFO - PROCESS | 16915 | __startTimestamp1461036135068__endTimestamp 20:22:15 INFO - PROCESS | 16915 | 20:22:15 INFO - PROCESS | 16915 | ------- Summary: start ------- 20:22:15 INFO - PROCESS | 16915 | Number of tests: 6 20:22:15 INFO - PROCESS | 16915 | 20:22:15 INFO - PROCESS | 16915 | [#0] dojo.html Cycles:165 Average:5205.54 Median:5392.08 stddev:582.30 (10.8%) stddev-sans-first:558.18 20:22:15 INFO - PROCESS | 16915 | Values: 3015.8 3041.1 3090.3 3093.6 3122.4 5139.2 5161.2 5233.7 5234.8 5240.6 5254.7 5311.3 5328.4 5333.5 5366.0 4658.3 4708.7 4767.5 4814.7 4837.5 4643.3 4796.6 4819.6 4848.5 4855.9 4697.3 4704.8 4846.1 4853.0 4865.9 4746.6 4747.9 4748.5 4752.5 4799.7 4717.2 4720.7 4723.5 4724.1 4730.3 5080.1 5191.1 5276.6 5294.2 5294.3 5579.7 5579.7 5581.4 5583.1 5585.6 5584.5 5595.7 5597.2 5617.2 5617.9 5141.2 5269.7 5346.3 5385.8 5394.7 5733.9 5756.5 5756.6 5762.8 5808.2 5392.1 5526.0 5537.1 5538.3 5545.7 5564.1 5619.9 5629.5 5636.7 5668.5 5537.2 5587.1 5590.2 5591.5 5593.2 5363.4 5552.1 5589.5 5595.2 5602.3 4276.9 4279.5 4290.7 4305.1 4307.4 3813.3 3814.6 3835.6 3861.8 3879.8 5099.1 5114.7 5303.6 5417.9 5438.2 5635.7 5659.4 5662.5 5695.7 5713.0 5356.9 5366.4 5367.3 5367.6 5369.5 4731.9 4782.3 4869.1 4873.5 4904.0 5760.5 5770.3 5771.8 5778.3 5806.9 5558.5 5563.0 5563.9 5571.4 5572.4 5600.7 5751.7 5764.4 5816.7 5851.5 5470.4 5470.6 5474.5 5480.4 5487.9 5524.9 5566.0 5566.3 5576.2 5576.7 5339.7 5435.2 5492.8 5515.3 5536.6 5446.6 5448.6 5449.3 5452.9 5460.7 5260.9 5374.4 5379.4 5379.7 5425.1 5497.9 5538.5 5553.9 5583.0 5601.9 5360.2 5363.4 5370.1 5371.6 5419.3 20:22:15 INFO - PROCESS | 16915 | 20:22:15 INFO - PROCESS | 16915 | [#1] ext.html Cycles:180 Average:48285.88 Median:39777.50 stddev:87525.58 (220.0%) stddev-sans-first:87697.89 20:22:15 INFO - PROCESS | 16915 | Values: 603.1 634.6 641.2 652.0 656.8 29956.7 30706.7 36955.4 37617.6 37657.2 39716.6 40120.6 40289.2 40439.0 40472.6 8543.8 8726.1 8735.8 8740.4 8741.3 8611.0 8744.6 8746.9 8748.2 8751.2 8721.1 8822.6 9009.2 9014.5 9015.7 8864.5 8921.9 8948.2 8952.3 8960.5 8768.4 8890.6 8892.8 8893.6 8896.2 39838.4 40088.8 40330.2 40384.4 40404.6 3268.2 3469.6 3517.8 3580.5 3799.4 29942.9 30981.4 31120.5 31467.1 31692.0 4053.4 4124.4 4250.1 4261.1 4263.0 287450.0 288748.0 289067.0 289193.0 291495.0 34488.3 35273.1 53534.7 53694.5 53705.7 33523.5 33543.2 33606.0 33637.2 33646.8 13552.9 13610.9 13631.2 13690.0 13800.8 11761.4 11837.9 11838.9 11843.3 11846.4 8343.8 8365.6 8398.2 8423.8 8468.6 3286.2 3319.6 3356.1 3359.3 3385.2 1064.6 1085.4 1150.7 1150.8 1153.4 31248.0 31762.5 32035.8 32084.7 32496.8 1149.1 1152.5 1164.5 1221.1 1243.3 16752.7 17141.4 17176.8 17203.0 17219.2 417944.0 419220.0 420005.0 420505.0 421515.0 54215.5 56087.4 56173.4 56255.0 56314.0 1259.7 1315.3 1388.0 1389.5 1429.4 27755.3 30869.4 31302.2 31749.7 32058.0 43651.8 44288.3 44501.6 44586.0 44625.6 264392.0 267117.0 267149.0 267153.0 267679.0 22927.4 25000.2 25050.5 26952.6 27384.2 40007.4 41338.0 41648.4 41681.0 41784.6 34646.1 42877.4 44175.3 44442.8 45341.3 38952.6 39536.6 39917.4 39992.4 40236.4 41621.6 42209.0 42276.6 43098.4 45518.5 41513.4 41667.8 42461.4 42566.0 42708.6 28505.4 29637.6 29852.6 29961.4 30072.2 20:22:15 INFO - PROCESS | 16915 | 20:22:15 INFO - PROCESS | 16915 | [#2] jquery.html Cycles:180 Average:28434.60 Median:21704.17 stddev:84546.46 (389.5%) stddev-sans-first:84757.42 20:22:15 INFO - PROCESS | 16915 | Values: 393.6 394.2 396.6 401.9 403.5 14643.0 15561.5 16610.3 17483.0 17517.5 17423.9 17432.0 18093.8 18095.2 18399.6 5430.2 5560.9 5586.2 5600.1 5616.6 3948.9 5514.4 5570.5 5836.8 6150.9 6088.1 6099.3 6100.2 6110.4 6143.6 5214.8 5500.7 5549.2 5553.0 6098.1 5350.0 5351.6 5364.0 5365.9 5369.6 11486.0 11709.2 11996.0 12077.7 12187.5 2099.8 2209.1 2209.2 2211.6 2304.4 9180.7 9691.5 9874.2 9903.1 10029.4 1856.3 1867.0 1965.9 1997.3 2030.3 67827.7 69344.3 70042.6 70399.6 70709.6 10215.4 10224.9 10332.5 10382.1 10601.3 14116.6 14116.9 14134.6 14283.7 14300.6 7811.4 7880.2 7918.0 8050.7 8059.3 7634.6 7702.7 7724.5 7825.6 7826.7 4528.2 4565.3 4568.1 4668.7 4736.4 1873.4 1933.7 1939.5 1991.1 2018.6 962.3 963.2 972.2 972.7 1040.7 16829.8 17619.0 17750.6 18135.7 18512.5 997.3 1010.3 1047.3 1068.2 1097.6 9676.3 9987.5 10120.8 10131.9 10291.1 500753.0 505569.0 506700.0 508637.0 545521.0 89543.6 94517.1 94937.0 97069.0 97252.0 1092.2 1105.2 1120.5 1157.7 1164.8 16152.9 16155.8 16316.3 16415.0 16421.4 28184.6 37459.8 38456.6 38858.6 39459.4 52609.7 55818.0 56024.2 56074.0 56079.0 7060.9 8110.5 8199.5 8307.5 8501.0 9313.3 11944.6 12679.9 12920.4 12945.0 6145.5 8284.5 10977.8 11196.5 11506.4 11131.9 11304.9 11416.1 11735.8 12029.3 11127.8 11353.5 11891.2 12328.1 12595.2 8333.8 8377.2 8384.7 8418.4 8503.5 6201.0 9608.0 11118.7 11919.5 12044.8 20:22:15 INFO - PROCESS | 16915 | 20:22:15 INFO - PROCESS | 16915 | [#3] mootools.html Cycles:180 Average:5678.46 Median:4630.78 stddev:3222.54 (69.6%) stddev-sans-first:3214.85 20:22:15 INFO - PROCESS | 16915 | Values: 1308.6 1464.9 1484.9 1642.0 1815.0 8076.6 8380.5 8392.4 8396.8 8402.8 8182.0 8315.7 8318.0 8325.2 8328.5 2002.8 2194.3 2218.2 2252.8 2303.2 2321.6 2337.3 2340.0 2340.2 2347.9 2253.0 2294.9 2295.1 2300.5 2302.7 1977.3 2273.9 2328.8 2330.6 2338.2 2230.9 2245.4 2246.1 2246.2 2276.9 8463.8 8549.7 8564.5 8579.1 8586.4 5049.6 5179.8 5181.9 5190.4 5217.8 3322.7 3340.4 3395.1 3400.4 3430.4 1056.4 1066.7 1067.3 1073.7 1102.9 11865.4 11875.6 11877.2 11884.2 11895.8 4441.0 4470.5 4596.3 4639.3 4641.8 10017.7 10092.1 10103.4 10111.2 10113.8 4530.3 5113.6 5128.1 5132.4 5145.4 4488.6 4587.1 4589.7 4595.1 4622.3 3850.7 3883.8 3946.9 3963.7 3998.1 1240.4 1246.0 1260.2 1295.5 1316.5 932.9 952.3 966.3 969.9 988.2 5558.2 5587.1 5617.7 5669.0 5788.4 417.9 427.8 429.2 432.3 438.2 3962.8 3978.9 4066.9 4112.1 4333.8 9982.2 10422.6 10489.6 10527.9 10594.6 10348.5 10464.8 10470.8 10480.1 10486.2 7716.3 7948.0 7992.4 8014.4 8132.9 5737.9 5824.1 5882.4 5958.6 6017.7 9771.5 9821.5 9852.6 9862.4 9967.4 9557.0 9952.8 10159.1 10169.8 10295.6 7204.1 8027.9 8211.2 8310.4 8483.5 8222.2 8288.6 8320.5 8350.5 8363.2 7657.1 7875.7 7896.1 7984.9 8036.5 7725.5 7790.5 7811.3 7895.2 7897.0 7116.0 7153.7 7176.7 7185.0 7189.2 4961.5 5126.0 5230.6 5232.2 5370.3 5218.1 5267.8 5319.5 5359.2 5522.0 20:22:15 INFO - PROCESS | 16915 | 20:22:15 INFO - PROCESS | 16915 | [#4] prototype.html Cycles:180 Average:4946.01 Median:5659.59 stddev:1484.23 (26.2%) stddev-sans-first:1447.15 20:22:15 INFO - PROCESS | 16915 | Values: 316.5 323.1 326.0 327.7 333.2 5663.8 5698.4 5722.7 5725.5 5728.5 5283.6 5376.4 5568.8 5611.6 5650.0 4278.4 4290.1 4293.7 4318.6 4326.9 4294.8 4296.6 4296.8 4305.4 4323.7 4014.2 4104.4 4289.9 4293.7 4298.9 4238.0 4250.2 4276.5 4286.5 4292.2 3754.5 3763.5 3767.5 3779.3 3794.8 5256.3 5337.3 5365.0 5385.9 5386.9 4889.3 4894.9 4906.8 4929.4 4930.9 5771.4 5784.0 5795.0 5801.4 5810.5 3982.0 4152.6 4157.5 4166.8 4166.9 6046.8 6077.2 6084.3 6092.7 6096.2 4250.2 4264.3 4264.5 4269.7 4273.3 4223.3 4232.1 4305.7 4317.8 4322.6 4883.5 4885.6 4893.5 4923.0 4929.8 5842.0 5853.7 5856.6 5863.2 5893.8 1391.4 1425.1 1470.9 1495.4 1500.8 1020.4 1022.9 1024.7 1048.7 1061.0 5615.3 5657.2 5661.9 5663.2 5665.4 5967.3 5971.2 5987.2 5997.4 5998.3 5438.5 5656.9 5666.3 5728.3 5753.1 3247.5 3256.9 3269.2 3272.8 3278.4 6262.5 6356.3 6358.3 6366.3 6407.2 6260.7 6273.2 6293.4 6300.9 6301.9 6356.5 6371.6 6380.8 6388.0 6404.4 5888.4 6066.7 6092.5 6093.2 6101.5 6017.7 6019.4 6024.5 6027.5 6038.5 5952.7 6327.3 6346.5 6382.0 6389.6 4163.6 4174.5 4190.5 4192.4 4200.1 5851.4 6149.7 6153.0 6155.7 6164.2 5572.9 5893.8 5902.3 5943.0 5944.5 5876.3 5892.9 5909.9 5935.7 5935.7 5579.4 5848.3 5853.5 5871.8 5899.1 5938.7 5969.5 5994.7 6017.6 6034.4 5826.2 5843.8 5872.3 5881.9 5883.1 20:22:15 INFO - PROCESS | 16915 | 20:22:15 INFO - PROCESS | 16915 | [#5] yui.html Cycles:180 Average:14452.42 Median:4420.87 stddev:16564.76 (374.7%) stddev-sans-first:16579.32 20:22:15 INFO - PROCESS | 16915 | Values: 759.4 774.9 834.8 848.8 869.2 14102.8 14401.1 14411.0 14429.5 14469.0 12977.7 13007.5 13020.2 13056.7 13072.7 792.8 823.7 824.2 824.7 825.3 681.3 791.5 798.1 809.4 809.9 851.3 851.8 855.2 857.9 858.6 848.1 848.1 848.9 849.0 850.4 524.0 602.3 620.6 622.0 623.0 14293.5 14297.7 14306.8 14359.1 14383.6 12419.0 12565.8 12823.7 12923.4 12952.6 10567.8 10593.0 10616.9 10631.0 10878.0 3764.6 3818.4 3849.3 3876.9 3890.8 56572.4 56973.1 57450.4 57558.7 57650.4 10074.8 10364.8 10398.8 10470.3 10478.9 18846.8 18944.8 18947.0 19576.1 19709.2 8116.9 8145.0 8209.4 8399.7 8627.0 4336.5 4524.2 4532.0 4629.9 4630.9 3255.9 3357.3 3370.9 3372.9 3372.9 614.7 621.3 623.0 628.7 630.6 592.3 644.7 683.6 756.8 763.9 8877.4 9159.0 9333.2 9398.4 9689.4 650.7 697.3 727.6 745.4 780.3 4253.7 4269.0 4319.9 4410.9 4430.8 59167.7 59905.7 60314.4 60604.4 62374.4 48381.0 50910.7 51042.5 51210.7 51953.0 45501.5 46140.0 46769.0 46883.5 48223.0 8797.2 9021.5 9202.1 9328.7 9453.9 31246.0 31741.0 31999.7 32150.7 32411.5 41768.0 44466.6 44616.6 45104.0 45188.1 11748.4 11887.0 12029.5 12068.5 12355.0 12047.6 12947.4 13133.0 13260.7 13427.7 12609.1 12693.3 12712.5 13352.5 13528.0 12534.8 12650.5 12938.2 12966.5 13856.1 12004.6 12218.0 12457.3 12478.0 13017.6 10511.6 10521.3 10585.1 10632.7 10656.1 10546.8 10728.4 10947.5 10958.7 11007.7 20:22:15 INFO - PROCESS | 16915 | -------- Summary: end -------- 20:22:15 INFO - PROCESS | 16915 | 20:22:15 INFO - TEST-INFO | 16915: exit 0 20:22:15 INFO - TEST-OK | dromaeo_css | took 1111134ms 20:22:15 INFO - TEST-START | kraken 20:22:15 INFO - operating with platform_type : linux_ 20:22:15 INFO - Initialising browser for kraken test... 20:22:15 INFO - TEST-INFO | started process 17096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpay6SV_/profile http://localhost:39844/getInfo.html) 20:22:19 INFO - PROCESS | 17096 | __metrics Screen width/height:1600/1200 20:22:19 INFO - PROCESS | 17096 | colorDepth:24 20:22:19 INFO - PROCESS | 17096 | Browser inner width/height: 1024/697 20:22:19 INFO - PROCESS | 17096 | __metrics 20:22:20 ERROR - PROCESS | 17096 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:22:21 INFO - TEST-INFO | 17096: exit 0 20:22:21 INFO - Browser initialized. 20:22:21 INFO - Running cycle 1/1 for kraken test... 20:22:21 INFO - TEST-INFO | started process 17176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpay6SV_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:22:33 INFO - PROCESS | 17176 | RSS: Main: 152915968 20:22:33 INFO - PROCESS | 17176 | 20:22:36 INFO - PROCESS | 17176 | Cycle 1(1): loaded http://localhost:39844/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39844/tests/kraken/driver.html?testName=audio-beat-detection) 20:22:36 INFO - PROCESS | 17176 | RSS: Main: 207708160 20:22:36 INFO - PROCESS | 17176 | 20:22:39 INFO - PROCESS | 17176 | Cycle 1(1): loaded http://localhost:39844/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39844/tests/kraken/driver.html?testName=audio-dft) 20:22:40 INFO - PROCESS | 17176 | RSS: Main: 193884160 20:22:40 INFO - PROCESS | 17176 | 20:22:43 INFO - PROCESS | 17176 | Cycle 1(1): loaded http://localhost:39844/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39844/tests/kraken/driver.html?testName=audio-fft) 20:22:43 INFO - PROCESS | 17176 | RSS: Main: 264560640 20:22:43 INFO - PROCESS | 17176 | 20:22:45 INFO - PROCESS | 17176 | Cycle 1(1): loaded http://localhost:39844/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39844/tests/kraken/driver.html?testName=audio-oscillator) 20:22:46 INFO - PROCESS | 17176 | RSS: Main: 171843584 20:22:46 INFO - PROCESS | 17176 | 20:22:48 INFO - PROCESS | 17176 | Cycle 1(1): loaded http://localhost:39844/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39844/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:22:49 INFO - PROCESS | 17176 | RSS: Main: 176926720 20:22:49 INFO - PROCESS | 17176 | 20:22:52 INFO - PROCESS | 17176 | Cycle 1(1): loaded http://localhost:39844/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39844/tests/kraken/driver.html?testName=imaging-darkroom) 20:22:52 INFO - PROCESS | 17176 | RSS: Main: 212901888 20:22:52 INFO - PROCESS | 17176 | 20:22:56 INFO - PROCESS | 17176 | Cycle 1(1): loaded http://localhost:39844/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39844/tests/kraken/driver.html?testName=imaging-desaturate) 20:22:56 INFO - PROCESS | 17176 | RSS: Main: 213245952 20:22:56 INFO - PROCESS | 17176 | 20:22:59 INFO - PROCESS | 17176 | Cycle 1(1): loaded http://localhost:39844/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39844/tests/kraken/driver.html?testName=json-parse-financial) 20:23:00 INFO - PROCESS | 17176 | RSS: Main: 214196224 20:23:00 INFO - PROCESS | 17176 | 20:23:01 INFO - PROCESS | 17176 | Cycle 1(1): loaded http://localhost:39844/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39844/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:23:02 INFO - PROCESS | 17176 | RSS: Main: 200261632 20:23:02 INFO - PROCESS | 17176 | 20:23:04 INFO - PROCESS | 17176 | Cycle 1(1): loaded http://localhost:39844/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39844/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:23:04 INFO - PROCESS | 17176 | RSS: Main: 201441280 20:23:04 INFO - PROCESS | 17176 | 20:23:06 INFO - PROCESS | 17176 | Cycle 1(1): loaded http://localhost:39844/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39844/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:23:07 INFO - PROCESS | 17176 | RSS: Main: 218066944 20:23:07 INFO - PROCESS | 17176 | 20:23:10 INFO - PROCESS | 17176 | Cycle 1(1): loaded http://localhost:39844/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39844/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:23:10 INFO - PROCESS | 17176 | RSS: Main: 222318592 20:23:10 INFO - PROCESS | 17176 | 20:23:13 INFO - PROCESS | 17176 | Cycle 1(1): loaded http://localhost:39844/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39844/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:23:14 INFO - PROCESS | 17176 | RSS: Main: 218796032 20:23:14 INFO - PROCESS | 17176 | 20:23:15 INFO - PROCESS | 17176 | Cycle 1(1): loaded http://localhost:39844/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39844/tests/kraken/driver.html?testName=ai-astar) 20:23:15 INFO - PROCESS | 17176 | RSS: Main: 282460160 20:23:15 INFO - PROCESS | 17176 | 20:23:15 INFO - PROCESS | 17176 | __start_tp_report 20:23:15 INFO - PROCESS | 17176 | _x_x_mozilla_page_load 20:23:15 INFO - PROCESS | 17176 | _x_x_mozilla_page_load_details 20:23:15 INFO - PROCESS | 17176 | |i|pagename|runs| 20:23:15 INFO - PROCESS | 17176 | |0;ai-astar;113;113;105;110;111;112;99;110;110;110 20:23:15 INFO - PROCESS | 17176 | |1;audio-beat-detection;154;129;152;180;146;154;154;128;185;134 20:23:15 INFO - PROCESS | 17176 | |2;audio-dft;164;163;162;160;161;163;162;161;161;161 20:23:15 INFO - PROCESS | 17176 | |3;audio-fft;77;77;114;106;72;73;74;132;101;76 20:23:15 INFO - PROCESS | 17176 | |4;audio-oscillator;93;93;145;93;93;92;143;93;93;147 20:23:15 INFO - PROCESS | 17176 | |5;imaging-gaussian-blur;117;117;116;117;118;116;117;117;116;117 20:23:15 INFO - PROCESS | 17176 | |6;imaging-darkroom;146;145;146;146;146;145;145;146;146;146 20:23:15 INFO - PROCESS | 17176 | |7;imaging-desaturate;95;94;95;94;95;95;94;95;94;95 20:23:15 INFO - PROCESS | 17176 | |8;json-parse-financial;57;58;57;57;58;59;57;72;56;55 20:23:15 INFO - PROCESS | 17176 | |9;json-stringify-tinderbox;61;61;61;60;62;60;63;61;61;62 20:23:15 INFO - PROCESS | 17176 | |10;stanford-crypto-aes;77;76;76;77;84;77;76;78;77;78 20:23:15 INFO - PROCESS | 17176 | |11;stanford-crypto-ccm;125;134;122;133;152;126;132;123;166;129 20:23:15 INFO - PROCESS | 17176 | |12;stanford-crypto-pbkdf2;172;164;173;165;170;173;170;164;172;166 20:23:15 INFO - PROCESS | 17176 | |13;stanford-crypto-sha256-iterative;69;69;69;79;68;67;69;66;68;67 20:23:15 INFO - PROCESS | 17176 | __end_tp_report 20:23:15 INFO - PROCESS | 17176 | __start_cc_report 20:23:15 INFO - PROCESS | 17176 | _x_x_mozilla_cycle_collect,1635 20:23:15 INFO - PROCESS | 17176 | __end_cc_report 20:23:15 INFO - PROCESS | 17176 | __startTimestamp1461036195980__endTimestamp 20:23:15 INFO - PROCESS | 17176 | 20:23:15 INFO - PROCESS | 17176 | ------- Summary: start ------- 20:23:15 INFO - PROCESS | 17176 | Number of tests: 14 20:23:15 INFO - PROCESS | 17176 | 20:23:15 INFO - PROCESS | 17176 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.50 stddev:4.27 (3.8%) stddev-sans-first:4.31 20:23:15 INFO - PROCESS | 17176 | Values: 113.0 113.0 105.0 110.0 111.0 112.0 99.0 110.0 110.0 110.0 20:23:15 INFO - PROCESS | 17176 | 20:23:15 INFO - PROCESS | 17176 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:154.00 stddev:19.29 (12.5%) stddev-sans-first:20.44 20:23:15 INFO - PROCESS | 17176 | Values: 154.0 129.0 152.0 180.0 146.0 154.0 154.0 128.0 185.0 134.0 20:23:15 INFO - PROCESS | 17176 | 20:23:15 INFO - PROCESS | 17176 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.01 20:23:15 INFO - PROCESS | 17176 | Values: 164.0 163.0 162.0 160.0 161.0 163.0 162.0 161.0 161.0 161.0 20:23:15 INFO - PROCESS | 17176 | 20:23:15 INFO - PROCESS | 17176 | [#3] audio-fft Cycles:10 Average:90.20 Median:73.50 stddev:21.39 (29.1%) stddev-sans-first:22.15 20:23:15 INFO - PROCESS | 17176 | Values: 77.0 77.0 114.0 106.0 72.0 73.0 74.0 132.0 101.0 76.0 20:23:15 INFO - PROCESS | 17176 | 20:23:15 INFO - PROCESS | 17176 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:93.00 stddev:25.21 (27.1%) stddev-sans-first:26.10 20:23:15 INFO - PROCESS | 17176 | Values: 93.0 93.0 145.0 93.0 93.0 92.0 143.0 93.0 93.0 147.0 20:23:15 INFO - PROCESS | 17176 | 20:23:15 INFO - PROCESS | 17176 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 20:23:15 INFO - PROCESS | 17176 | Values: 117.0 117.0 116.0 117.0 118.0 116.0 117.0 117.0 116.0 117.0 20:23:15 INFO - PROCESS | 17176 | 20:23:15 INFO - PROCESS | 17176 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 20:23:15 INFO - PROCESS | 17176 | Values: 146.0 145.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 146.0 20:23:15 INFO - PROCESS | 17176 | 20:23:15 INFO - PROCESS | 17176 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:23:15 INFO - PROCESS | 17176 | Values: 95.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 20:23:15 INFO - PROCESS | 17176 | 20:23:15 INFO - PROCESS | 17176 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:57.50 stddev:4.84 (8.4%) stddev-sans-first:5.09 20:23:15 INFO - PROCESS | 17176 | Values: 57.0 58.0 57.0 57.0 58.0 59.0 57.0 72.0 56.0 55.0 20:23:15 INFO - PROCESS | 17176 | 20:23:15 INFO - PROCESS | 17176 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 20:23:15 INFO - PROCESS | 17176 | Values: 61.0 61.0 61.0 60.0 62.0 60.0 63.0 61.0 61.0 62.0 20:23:15 INFO - PROCESS | 17176 | 20:23:15 INFO - PROCESS | 17176 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.00 stddev:2.37 (3.1%) stddev-sans-first:2.50 20:23:15 INFO - PROCESS | 17176 | Values: 77.0 76.0 76.0 77.0 84.0 77.0 76.0 78.0 77.0 78.0 20:23:15 INFO - PROCESS | 17176 | 20:23:15 INFO - PROCESS | 17176 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:132.50 stddev:14.09 (10.6%) stddev-sans-first:14.55 20:23:15 INFO - PROCESS | 17176 | Values: 125.0 134.0 122.0 133.0 152.0 126.0 132.0 123.0 166.0 129.0 20:23:15 INFO - PROCESS | 17176 | 20:23:15 INFO - PROCESS | 17176 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:171.00 stddev:3.75 (2.2%) stddev-sans-first:3.81 20:23:15 INFO - PROCESS | 17176 | Values: 172.0 164.0 173.0 165.0 170.0 173.0 170.0 164.0 172.0 166.0 20:23:15 INFO - PROCESS | 17176 | 20:23:15 INFO - PROCESS | 17176 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:3.63 (5.3%) stddev-sans-first:3.86 20:23:15 INFO - PROCESS | 17176 | Values: 69.0 69.0 69.0 79.0 68.0 67.0 69.0 66.0 68.0 67.0 20:23:15 INFO - PROCESS | 17176 | -------- Summary: end -------- 20:23:15 INFO - PROCESS | 17176 | 20:23:16 INFO - TEST-INFO | 17176: exit 0 20:23:16 INFO - TEST-OK | kraken | took 61161ms 20:23:16 INFO - SUITE-END | took 1172s 20:23:17 INFO - Completed test suite (00:19:32) 20:23:17 INFO - javascript benchmark 20:23:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3015.849207539623, 3041.0572722456027, 3090.320129571495, 3093.5669006339117, 3122.4067427188825, 5139.229115632647, 5161.200013997827, 5233.7121458319825, 5234.7644356003975, 5240.580753539717, 5254.710990895499, 5311.256424100629, 5328.387235467922, 5333.493318134781, 5366.0, 4658.301254811771, 4708.69393489423, 4767.499412561683, 4814.6870453420415, 4837.467878533358, 4643.326717625942, 4796.568308852203, 4819.638527110464, 4848.53938875808, 4855.878603034935, 4697.342372067913, 4704.764761761915, 4846.1034708578845, 4852.951470485285, 4865.854024379239, 4746.572808447257, 4747.8575642730775, 4748.5251474852585, 4752.453467851206, 4799.712017278975, 4717.198076327033, 4720.740359280238, 4723.504032076617, 4724.078804633098, 4730.290456431529, 5080.110980578421, 5191.0656081905245, 5276.630635855492, 5294.232336311214, 5294.285271488338, 5579.6652200867675, 5579.69311687857, 5581.441855814386, 5583.05088135018, 5585.553155747531, 5584.5253153482, 5595.664260144405, 5597.216389705444, 5617.185508101303, 5617.859553511195, 5141.177411614124, 5269.7365131743645, 5346.304980352529, 5385.78456861725, 5394.703291318976, 5733.913991290134, 5756.481916627524, 5756.597038207369, 5762.769489220468, 5808.215890854681, 5392.083345831218, 5525.972370138204, 5537.058700021006, 5538.252335934597, 5545.72271386429, 5564.10974244119, 5619.8595035124445, 5629.521490673339, 5636.746346414421, 5668.518175955008, 5537.197106419547, 5587.1339942309005, 5590.161475778585, 5591.4688104629995, 5593.188987596775, 5363.436839131913, 5552.11166213412, 5589.524890384281, 5595.21666966625, 5602.2717046783655, 4276.893077673083, 4279.465066866642, 4290.742555446684, 4305.138972205571, 4307.3754305626135, 3813.2564149990485, 3814.6185381461632, 3835.616438356142, 3861.787601681878, 3879.7866117363815, 5099.107656160157, 5114.693118412907, 5303.575713942875, 5417.918731219035, 5438.211459338374, 5635.746391412315, 5659.377468478464, 5662.490375866109, 5695.743691533891, 5712.971435142881, 5356.946430535645, 5366.356037275474, 5367.275417818622, 5367.597430192751, 5369.543588794996, 4731.905361892743, 4782.33047373361, 4869.14789911764, 4873.512648735169, 4903.975480122576, 5760.53915686744, 5770.336411312753, 5771.797987070432, 5778.306603207642, 5806.854828629233, 5558.499735023867, 5563.02647036775, 5563.916541251965, 5571.387147413781, 5572.442755724557, 5600.663960162403, 5751.683657398883, 5764.365919748908, 5816.651000939957, 5851.531877449879, 5470.425605311385, 5470.64440811346, 5474.534664553557, 5480.424555421623, 5487.890242195054, 5524.944750552443, 5566.0, 5566.276384070207, 5576.247206627054, 5576.7211639417055, 5339.733013349394, 5435.184722291688, 5492.780288788404, 5515.310586176728, 5536.584756143225, 5446.645968012067, 5448.618596698193, 5449.291592093003, 5452.91820622683, 5460.672359658433, 5260.86847828792, 5374.355077390738, 5379.381371142369, 5379.731013449234, 5425.104857698593, 5497.862553436036, 5538.47384498472, 5553.888922221614, 5583.0, 5601.887962240814, 5360.249565060816, 5363.41002489718, 5370.087085195604, 5371.5971302153275, 5419.3225846769155], "value": 5167.012171827099, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.0622382195684, 634.6287421858212, 641.2081079866364, 651.9674016299184, 656.8062421585635, 29956.70043299566, 30706.692933070663, 36955.44566831496, 37617.62382376175, 37657.246855062884, 39716.60283397165, 40120.598794012054, 40289.194216115735, 40439.0, 40472.59527404725, 8543.786405339884, 8726.127387261287, 8735.781605459882, 8740.388172827905, 8741.344399170088, 8610.956945215265, 8744.562771861414, 8746.912530874706, 8748.212660860521, 8751.168638979287, 8721.084286149959, 8822.64709411626, 9009.234215091725, 9014.504202268872, 9015.684451044215, 8864.512451815148, 8921.910780892173, 8948.194662480375, 8952.328575356874, 8960.507172105532, 8768.386212965095, 8890.555472226428, 8892.777680557972, 8893.555322233862, 8896.154865287852, 39838.402423963664, 40088.79955600233, 40330.193396131916, 40384.39423408651, 40404.59595404038, 3268.1829542614346, 3469.5663042119736, 3517.8416971236356, 3580.4629305604108, 3799.392097264452, 29942.85028574865, 30981.380372392425, 31120.487529308124, 31467.055988320386, 31692.0, 4053.4279266038543, 4124.422580838685, 4250.06498570314, 4261.062566235423, 4263.0, 287450.0, 288748.0, 289067.0, 289193.0, 291494.9999999979, 34488.310233795186, 35273.118172045906, 53534.7323263389, 53694.46305536895, 53705.73147134318, 33523.4971475428, 33543.16142096467, 33606.0, 33637.15907102342, 33646.831765841016, 13552.932235338958, 13610.931945340408, 13631.182129072287, 13690.041697081308, 13800.792988105186, 11761.353125578004, 11837.88162118385, 11838.88161118395, 11843.28940263587, 11846.407679615984, 8343.8331233375, 8365.623546940402, 8398.244158025685, 8423.831523369621, 8468.576571171418, 3286.1620286827183, 3319.618243901934, 3356.110630682871, 3359.2945481448683, 3385.2044769479153, 1064.5901327988624, 1085.3867564825848, 1150.7295785490403, 1150.7928572856965, 1153.3944679043568, 31248.0, 31762.523562146587, 32035.839820800746, 32084.679153208635, 32496.83751581227, 1149.1381463902073, 1152.464104191555, 1164.545827127421, 1221.096388672394, 1243.347242697591, 16752.664946701, 17141.400050998403, 17176.82823171752, 17203.0, 17219.22513486896, 417944.0, 419220.0, 420005.0, 420505.0, 421515.0, 54215.45784542183, 56087.43912560904, 56173.43826561764, 56255.0, 56314.0, 1259.6976725585794, 1315.283170671986, 1388.0422508469326, 1389.534505940501, 1429.3925081840177, 27755.306117347227, 30869.382612347177, 31302.217444563157, 31749.682503174674, 32058.0, 43651.781741091094, 44288.33567496554, 44501.554984449744, 44586.0, 44625.55374446344, 264392.0, 267117.0, 267149.0, 267153.0, 267679.0, 22927.395082344075, 25000.249992500256, 25050.498990019732, 26952.595711063957, 27384.178474645792, 40007.39988900227, 41338.0, 41648.3752743703, 41681.0, 41784.58215417928, 34646.13384665403, 42877.44953789892, 44175.33736993883, 44442.77778611086, 45341.31988020116, 38952.6104738949, 39536.60463395329, 39917.40123898202, 39992.40011399773, 40236.3964540538, 41621.58378416177, 42209.0, 42276.57723422726, 43098.353524696526, 45518.544814552755, 41513.37729934114, 41667.7916610415, 42461.36307955445, 42566.0, 42708.57291427046, 28505.42989140247, 29637.5554366689, 29852.552211717277, 29961.400771984874, 30072.24819379533], "value": 17956.70265994817, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.6398195650979, 394.24502078519635, 396.59349167103716, 401.9115794525204, 403.5117507815543, 14643.0, 15561.455349062786, 16610.25253863576, 17483.038432886202, 17517.474475765717, 17423.91288043561, 17432.0, 18093.81906180938, 18095.18571664275, 18399.632007359844, 5430.185472179165, 5560.86097847553, 5586.190002449643, 5600.0759874620635, 5616.550675945915, 3948.940765888514, 5514.393416724157, 5570.498655121039, 5836.795712150076, 6150.876982460348, 6088.056351265539, 6099.298580663236, 6100.23747031621, 6110.358412366704, 6143.631382117065, 5214.843554693365, 5500.724963751836, 5549.1676248562835, 5552.972235138839, 6098.08528720691, 5349.973250133725, 5351.598630102758, 5363.973180134113, 5365.946340536622, 5369.570434365241, 11486.0, 11709.238899471593, 11996.0, 12077.698057548543, 12187.512499500099, 2099.769025407204, 2209.0942713487393, 2209.193644319828, 2211.612967730641, 2304.43541332373, 9180.6786762463, 9691.515424228832, 9874.16069634082, 9903.05920937517, 10029.398236105857, 1856.303886042734, 1866.9719954200698, 1965.9017049147628, 1997.300944669354, 2030.3198428526462, 67827.66086169587, 69344.30655693429, 70042.64978675074, 70399.64800176017, 70709.64645176793, 10215.387076775418, 10224.903894701569, 10332.53503592325, 10382.065614094618, 10601.257911946244, 14116.647083822781, 14116.929415352857, 14134.64663383403, 14283.714325713636, 14300.570982870531, 7811.375089992787, 7880.172581878935, 7918.0, 8050.718224862102, 8059.314958228616, 7634.6182690865235, 7702.653380597886, 7724.459287849909, 7825.647845846951, 7826.726064587712, 4528.162289976365, 4565.33802598628, 4568.132054909556, 4668.743219122981, 4736.4316282046375, 1873.3911478769455, 1933.719610656447, 1939.4957311098933, 1991.084101313412, 2018.5559176981042, 962.3119469579284, 963.2438535749403, 972.1736523954582, 972.7130496503548, 1040.6669865643073, 16829.83170168307, 17619.0, 17750.644987100186, 18135.72796408055, 18512.537186570444, 997.2570435025807, 1010.3432768700403, 1047.3035431438161, 1068.1828401273033, 1097.5719469406938, 9676.322657414054, 9987.450690211963, 10120.797584048278, 10131.949340253252, 10291.125254353465, 500753.0, 505569.0, 506700.0, 508637.0, 545521.0, 89543.55228223818, 94517.05482945082, 94937.0, 97069.0, 97252.0, 1092.1972350322508, 1105.2318638546133, 1120.467777805536, 1157.7163594919298, 1164.7670465906851, 16152.919235403748, 16155.75766363482, 16316.347346106497, 16415.0, 16421.42525011619, 28184.577231341136, 37459.81270093632, 38456.615433845305, 38858.61141388663, 39459.40810887782, 52609.73695131653, 55818.0, 56024.15963760465, 56074.0, 56079.0, 7060.870260758254, 8110.513369197631, 8199.467034642728, 8307.501549907025, 8500.957495212484, 9313.25493960495, 11944.581939632071, 12679.93660031694, 12920.353982301036, 12945.029122815638, 6145.477634400947, 8284.46151000183, 10977.780444391226, 11196.496157673088, 11506.424678766196, 11131.944340278571, 11304.943475282571, 11416.086713063101, 11735.823962640738, 12029.338386388832, 11127.777444450903, 11353.48909299067, 11891.167618266983, 12328.07539434528, 12595.244285342542, 8333.791655208668, 8377.246047855722, 8384.748457546284, 8418.410711250399, 8503.532305723245, 6201.0, 9607.991160928003, 11118.722031949266, 11919.46362413676, 12044.819327710267], "value": 8692.865301490425, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.6139588821297, 1464.875485583725, 1484.8589384008521, 1641.958951026225, 1814.9818501814987, 8076.555789431579, 8380.539070351128, 8392.370572207086, 8396.790080247996, 8402.789930251747, 8182.0, 8315.708950186745, 8318.043425006126, 8325.167483251671, 8328.541930193836, 2002.7596688397414, 2194.3416974907504, 2218.179273668745, 2252.763459836718, 2303.1574740207852, 2321.570509455756, 2337.3104934044413, 2339.9766002340016, 2340.216027630746, 2347.94130146746, 2252.966205506919, 2294.8623082615095, 2295.0819672131115, 2300.5398920216026, 2302.7466978632337, 1977.3375919067057, 2273.874936878471, 2328.8136949044206, 2330.5921463743775, 2338.240071976614, 2230.9107635694554, 2245.438640339915, 2246.0791075658904, 2246.1689175005354, 2276.8747718875456, 8463.788405289855, 8549.743507694779, 8564.528950907697, 8579.142085791433, 8586.441881277697, 5049.64652474327, 5179.766910488999, 5181.922271165936, 5190.429052804188, 5217.817376391846, 3322.700956913865, 3340.3987282289177, 3395.066356751888, 3400.387930172568, 3430.4168291390524, 1056.3978532236629, 1066.695991642386, 1067.2742535076145, 1073.693997210799, 1102.939338336391, 11865.40672966357, 11875.584354547636, 11877.22798018126, 11884.168108232427, 11895.821562676567, 4440.977795111004, 4470.463544374696, 4596.333531637893, 4639.257718765049, 4641.791119399635, 10017.749556261151, 10092.091711745832, 10103.444310562989, 10111.191104711605, 10113.848292275621, 4530.29780384041, 5113.642045056885, 5128.1282182029145, 5132.358455193101, 5145.434002259748, 4488.618467430305, 4587.082583483317, 4589.65577581676, 4595.126925884071, 4622.306654001926, 3850.6534411903062, 3883.786391748481, 3946.881593552198, 3963.7027222958395, 3998.100427403811, 1240.3612139748036, 1245.9688507787196, 1260.2312589320507, 1295.5465587044648, 1316.493150137185, 932.9486878221627, 952.3238500664468, 966.3332300712626, 969.8642190093393, 988.1501908358806, 5558.166275058693, 5587.1339942309005, 5617.691026993472, 5669.036263835158, 5788.392218817048, 417.8725488725907, 427.8395601649381, 429.1652735429622, 432.2932006169872, 438.2330920888445, 3962.841486340514, 3978.8806335809973, 4066.9389959150635, 4112.074783173762, 4333.804978775963, 9982.201423886072, 10422.635207767844, 10489.632862849763, 10527.894721052844, 10594.629187978539, 10348.482575871176, 10464.790704185874, 10470.842937355794, 10480.056794888496, 10486.213533984981, 7716.2669546393, 7947.960260198662, 7992.3606111510935, 8014.438989270695, 8132.9186708132165, 5737.91393129095, 5824.097264923944, 5882.441168089024, 5958.6424814511265, 6017.699115044143, 9771.511424428892, 9821.508924553887, 9852.605895764089, 9862.358946668444, 9967.40195588267, 9556.95221523888, 9952.800943981225, 10159.136473399843, 10169.796604068026, 10295.588176472857, 7204.0994875640545, 8027.879581806161, 8211.21993410625, 8310.418270721233, 8483.533405662747, 8222.17778222173, 8288.58557072132, 8320.459170153921, 8350.540720260202, 8363.247307742333, 7657.119431265476, 7875.724349647735, 7896.09194942566, 7984.8802267967185, 8036.517808931483, 7725.5364678119495, 7790.5325680459355, 7811.296983271305, 7895.171007044408, 7897.0, 7115.964420177866, 7153.749618763319, 7176.7488137914925, 7184.9640751795905, 7189.245129261352, 4961.479044700399, 5126.026055049678, 5230.607704422107, 5232.215167724872, 5370.3287089113865, 5218.086834803818, 5267.762950667306, 5319.47083070851, 5359.169328754049, 5521.972390138184], "value": 4466.17626821258, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.4588553573391, 323.1291668952174, 325.9771815972882, 327.6903326356594, 333.1969952414678, 5663.801766938158, 5698.373178950312, 5722.685252311121, 5725.4847063764255, 5728.484436400723, 5283.577313814895, 5376.4085950545505, 5568.777248910039, 5611.615063597975, 5650.0, 4278.37963495293, 4290.099079193373, 4293.677974151936, 4318.632916202118, 4326.935095973563, 4294.763787991659, 4296.634786043174, 4296.763677997709, 4305.354196870463, 4323.740575565461, 4014.1971605678837, 4104.445899803533, 4289.892752681177, 4293.742375457467, 4298.935515967263, 4238.046439551107, 4250.213710463574, 4276.465441819772, 4286.507051689049, 4292.205941900743, 3754.511913451234, 3763.5295588051495, 3767.5290588676417, 3779.281936432069, 3794.810259487042, 5256.26412302278, 5337.332833395825, 5365.0, 5385.946140538584, 5386.865328366783, 4889.29105279736, 4894.877628059327, 4906.803727850882, 4929.383827021622, 4930.876728081791, 5771.394003629601, 5783.971080144573, 5795.0, 5801.361850196475, 5810.477057064884, 3982.0, 4152.563980782004, 4157.459530261077, 4166.83332666693, 4166.8749937501925, 6046.820869930365, 6077.176846945943, 6084.30030546484, 6092.72582733778, 6096.207493025922, 4250.23495770758, 4264.253755592759, 4264.486107431879, 4269.658427325807, 4273.273543497613, 4223.324268117087, 4232.090100628379, 4305.6749355347765, 4317.805698743564, 4322.5677432256525, 4883.536064073907, 4885.60915126789, 4893.510648935078, 4922.950770492249, 4929.827456039093, 5842.0, 5853.707314634251, 5856.6486010838635, 5863.179154918314, 5893.823185304448, 1391.3808355282006, 1425.102185623051, 1470.919099449519, 1495.4167874528941, 1500.8048953635957, 1020.4285600063988, 1022.9335093218917, 1024.7386916336286, 1048.6591857646295, 1060.984085238722, 5615.2700148981185, 5657.236273103161, 5661.943380566224, 5663.159473171236, 5665.3768085510565, 5967.343592204854, 5971.164037034819, 5987.221661184105, 5997.430244126801, 5998.340182579913, 5438.5377242934, 5656.886862262814, 5666.291713535808, 5728.283964504437, 5753.1370294456165, 3247.5128730690585, 3256.918577035593, 3269.1990462336403, 3272.7727102336626, 3278.4098862204555, 6262.467690246289, 6356.332585078592, 6358.33237510064, 6366.299707032223, 6407.167068281094, 6260.655663938527, 6273.1844860167885, 6293.402126797947, 6300.936990630126, 6301.873962520724, 6356.45970092538, 6371.585846919936, 6380.808575742735, 6387.968060159669, 6404.391582799627, 5888.411158884077, 6066.696665166813, 6092.543059270483, 6093.166677494986, 6101.481374083252, 6017.669028203491, 6019.367966363644, 6024.487918526975, 6027.547933905063, 6038.5169186465855, 5952.702364881825, 6327.303996560283, 6346.524010699309, 6382.042693595998, 6389.63583474099, 4163.604457576525, 4174.499060112806, 4190.539040705581, 4192.392103144966, 4200.075983283673, 5851.385604511465, 6149.72326245329, 6153.046277826944, 6155.72299246526, 6164.167837341902, 5572.91640625399, 5893.764249429974, 5902.321233058082, 5943.0, 5944.494717949023, 5876.294844618673, 5892.911606325994, 5909.940900590939, 5935.703214839327, 5935.732892019956, 5579.386267510652, 5848.327442344185, 5853.473187412983, 5871.823845284648, 5899.144624029577, 5938.73275702603, 5969.462748352669, 5994.730237139252, 6017.638941663514, 6034.426729460694, 5826.184334193132, 5843.766249349978, 5872.265966754156, 5881.852953676193, 5883.117532370179], "value": 4467.792879995089, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.4493991855906, 774.9305957778267, 834.7860736165762, 848.7793173774817, 869.1612593846936, 14102.788458173136, 14401.13593184407, 14411.0, 14429.494967676133, 14469.0, 12977.740445191113, 13007.544735934243, 13020.153690010166, 13056.738865222713, 13072.673183170426, 792.7661339904728, 823.6993497373476, 824.1552408780988, 824.7484517222244, 825.3067423364373, 681.2642346266045, 791.5448617045193, 798.0981490915258, 809.4212637963855, 809.8987626546682, 851.2891735400948, 851.8381507513584, 855.1875718067861, 857.939944203906, 858.6050416808245, 848.0671261612208, 848.0713618587637, 848.9108643592426, 849.0193826130798, 850.3537311643196, 523.9738013099368, 602.286290745468, 620.6369273974685, 622.0265284829228, 623.0467384901063, 14293.499727509592, 14297.71404571913, 14306.785398219035, 14359.066660667024, 14383.640408989859, 12419.0, 12565.811512827315, 12823.679408014781, 12923.356045237675, 12952.611421657366, 10567.841482377771, 10593.0, 10616.893831061669, 10631.0, 10878.0, 3764.604716504782, 3818.3890577507464, 3849.345611246095, 3876.8643097491454, 3890.8054597270025, 56572.43427565713, 56973.145402818576, 57450.42549574492, 57558.7122064387, 57650.423495764924, 10074.848877266846, 10364.844527332096, 10398.844017339747, 10470.319429237075, 10478.895211047944, 18846.811531884505, 18944.81055189458, 18947.0, 19576.119074641676, 19709.211631534865, 8116.8782468263025, 8144.958202327482, 8209.425340226127, 8399.748007559783, 8627.007894092134, 4336.479622445327, 4524.23088075028, 4532.0482698632995, 4629.8842528936375, 4630.907381852344, 3255.886043988449, 3357.2949680566867, 3370.8820191293676, 3372.898813035613, 3372.9494057589154, 614.7295190116334, 621.273110460762, 623.037407205868, 628.745358129958, 630.5964182922933, 592.2981267198384, 644.7324360390386, 683.5625199872086, 756.8107973006748, 763.94270429718, 8877.378583499221, 9159.0, 9333.160015598629, 9398.357800447873, 9689.41863488193, 650.677914432359, 697.2713514377386, 727.6470911607865, 745.407401116114, 780.3172224303735, 4253.659707223414, 4269.0, 4319.892002699958, 4410.933835992462, 4430.800613972379, 59167.70416147892, 59905.70047149823, 60314.39685603176, 60604.393956060754, 62374.37625623777, 48381.0, 50910.74544627253, 51042.48957510378, 51210.74394628003, 51953.0, 45501.54498455039, 46140.0, 46769.0, 46883.5311646886, 48222.9999999993, 8797.164269394398, 9021.548922553977, 9202.125798049176, 9328.673496427593, 9453.858192127262, 31246.0, 31741.0, 31999.68000319967, 32150.678493214768, 32411.51382729308, 41768.0, 44466.55533444624, 44616.55383446254, 45104.0, 45188.09623807571, 11748.353840538852, 11887.0, 12029.518819247132, 12068.517259309529, 12355.011599071873, 12047.578334758242, 12947.352632368156, 13133.0, 13260.734785304046, 13427.731445370842, 12609.117361784587, 12693.301868397326, 12712.491500340253, 13352.532661356807, 13528.0, 12534.811977820522, 12650.493980241055, 12938.159019663692, 12966.481340746264, 13856.113398796055, 12004.579839705568, 12218.0225581955, 12457.314847683465, 12478.0, 13017.609471715863, 10511.632092876713, 10521.263511554424, 10585.100266477435, 10632.681019569425, 10656.094231990057, 10546.78906421852, 10728.409937453203, 10947.452627368759, 10958.671239862817, 11007.669769906915], "value": 6639.1279828166025, "unit": "score"}], "name": "dromaeo_css", "value": 6888.660622580073, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 105.0, 110.0, 111.0, 112.0, 99.0, 110.0, 110.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 152.0, 180.0, 146.0, 154.0, 154.0, 128.0, 185.0, 134.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 160.0, 161.0, 163.0, 162.0, 161.0, 161.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 114.0, 106.0, 72.0, 73.0, 74.0, 132.0, 101.0, 76.0], "value": 90.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 145.0, 93.0, 93.0, 92.0, 143.0, 93.0, 93.0, 147.0], "value": 108.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 57.0, 58.0, 59.0, 57.0, 72.0, 56.0, 55.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 62.0, 60.0, 63.0, 61.0, 61.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 77.0, 84.0, 77.0, 76.0, 78.0, 77.0, 78.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 134.0, 122.0, 133.0, 152.0, 126.0, 132.0, 123.0, 166.0, 129.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 164.0, 173.0, 165.0, 170.0, 173.0, 170.0, 164.0, 172.0, 166.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 79.0, 68.0, 67.0, 69.0, 66.0, 68.0, 67.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1548.1, "alertThreshold": 2.0}]} 20:23:17 INFO - Return code: 0 20:23:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:23:17 ERROR - # TBPL SUCCESS # 20:23:17 INFO - Running post-action listener: _resource_record_post_action 20:23:17 INFO - Running post-run listener: _resource_record_post_run 20:23:18 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 533504000; Read time: 52; Write time: 419772 20:23:18 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244297728; Read time: 0; Write time: 268456 20:23:18 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289206272; Read time: 52; Write time: 151316 20:23:18 INFO - Running post-run listener: _upload_blobber_files 20:23:18 INFO - Blob upload gear active. 20:23:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:23:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:23:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:23:18 INFO - (blobuploader) - INFO - Open directory for files ... 20:23:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:23:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:23:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:23:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:23:19 INFO - (blobuploader) - INFO - Done attempting. 20:23:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:23:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:23:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:23:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:23:20 INFO - (blobuploader) - INFO - Done attempting. 20:23:20 INFO - (blobuploader) - INFO - Iteration through files over. 20:23:20 INFO - Return code: 0 20:23:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:23:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:23:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10b88ae211729312335173536521e71715d1b5e700a89788c6f4cbfd3b60b880ab7adb65c1f797fe407326db5f50b045eab15d3232cd17414ec393cda97065cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/258521e1c6bcee55cfe5fd11f71eae25e5b4bf4296d36f5d27e0b45f6de19d62763b28e98976f2a7ed61020241f27c896530335c6e63147f4b7b83f33f780b7b"} 20:23:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:23:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:23:20 INFO - Contents: 20:23:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10b88ae211729312335173536521e71715d1b5e700a89788c6f4cbfd3b60b880ab7adb65c1f797fe407326db5f50b045eab15d3232cd17414ec393cda97065cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/258521e1c6bcee55cfe5fd11f71eae25e5b4bf4296d36f5d27e0b45f6de19d62763b28e98976f2a7ed61020241f27c896530335c6e63147f4b7b83f33f780b7b"} 20:23:20 INFO - Running post-run listener: copy_logs_to_upload_dir 20:23:20 INFO - Copying logs to upload dir... 20:23:20 INFO - mkdir: /builds/slave/test/build/upload/logs 20:23:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.513643 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-18 20:23:19.500494) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 20:23:19.504384) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10b88ae211729312335173536521e71715d1b5e700a89788c6f4cbfd3b60b880ab7adb65c1f797fe407326db5f50b045eab15d3232cd17414ec393cda97065cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/258521e1c6bcee55cfe5fd11f71eae25e5b4bf4296d36f5d27e0b45f6de19d62763b28e98976f2a7ed61020241f27c896530335c6e63147f4b7b83f33f780b7b"} build_url:https://queue.taskcluster.net/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/KrB0Q6WjQiestTUTGwWDqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10b88ae211729312335173536521e71715d1b5e700a89788c6f4cbfd3b60b880ab7adb65c1f797fe407326db5f50b045eab15d3232cd17414ec393cda97065cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/258521e1c6bcee55cfe5fd11f71eae25e5b4bf4296d36f5d27e0b45f6de19d62763b28e98976f2a7ed61020241f27c896530335c6e63147f4b7b83f33f780b7b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 20:23:19.528647) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 20:23:19.529016) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1461022859.878868-1581520074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 20:23:19.614142) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 20:23:19.614474) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 20:23:19.614781) ========= ========= Total master_lag: 0.17 =========