builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1462457527.71 results: success (0) buildid: 20160505061938 builduid: 35db91effe364221bfc2ec319838e06a revision: f6a21128e6ac685e12cb39e691b86e8f48189ab9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 07:12:07.712156) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 07:12:07.712682) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 07:12:07.712998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 07:12:07.730202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 07:12:07.730588) ========= 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=6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 07:12:08-- 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% 223M=0s 2016-05-05 07:12:08 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085713 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 07:12:07.830387) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 07:12:07.830705) ========= 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=6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018571 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 07:12:07.883039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 07:12:07.883363) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f6a21128e6ac685e12cb39e691b86e8f48189ab9 --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 f6a21128e6ac685e12cb39e691b86e8f48189ab9 --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=6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 07:12:08,546 truncating revision to first 12 chars 2016-05-05 07:12:08,546 Setting DEBUG logging. 2016-05-05 07:12:08,546 attempt 1/10 2016-05-05 07:12:08,546 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f6a21128e6ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 07:12:08,809 unpacking tar archive at: fx-team-f6a21128e6ac/testing/mozharness/ program finished with exit code 0 elapsedTime=0.552643 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 07:12:08.448649) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 07:12:08.448965) ========= script_repo_revision: f6a21128e6ac685e12cb39e691b86e8f48189ab9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 07:12:08.449388) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 07:12:08.449685) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 07:12:08.459299) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-05-05 07:12:08.459633) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:12:09 INFO - MultiFileLogger online at 20160505 07:12:09 in /builds/slave/test 07:12:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:12:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:12:09 INFO - {'append_to_log': False, 07:12:09 INFO - 'base_work_dir': '/builds/slave/test', 07:12:09 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:12:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:12:09 INFO - 'branch': 'Fx-Team-Non-PGO', 07:12:09 INFO - 'buildbot_json_path': 'buildprops.json', 07:12:09 INFO - 'config_files': ('talos/linux_config.py',), 07:12:09 INFO - 'default_actions': ('clobber', 07:12:09 INFO - 'read-buildbot-config', 07:12:09 INFO - 'download-and-extract', 07:12:09 INFO - 'populate-webroot', 07:12:09 INFO - 'create-virtualenv', 07:12:09 INFO - 'install', 07:12:09 INFO - 'run-tests'), 07:12:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:12:09 INFO - 'download_minidump_stackwalk': True, 07:12:09 INFO - 'download_symbols': 'ondemand', 07:12:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:12:09 INFO - 'tooltool.py': '/tools/tooltool.py', 07:12:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:12:09 INFO - '/tools/misc-python/virtualenv.py')}, 07:12:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:12:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:12:09 INFO - 'installer_path': 'installer.exe', 07:12:09 INFO - 'log_level': 'info', 07:12:09 INFO - 'log_name': 'talos', 07:12:09 INFO - 'log_to_console': True, 07:12:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:12:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:12:09 INFO - 'opt_config_files': (), 07:12:09 INFO - 'pip_index': False, 07:12:09 INFO - 'sps_profile': False, 07:12:09 INFO - 'sps_profile_interval': 0, 07:12:09 INFO - 'suite': 'dromaeojs', 07:12:09 INFO - 'system_bits': '32', 07:12:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:12:09 INFO - 'title': 'talos-linux64-ix-023', 07:12:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:12:09 INFO - 'use_talos_json': True, 07:12:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:12:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:12:09 INFO - 'work_dir': 'build'} 07:12:09 INFO - ##### 07:12:09 INFO - ##### Running clobber step. 07:12:09 INFO - ##### 07:12:09 INFO - Running pre-action listener: _resource_record_pre_action 07:12:09 INFO - Running main action method: clobber 07:12:09 INFO - rmtree: /builds/slave/test/build 07:12:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:12:09 INFO - Running post-action listener: _resource_record_post_action 07:12:09 INFO - ##### 07:12:09 INFO - ##### Running read-buildbot-config step. 07:12:09 INFO - ##### 07:12:09 INFO - Running pre-action listener: _resource_record_pre_action 07:12:09 INFO - Running main action method: read_buildbot_config 07:12:09 INFO - Using buildbot properties: 07:12:09 INFO - { 07:12:09 INFO - "project": "", 07:12:09 INFO - "product": "firefox", 07:12:09 INFO - "script_repo_revision": "production", 07:12:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:12:09 INFO - "repository": "", 07:12:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:12:09 INFO - "buildid": "20160505061938", 07:12:09 INFO - "pgo_build": "False", 07:12:09 INFO - "basedir": "/builds/slave/test", 07:12:09 INFO - "buildnumber": 1726, 07:12:09 INFO - "slavename": "talos-linux64-ix-023", 07:12:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:12:09 INFO - "platform": "ubuntu64_hw", 07:12:09 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:12:09 INFO - "branch": "fx-team", 07:12:09 INFO - "repo_path": "integration/fx-team", 07:12:09 INFO - "revision": "f6a21128e6ac685e12cb39e691b86e8f48189ab9", 07:12:09 INFO - "stage_platform": "linux64", 07:12:09 INFO - "builduid": "35db91effe364221bfc2ec319838e06a", 07:12:09 INFO - "slavebuilddir": "test" 07:12:09 INFO - } 07:12:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:12:09 INFO - Running post-action listener: _resource_record_post_action 07:12:09 INFO - ##### 07:12:09 INFO - ##### Running download-and-extract step. 07:12:09 INFO - ##### 07:12:09 INFO - Running pre-action listener: _resource_record_pre_action 07:12:09 INFO - Running main action method: download_and_extract 07:12:09 INFO - mkdir: /builds/slave/test/build/tests 07:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:09 INFO - https://queue.taskcluster.net/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:12:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:12:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:12:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:12:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:12:10 INFO - Downloaded 1361 bytes. 07:12:10 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:12:10 INFO - Using the following test package requirements: 07:12:10 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:12:10 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:12:10 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:12:10 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:10 INFO - u'jsshell-linux-x86_64.zip'], 07:12:10 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:12:10 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:12:10 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:12:10 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:12:10 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:12:10 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:12:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:12: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')]} 07:12:10 INFO - https://queue.taskcluster.net/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:12:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:12:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:12:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:12:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:12:11 INFO - Downloaded 22307347 bytes. 07:12:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:12:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:12:12 INFO - Return code: 0 07:12:12 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:12 INFO - https://queue.taskcluster.net/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:12:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:12:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:12:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:12:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:12:14 INFO - Downloaded 22307347 bytes. 07:12:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:12:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:12:15 INFO - Return code: 0 07:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:15 INFO - https://queue.taskcluster.net/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:12:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:12:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:12:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:12:21 INFO - Downloaded 10840152 bytes. 07:12:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:12:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:12:21 INFO - Return code: 0 07:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:21 INFO - https://queue.taskcluster.net/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:12:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:12:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:12:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:12:23 INFO - Downloaded 54865943 bytes. 07:12:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:12:23 INFO - mkdir: /builds/slave/test/properties 07:12:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:12:23 INFO - Writing to file /builds/slave/test/properties/build_url 07:12:23 INFO - Contents: 07:12:23 INFO - build_url:https://queue.taskcluster.net/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:12:24 INFO - Running post-action listener: _resource_record_post_action 07:12:24 INFO - Running post-action listener: set_extra_try_arguments 07:12:24 INFO - ##### 07:12:24 INFO - ##### Running populate-webroot step. 07:12:24 INFO - ##### 07:12:24 INFO - Running pre-action listener: _resource_record_pre_action 07:12:24 INFO - Running main action method: populate_webroot 07:12:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:12:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:12:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:12:24 INFO - '--tppagecycles', 07:12:24 INFO - '7'], 07:12:24 INFO - 'tests': ['tsvgm']}}, 07:12:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:12:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:12:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:12:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:12:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:12:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:12:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:24 INFO - 'talos_options': ['--disable-e10s'], 07:12:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:12:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:12:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:24 INFO - 'talos_options': ['--disable-e10s'], 07:12:24 INFO - 'tests': ['damp', 'tps']}, 07:12:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:24 INFO - 'tests': ['damp', 'tps']}, 07:12:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:12:24 INFO - 'tests': ['dromaeo_dom']}, 07:12:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:12:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:12:24 INFO - 'tests': ['a11yr', 07:12:24 INFO - 'ts_paint', 07:12:24 INFO - 'tpaint', 07:12:24 INFO - 'sessionrestore', 07:12:24 INFO - 'sessionrestore_no_auto_restore', 07:12:24 INFO - 'tabpaint']}, 07:12:24 INFO - 'other-e10s': {'tests': ['a11yr', 07:12:24 INFO - 'ts_paint', 07:12:24 INFO - 'tpaint', 07:12:24 INFO - 'sessionrestore', 07:12:24 INFO - 'sessionrestore_no_auto_restore', 07:12:24 INFO - 'tabpaint']}, 07:12:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:12:24 INFO - 'ts_paint', 07:12:24 INFO - 'tpaint', 07:12:24 INFO - 'sessionrestore', 07:12:24 INFO - 'sessionrestore_no_auto_restore', 07:12:24 INFO - 'tabpaint']}, 07:12:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:12:24 INFO - 'ts_paint', 07:12:24 INFO - 'tpaint', 07:12:24 INFO - 'sessionrestore', 07:12:24 INFO - 'sessionrestore_no_auto_restore', 07:12:24 INFO - 'tabpaint']}, 07:12:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:12:24 INFO - 'tests': ['a11yr', 07:12:24 INFO - 'ts_paint', 07:12:24 INFO - 'tpaint', 07:12:24 INFO - 'sessionrestore', 07:12:24 INFO - 'sessionrestore_no_auto_restore', 07:12:24 INFO - 'tabpaint']}, 07:12:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:12:24 INFO - 'tests': ['a11yr', 07:12:24 INFO - 'ts_paint', 07:12:24 INFO - 'tpaint', 07:12:24 INFO - 'sessionrestore', 07:12:24 INFO - 'sessionrestore_no_auto_restore', 07:12:24 INFO - 'tabpaint']}, 07:12:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:12:24 INFO - 'tests': ['tsvgx', 07:12:24 INFO - 'tsvgr_opacity', 07:12:24 INFO - 'tart', 07:12:24 INFO - 'tscrollx', 07:12:24 INFO - 'cart']}, 07:12:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:12:24 INFO - 'tsvgr_opacity', 07:12:24 INFO - 'tart', 07:12:24 INFO - 'tscrollx', 07:12:24 INFO - 'cart']}, 07:12:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:24 INFO - 'talos_options': ['--disable-e10s'], 07:12:24 INFO - 'tests': ['tp5o']}, 07:12:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:24 INFO - 'tests': ['tp5o']}, 07:12:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:24 INFO - 'talos_options': ['--disable-e10s', 07:12:24 INFO - '--xperf_path', 07:12:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:12:24 INFO - 'tests': ['tp5n']}, 07:12:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:24 INFO - 'talos_options': ['--xperf_path', 07:12:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:12:24 INFO - 'tests': ['tp5n']}}, 07:12:24 INFO - 'talos.zip': {'path': '', 07:12:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:12:24 INFO - Running post-action listener: _resource_record_post_action 07:12:24 INFO - ##### 07:12:24 INFO - ##### Running create-virtualenv step. 07:12:24 INFO - ##### 07:12:24 INFO - Running pre-action listener: _resource_record_pre_action 07:12:24 INFO - Running main action method: create_virtualenv 07:12:24 INFO - Creating virtualenv /builds/slave/test/build/venv 07:12:24 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 07:12:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:12:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:12:24 INFO - Using real prefix '/usr' 07:12:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:12:25 INFO - Installing distribute.............................................................................................................................................................................................done. 07:12:27 INFO - Installing pip.................done. 07:12:27 INFO - Return code: 0 07:12:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:27 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 0x7f6deb4e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce1410>, '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 0x2ce2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce27a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', '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 07:12:27 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 07:12:27 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 07:12:27 INFO - Using env: {'DISPLAY': ':0', 07:12:27 INFO - 'HOME': '/home/cltbld', 07:12:27 INFO - 'LANG': 'en_US.UTF-8', 07:12:27 INFO - 'LANGUAGE': 'en_US:en', 07:12:27 INFO - 'LOGNAME': 'cltbld', 07:12:27 INFO - 'MAIL': '/var/mail/cltbld', 07:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:27 INFO - 'MOZ_NO_REMOTE': '1', 07:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:27 INFO - 'NO_EM_RESTART': '1', 07:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:27 INFO - 'PWD': '/builds/slave/test', 07:12:27 INFO - 'SHELL': '/bin/bash', 07:12:27 INFO - 'SHLVL': '1', 07:12:27 INFO - 'TERM': 'linux', 07:12:27 INFO - 'TMOUT': '86400', 07:12:27 INFO - 'USER': 'cltbld', 07:12:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', 07:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:27 INFO - '_': '/tools/buildbot/bin/python'} 07:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:27 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 07:12:27 INFO - Cleaning up... 07:12:27 INFO - Return code: 0 07:12:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:27 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 0x7f6deb4e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce1410>, '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 0x2ce2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce27a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', '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 07:12:27 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 07:12:27 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 07:12:27 INFO - Using env: {'DISPLAY': ':0', 07:12:27 INFO - 'HOME': '/home/cltbld', 07:12:27 INFO - 'LANG': 'en_US.UTF-8', 07:12:27 INFO - 'LANGUAGE': 'en_US:en', 07:12:27 INFO - 'LOGNAME': 'cltbld', 07:12:27 INFO - 'MAIL': '/var/mail/cltbld', 07:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:27 INFO - 'MOZ_NO_REMOTE': '1', 07:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:27 INFO - 'NO_EM_RESTART': '1', 07:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:27 INFO - 'PWD': '/builds/slave/test', 07:12:27 INFO - 'SHELL': '/bin/bash', 07:12:27 INFO - 'SHLVL': '1', 07:12:27 INFO - 'TERM': 'linux', 07:12:27 INFO - 'TMOUT': '86400', 07:12:27 INFO - 'USER': 'cltbld', 07:12:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', 07:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:27 INFO - '_': '/tools/buildbot/bin/python'} 07:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:27 INFO - Downloading/unpacking psutil>=0.7.1 07:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:12:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:29 INFO - Installing collected packages: psutil 07:12:29 INFO - Running setup.py install for psutil 07:12:29 INFO - building 'psutil._psutil_linux' extension 07:12:29 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 07:12:29 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 07:12:29 INFO - building 'psutil._psutil_posix' extension 07:12:29 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 07:12:29 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 07:12:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:30 INFO - Successfully installed psutil 07:12:30 INFO - Cleaning up... 07:12:30 INFO - Return code: 0 07:12:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:12:30 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')]} 07:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:30 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')]} 07:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:30 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 0x7f6deb4e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce1410>, '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 0x2ce2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce27a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', '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 07:12:30 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 07:12:30 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 07:12:30 INFO - Using env: {'DISPLAY': ':0', 07:12:30 INFO - 'HOME': '/home/cltbld', 07:12:30 INFO - 'LANG': 'en_US.UTF-8', 07:12:30 INFO - 'LANGUAGE': 'en_US:en', 07:12:30 INFO - 'LOGNAME': 'cltbld', 07:12:30 INFO - 'MAIL': '/var/mail/cltbld', 07:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:30 INFO - 'MOZ_NO_REMOTE': '1', 07:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:30 INFO - 'NO_EM_RESTART': '1', 07:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:30 INFO - 'PWD': '/builds/slave/test', 07:12:30 INFO - 'SHELL': '/bin/bash', 07:12:30 INFO - 'SHLVL': '1', 07:12:30 INFO - 'TERM': 'linux', 07:12:30 INFO - 'TMOUT': '86400', 07:12:30 INFO - 'USER': 'cltbld', 07:12:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', 07:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:30 INFO - '_': '/tools/buildbot/bin/python'} 07:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:12:30 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 07:12:30 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 07:12:30 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 07:12:30 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 07:12:30 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 07:12:30 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 07:12:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:12:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:12:32 INFO - Installing collected packages: mozsystemmonitor 07:12:32 INFO - Running setup.py install for mozsystemmonitor 07:12:32 INFO - Successfully installed mozsystemmonitor 07:12:32 INFO - Cleaning up... 07:12:32 INFO - Return code: 0 07:12:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:12:32 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')]} 07:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:32 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')]} 07:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:32 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 0x7f6deb4e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce1410>, '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 0x2ce2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce27a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', '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 07:12:32 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 07:12:32 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 07:12:32 INFO - Using env: {'DISPLAY': ':0', 07:12:32 INFO - 'HOME': '/home/cltbld', 07:12:32 INFO - 'LANG': 'en_US.UTF-8', 07:12:32 INFO - 'LANGUAGE': 'en_US:en', 07:12:32 INFO - 'LOGNAME': 'cltbld', 07:12:32 INFO - 'MAIL': '/var/mail/cltbld', 07:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:32 INFO - 'MOZ_NO_REMOTE': '1', 07:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:32 INFO - 'NO_EM_RESTART': '1', 07:12:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:32 INFO - 'PWD': '/builds/slave/test', 07:12:32 INFO - 'SHELL': '/bin/bash', 07:12:32 INFO - 'SHLVL': '1', 07:12:32 INFO - 'TERM': 'linux', 07:12:32 INFO - 'TMOUT': '86400', 07:12:32 INFO - 'USER': 'cltbld', 07:12:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', 07:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:32 INFO - '_': '/tools/buildbot/bin/python'} 07:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:32 INFO - Downloading/unpacking blobuploader==1.2.4 07:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:34 INFO - Downloading blobuploader-1.2.4.tar.gz 07:12:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:12:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:12:34 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 07:12:34 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 07:12:34 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 07:12:34 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 07:12:34 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 07:12:34 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 07:12:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:12:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:12:34 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 07:12:34 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 07:12:34 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 07:12:34 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 07:12:34 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 07:12:34 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 07:12:35 INFO - Downloading docopt-0.6.1.tar.gz 07:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:12:35 INFO - Installing collected packages: blobuploader, requests, docopt 07:12:35 INFO - Running setup.py install for blobuploader 07:12:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:12:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:12:35 INFO - Running setup.py install for requests 07:12:35 INFO - Running setup.py install for docopt 07:12:35 INFO - Successfully installed blobuploader requests docopt 07:12:35 INFO - Cleaning up... 07:12:35 INFO - Return code: 0 07:12:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:35 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 0x7f6deb4e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce1410>, '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 0x2ce2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce27a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', '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 07:12:35 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 07:12:35 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 07:12:35 INFO - Using env: {'DISPLAY': ':0', 07:12:35 INFO - 'HOME': '/home/cltbld', 07:12:35 INFO - 'LANG': 'en_US.UTF-8', 07:12:35 INFO - 'LANGUAGE': 'en_US:en', 07:12:35 INFO - 'LOGNAME': 'cltbld', 07:12:35 INFO - 'MAIL': '/var/mail/cltbld', 07:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:35 INFO - 'MOZ_NO_REMOTE': '1', 07:12:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:35 INFO - 'NO_EM_RESTART': '1', 07:12:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:35 INFO - 'PWD': '/builds/slave/test', 07:12:35 INFO - 'SHELL': '/bin/bash', 07:12:35 INFO - 'SHLVL': '1', 07:12:35 INFO - 'TERM': 'linux', 07:12:35 INFO - 'TMOUT': '86400', 07:12:35 INFO - 'USER': 'cltbld', 07:12:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', 07:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:35 INFO - '_': '/tools/buildbot/bin/python'} 07:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:36 INFO - Running setup.py (path:/tmp/pip-eqwXyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:36 INFO - Running setup.py (path:/tmp/pip-8LpQoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:36 INFO - Running setup.py (path:/tmp/pip-JAWEgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:36 INFO - Running setup.py (path:/tmp/pip-6dIag5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:36 INFO - Running setup.py (path:/tmp/pip-k6_Csb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:36 INFO - Running setup.py (path:/tmp/pip-dOPe6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:36 INFO - Running setup.py (path:/tmp/pip-lgW8hO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:36 INFO - Running setup.py (path:/tmp/pip-9s7I7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:36 INFO - Running setup.py (path:/tmp/pip-NVhadE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:36 INFO - Running setup.py (path:/tmp/pip-pfQG7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:36 INFO - Running setup.py (path:/tmp/pip-9wD6WA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:36 INFO - Running setup.py (path:/tmp/pip-zbdzqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:36 INFO - Running setup.py (path:/tmp/pip-2Spx_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:36 INFO - Running setup.py (path:/tmp/pip-vY5Vk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:37 INFO - Running setup.py (path:/tmp/pip-CXgMrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:37 INFO - Running setup.py (path:/tmp/pip-98N47P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:37 INFO - Running setup.py (path:/tmp/pip-ZDbTJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:12:37 INFO - Running setup.py install for manifestparser 07:12:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:12:37 INFO - Running setup.py install for mozcrash 07:12:37 INFO - Running setup.py install for mozdebug 07:12:37 INFO - Running setup.py install for mozdevice 07:12:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:12:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:12:37 INFO - Running setup.py install for mozfile 07:12:37 INFO - Running setup.py install for mozhttpd 07:12:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:12:37 INFO - Running setup.py install for mozinfo 07:12:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:12:37 INFO - Running setup.py install for mozInstall 07:12:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Running setup.py install for mozleak 07:12:38 INFO - Running setup.py install for mozlog 07:12:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Running setup.py install for moznetwork 07:12:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Running setup.py install for mozprocess 07:12:38 INFO - Running setup.py install for mozprofile 07:12:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Running setup.py install for mozrunner 07:12:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Running setup.py install for mozscreenshot 07:12:38 INFO - Running setup.py install for moztest 07:12:38 INFO - Running setup.py install for mozversion 07:12:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:12:39 INFO - Cleaning up... 07:12:39 INFO - Return code: 0 07:12:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:39 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 0x7f6deb4e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce1410>, '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 0x2ce2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce27a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', '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 07:12:39 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 07:12:39 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 07:12:39 INFO - Using env: {'DISPLAY': ':0', 07:12:39 INFO - 'HOME': '/home/cltbld', 07:12:39 INFO - 'LANG': 'en_US.UTF-8', 07:12:39 INFO - 'LANGUAGE': 'en_US:en', 07:12:39 INFO - 'LOGNAME': 'cltbld', 07:12:39 INFO - 'MAIL': '/var/mail/cltbld', 07:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:39 INFO - 'MOZ_NO_REMOTE': '1', 07:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:39 INFO - 'NO_EM_RESTART': '1', 07:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:39 INFO - 'PWD': '/builds/slave/test', 07:12:39 INFO - 'SHELL': '/bin/bash', 07:12:39 INFO - 'SHLVL': '1', 07:12:39 INFO - 'TERM': 'linux', 07:12:39 INFO - 'TMOUT': '86400', 07:12:39 INFO - 'USER': 'cltbld', 07:12:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', 07:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:39 INFO - '_': '/tools/buildbot/bin/python'} 07:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:39 INFO - Running setup.py (path:/tmp/pip-PcnW8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:39 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)) 07:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:39 INFO - Running setup.py (path:/tmp/pip-IwD1e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:39 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)) 07:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:39 INFO - Running setup.py (path:/tmp/pip-Ip_38t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:39 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)) 07:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:39 INFO - Running setup.py (path:/tmp/pip-IKCUHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:39 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)) 07:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:39 INFO - Running setup.py (path:/tmp/pip-aR7DAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:39 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)) 07:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:39 INFO - Running setup.py (path:/tmp/pip-YcCigv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:39 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)) 07:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:39 INFO - Running setup.py (path:/tmp/pip-G2Bhc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:39 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)) 07:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:39 INFO - Running setup.py (path:/tmp/pip-JEd_Ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:39 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)) 07:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:39 INFO - Running setup.py (path:/tmp/pip-7pcCXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:39 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)) 07:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:39 INFO - Running setup.py (path:/tmp/pip-DFIahO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:39 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)) 07:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:39 INFO - Running setup.py (path:/tmp/pip-WrBfo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:40 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)) 07:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:40 INFO - Running setup.py (path:/tmp/pip-cmi0SW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:40 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)) 07:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:40 INFO - Running setup.py (path:/tmp/pip-s9GNU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:40 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)) 07:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:40 INFO - Running setup.py (path:/tmp/pip-GdtLPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:40 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)) 07:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:40 INFO - Running setup.py (path:/tmp/pip-6wCT7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:40 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)) 07:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:40 INFO - Running setup.py (path:/tmp/pip-tUUGTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:40 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)) 07:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:40 INFO - Running setup.py (path:/tmp/pip-M8PozS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:40 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)) 07:12:40 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)) 07:12:40 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)) 07:12:40 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)) 07:12:40 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)) 07:12:40 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)) 07:12:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:12:40 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 07:12:40 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 07:12:40 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 07:12:40 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 07:12:40 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 07:12:40 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 07:12:42 INFO - Downloading blessings-1.6.tar.gz 07:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:12:42 INFO - Installing collected packages: blessings 07:12:42 INFO - Running setup.py install for blessings 07:12:42 INFO - Successfully installed blessings 07:12:42 INFO - Cleaning up... 07:12:42 INFO - Return code: 0 07:12:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:12:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:42 INFO - Reading from file tmpfile_stdout 07:12:42 INFO - Current package versions: 07:12:42 INFO - argparse == 1.2.1 07:12:42 INFO - blessings == 1.6 07:12:42 INFO - blobuploader == 1.2.4 07:12:42 INFO - docopt == 0.6.1 07:12:42 INFO - manifestparser == 1.1 07:12:42 INFO - mozInstall == 1.12 07:12:42 INFO - mozcrash == 0.17 07:12:42 INFO - mozdebug == 0.1 07:12:42 INFO - mozdevice == 0.48 07:12:42 INFO - mozfile == 1.2 07:12:42 INFO - mozhttpd == 0.7 07:12:42 INFO - mozinfo == 0.9 07:12:42 INFO - mozleak == 0.1 07:12:42 INFO - mozlog == 3.1 07:12:42 INFO - moznetwork == 0.27 07:12:42 INFO - mozprocess == 0.22 07:12:42 INFO - mozprofile == 0.28 07:12:42 INFO - mozrunner == 6.11 07:12:42 INFO - mozscreenshot == 0.1 07:12:42 INFO - mozsystemmonitor == 0.0 07:12:42 INFO - moztest == 0.7 07:12:42 INFO - mozversion == 1.4 07:12:42 INFO - psutil == 3.1.1 07:12:42 INFO - requests == 1.2.3 07:12:42 INFO - wsgiref == 0.1.2 07:12:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:42 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 0x7f6deb4e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce1410>, '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 0x2ce2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce27a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', '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 07:12:42 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 07:12:42 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 07:12:42 INFO - Using env: {'DISPLAY': ':0', 07:12:42 INFO - 'HOME': '/home/cltbld', 07:12:42 INFO - 'LANG': 'en_US.UTF-8', 07:12:42 INFO - 'LANGUAGE': 'en_US:en', 07:12:42 INFO - 'LOGNAME': 'cltbld', 07:12:42 INFO - 'MAIL': '/var/mail/cltbld', 07:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:42 INFO - 'MOZ_NO_REMOTE': '1', 07:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:42 INFO - 'NO_EM_RESTART': '1', 07:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:42 INFO - 'PWD': '/builds/slave/test', 07:12:42 INFO - 'SHELL': '/bin/bash', 07:12:42 INFO - 'SHLVL': '1', 07:12:42 INFO - 'TERM': 'linux', 07:12:42 INFO - 'TMOUT': '86400', 07:12:42 INFO - 'USER': 'cltbld', 07:12:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', 07:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:42 INFO - '_': '/tools/buildbot/bin/python'} 07:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:43 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)) 07:12:43 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)) 07:12:43 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)) 07:12:43 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)) 07:12:43 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)) 07:12:43 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)) 07:12:43 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)) 07:12:43 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)) 07:12:43 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)) 07:12:43 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)) 07:12:43 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)) 07:12:43 INFO - Cleaning up... 07:12:43 INFO - Return code: 0 07:12:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:12: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')]} 07:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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')]} 07:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:43 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 0x7f6deb4e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce1410>, '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 0x2ce2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce27a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', '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 07:12:43 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 07:12:43 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 07:12:43 INFO - Using env: {'DISPLAY': ':0', 07:12:43 INFO - 'HOME': '/home/cltbld', 07:12:43 INFO - 'LANG': 'en_US.UTF-8', 07:12:43 INFO - 'LANGUAGE': 'en_US:en', 07:12:43 INFO - 'LOGNAME': 'cltbld', 07:12:43 INFO - 'MAIL': '/var/mail/cltbld', 07:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:43 INFO - 'MOZ_NO_REMOTE': '1', 07:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:43 INFO - 'NO_EM_RESTART': '1', 07:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:43 INFO - 'PWD': '/builds/slave/test', 07:12:43 INFO - 'SHELL': '/bin/bash', 07:12:43 INFO - 'SHLVL': '1', 07:12:43 INFO - 'TERM': 'linux', 07:12:43 INFO - 'TMOUT': '86400', 07:12:43 INFO - 'USER': 'cltbld', 07:12:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', 07:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:43 INFO - '_': '/tools/buildbot/bin/python'} 07:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:43 INFO - Downloading/unpacking jsonschema 07:12:43 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 07:12:43 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 07:12:43 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 07:12:43 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 07:12:43 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 07:12:43 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 07:12:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:12:45 INFO - Downloading/unpacking functools32 (from jsonschema) 07:12:45 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 07:12:45 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 07:12:45 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 07:12:45 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 07:12:45 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 07:12:45 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 07:12:45 INFO - Downloading functools32-3.2.3-2.tar.gz 07:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:12:45 INFO - warning: no files found matching '*.txt' 07:12:45 INFO - no previously-included directories found matching 'build' 07:12:45 INFO - no previously-included directories found matching 'dist' 07:12:45 INFO - no previously-included directories found matching '.git*' 07:12:45 INFO - Installing collected packages: jsonschema, functools32 07:12:45 INFO - Running setup.py install for functools32 07:12:45 INFO - warning: no files found matching '*.txt' 07:12:45 INFO - no previously-included directories found matching 'build' 07:12:45 INFO - no previously-included directories found matching 'dist' 07:12:45 INFO - no previously-included directories found matching '.git*' 07:12:45 INFO - Successfully installed jsonschema functools32 07:12:45 INFO - Cleaning up... 07:12:45 INFO - Return code: 0 07:12:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:45 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 0x7f6deb4e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce1410>, '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 0x2ce2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce27a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', '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 07:12:45 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 07:12:45 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 07:12:45 INFO - Using env: {'DISPLAY': ':0', 07:12:45 INFO - 'HOME': '/home/cltbld', 07:12:45 INFO - 'LANG': 'en_US.UTF-8', 07:12:45 INFO - 'LANGUAGE': 'en_US:en', 07:12:45 INFO - 'LOGNAME': 'cltbld', 07:12:45 INFO - 'MAIL': '/var/mail/cltbld', 07:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:45 INFO - 'MOZ_NO_REMOTE': '1', 07:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:45 INFO - 'NO_EM_RESTART': '1', 07:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:45 INFO - 'PWD': '/builds/slave/test', 07:12:45 INFO - 'SHELL': '/bin/bash', 07:12:45 INFO - 'SHLVL': '1', 07:12:45 INFO - 'TERM': 'linux', 07:12:45 INFO - 'TMOUT': '86400', 07:12:45 INFO - 'USER': 'cltbld', 07:12:45 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', 07:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:45 INFO - '_': '/tools/buildbot/bin/python'} 07:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:45 INFO - Downloading/unpacking flake8 07:12:45 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 07:12:45 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 07:12:45 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 07:12:45 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 07:12:45 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 07:12:45 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 07:12:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:12:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:12:47 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 07:12:47 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 07:12:47 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 07:12:47 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 07:12:47 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 07:12:47 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 07:12:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:12:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:12:47 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 07:12:47 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 07:12:47 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 07:12:47 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 07:12:47 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 07:12:47 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 07:12:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:12:48 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 07:12:48 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 07:12:48 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 07:12:48 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 07:12:48 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 07:12:48 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 07:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:12:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:12:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:12:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:12:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:12:48 INFO - no previously-included directories found matching 'docs/_build' 07:12:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:12:48 INFO - Running setup.py install for pep8 07:12:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:12:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:12:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:12:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:12:48 INFO - no previously-included directories found matching 'docs/_build' 07:12:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:12:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:12:48 INFO - Cleaning up... 07:12:48 INFO - Return code: 0 07:12:48 INFO - Running post-action listener: _resource_record_post_action 07:12:48 INFO - Running post-action listener: _start_resource_monitoring 07:12:48 INFO - Starting resource monitoring. 07:12:48 INFO - ##### 07:12:48 INFO - ##### Running install step. 07:12:48 INFO - ##### 07:12:48 INFO - Running pre-action listener: _resource_record_pre_action 07:12:48 INFO - Running main action method: install 07:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:49 INFO - Reading from file tmpfile_stdout 07:12:49 INFO - Detecting whether we're running mozinstall >=1.0... 07:12:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:12:49 INFO - Reading from file tmpfile_stdout 07:12:49 INFO - Output received: 07:12:49 INFO - Usage: mozinstall [options] installer 07:12:49 INFO - Options: 07:12:49 INFO - -h, --help show this help message and exit 07:12:49 INFO - -d DEST, --destination=DEST 07:12:49 INFO - Directory to install application into. [default: 07:12:49 INFO - "/builds/slave/test"] 07:12:49 INFO - --app=APP Application being installed. [default: firefox] 07:12:49 INFO - mkdir: /builds/slave/test/build/application 07:12:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:13:05 INFO - Reading from file tmpfile_stdout 07:13:05 INFO - Output received: 07:13:05 INFO - /builds/slave/test/build/application/firefox/firefox 07:13:05 INFO - Running post-action listener: _resource_record_post_action 07:13:05 INFO - ##### 07:13:05 INFO - ##### Running run-tests step. 07:13:05 INFO - ##### 07:13:05 INFO - Running pre-action listener: _resource_record_pre_action 07:13:05 INFO - Running main action method: run_tests 07:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:13:05 INFO - Python 2.7.3 07:13:05 INFO - Return code: 0 07:13:05 INFO - grabbing minidump binary from tooltool 07:13: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')]} 07:13:05 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 0x2ce1410>, '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 0x2ce2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce27a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:13:05 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 07:13:05 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 07:13:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:13:05 INFO - Return code: 0 07:13:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:13:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:13:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:13:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:13:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:13:06 INFO - Return code: 0 07:13:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 07:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 07:13:06 INFO - Using env: {'DISPLAY': ':0', 07:13:06 INFO - 'HOME': '/home/cltbld', 07:13:06 INFO - 'LANG': 'en_US.UTF-8', 07:13:06 INFO - 'LANGUAGE': 'en_US:en', 07:13:06 INFO - 'LOGNAME': 'cltbld', 07:13:06 INFO - 'MAIL': '/var/mail/cltbld', 07:13:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:13:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:06 INFO - 'MOZ_NO_REMOTE': '1', 07:13:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:06 INFO - 'NO_EM_RESTART': '1', 07:13:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:06 INFO - 'PWD': '/builds/slave/test', 07:13:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:13:06 INFO - 'SHELL': '/bin/bash', 07:13:06 INFO - 'SHLVL': '1', 07:13:06 INFO - 'TERM': 'linux', 07:13:06 INFO - 'TMOUT': '86400', 07:13:06 INFO - 'USER': 'cltbld', 07:13:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618', 07:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:06 INFO - '_': '/tools/buildbot/bin/python'} 07:13:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 07:13:06 INFO - mozversion application_buildid: 20160505061938 07:13:06 INFO - mozversion application_changeset: f6a21128e6ac685e12cb39e691b86e8f48189ab9 07:13:06 INFO - mozversion application_display_name: Nightly 07:13:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:13:06 INFO - mozversion application_name: Firefox 07:13:06 INFO - mozversion application_remotingname: firefox 07:13:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:13:06 INFO - mozversion application_vendor: Mozilla 07:13:06 INFO - mozversion application_version: 49.0a1 07:13:06 INFO - mozversion platform_buildid: 20160505061938 07:13:06 INFO - mozversion platform_changeset: f6a21128e6ac685e12cb39e691b86e8f48189ab9 07:13:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:13:06 INFO - mozversion platform_version: 49.0a1 07:13:06 INFO - using testdate: 1462457586 07:13:06 INFO - actual date: 1462457586 07:13:06 INFO - starting webserver on 'localhost:55462' 07:13:06 INFO - SUITE-START | Running 2 tests 07:13:06 INFO - TEST-START | dromaeo_css 07:13:06 INFO - operating with platform_type : linux_ 07:13:06 INFO - Initialising browser for dromaeo_css test... 07:13:06 INFO - TEST-INFO | started process 18796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDRbvjq/profile http://localhost:55462/getInfo.html) 07:13:10 INFO - PROCESS | 18796 | __metrics Screen width/height:1600/1200 07:13:10 INFO - PROCESS | 18796 | colorDepth:24 07:13:10 INFO - PROCESS | 18796 | Browser inner width/height: 1024/697 07:13:10 INFO - PROCESS | 18796 | __metrics 07:13:11 ERROR - PROCESS | 18796 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:13:12 INFO - TEST-INFO | 18796: exit 0 07:13:12 INFO - Browser initialized. 07:13:12 INFO - Running cycle 1/1 for dromaeo_css test... 07:13:12 INFO - TEST-INFO | started process 18874 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDRbvjq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:24 INFO - PROCESS | 18874 | RSS: Main: 156856320 07:13:24 INFO - PROCESS | 18874 | 07:14:16 INFO - PROCESS | 18874 | 1462457656013 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] 07:16:27 INFO - PROCESS | 18874 | Cycle 1(1): loaded http://localhost:55462/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55462/tests/dromaeo/cssquery-ext.html) 07:16:28 INFO - PROCESS | 18874 | RSS: Main: 240594944 07:16:28 INFO - PROCESS | 18874 | 07:19:30 INFO - PROCESS | 18874 | Cycle 1(1): loaded http://localhost:55462/tests/dromaeo/cssquery-ext.html (next: http://localhost:55462/tests/dromaeo/cssquery-jquery.html) 07:19:31 INFO - PROCESS | 18874 | RSS: Main: 237510656 07:19:31 INFO - PROCESS | 18874 | 07:22:33 INFO - PROCESS | 18874 | Cycle 1(1): loaded http://localhost:55462/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55462/tests/dromaeo/cssquery-mootools.html) 07:22:34 INFO - PROCESS | 18874 | RSS: Main: 237080576 07:22:34 INFO - PROCESS | 18874 | 07:25:36 INFO - PROCESS | 18874 | Cycle 1(1): loaded http://localhost:55462/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55462/tests/dromaeo/cssquery-prototype.html) 07:25:36 INFO - PROCESS | 18874 | RSS: Main: 229285888 07:25:36 INFO - PROCESS | 18874 | 07:28:39 INFO - PROCESS | 18874 | Cycle 1(1): loaded http://localhost:55462/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55462/tests/dromaeo/cssquery-yui.html) 07:28:40 INFO - PROCESS | 18874 | RSS: Main: 213479424 07:28:40 INFO - PROCESS | 18874 | 07:31:43 INFO - PROCESS | 18874 | Cycle 1(1): loaded http://localhost:55462/tests/dromaeo/cssquery-yui.html (next: http://localhost:55462/tests/dromaeo/cssquery-dojo.html) 07:31:43 INFO - PROCESS | 18874 | RSS: Main: 282087424 07:31:43 INFO - PROCESS | 18874 | 07:31:43 INFO - PROCESS | 18874 | __start_tp_report 07:31:43 INFO - PROCESS | 18874 | _x_x_mozilla_page_load 07:31:43 INFO - PROCESS | 18874 | _x_x_mozilla_page_load_details 07:31:43 INFO - PROCESS | 18874 | |i|pagename|runs| 07:31:43 INFO - PROCESS | 18874 | |0;dojo.html;2548.4759016916687;2614.8431094134353;2619.908303209388;2645.4047839236164;2654.7610715035644;4473.26191178456;4559.612432943196;4571.360009598655;4574.31385292206;4592.242280023796;4681.133990211813;4705.647076469261;4746.667733258673;4771.570558649721;4787.49731278216;4249.08644641402;4250.851220207293;4278.893027674302;4308.3537469379535;4398.472183338004;4308.569143085698;4352.978235108836;4363;4367.890802729926;4406.713563618355;4186.685998550106;4196.895077623053;4265.38151967966;4274.893127671802;4289.206496798102;4289.270823959934;4291.506476755182;4292.1630282095;4334.046509767846;4338.869833904956;4259.552746961586;4277.379779931924;4280.785960701953;4296.162248361571;4300.333448315516;4385.758783266919;4455.487618923833;4550.726956382595;4617.8152873885;4633.907321853578;4943.209086546171;4957.752112394366;4969.204927211665;4970.527799859007;4997.100521906055;5012.097822391968;5021.924671129936;5022.522860328263;5025.1708468102715;5025.422076461217;4583.518730533279;4673.696209746389;4738.95261047392;4763.595094416944;4773.71357718538;5117.667351622133;5167.6641018333685;5182.818601348935;5186.144286192812;5186.870328241824;4794.089123066676;4968.90062198754;4970.254461830682;4972.378452693413;4991.900161996739;4984;5001.174806157016;5018.247262910592;5023.34696489454;5044.142495775727;4915.459299477055;4925.7783399747095;4970.72661003641;4971.130052240844;5026.346574945233;4959.082569724613;4962.280469331999;4963.305137280783;4969.304297398367;5025.623078269145;4144.544100148981;4200.306949353322;4208.158368326347;4214.178235244098;4216.5572614875;3720.534933133358;3741.382671859167;3751.7186211033736;3761.981190094032;3764.3976963685677;4260.4248426462655;4288.185244803477;4371.453568303962;4375.1031038637;4377.474703035656;5057.443681195065;5063.8987220255385;5064;5066.898662026739;5088.491150884882;4294.0767734937135;4334.696571240046;4335.674824388184;4357.9564204358185;4379.4525684289465;4384.232759267115;4505.864824055284;4554.795034223468;4570.154521413549;4595.747233902168;4674.439067311944;4678.368420263221;4678.836240731558;4693.929591056137;4726.550977657186;4901.632377571767;4908.8464210911125;4947.18371468718;4965.47862474435;4984.850454486371;4573.7713114344815;4756.785944632431;4795.496472870438;4829.034193161311;4854.320395144612;4947.975260123676;4965.056639238677;4971.6022718183185;4974.477679843564;5017.57350625201;4904.239842824368;5047.242913562848;5047.7476126192805;5051.166557517969;5107.540321371094;4878.390201224847;4879.609631229422;4899.559039686445;4931.087748766489;4946.579540738933;4826.396700412449;4829.372181616367;4830.661853670209;4832.782524786323;4875.43932447773;4696;4768.237082066853;4779;4783.067301876101;4819.807207711652;4775.570198682135;4780.282957556395;4812.831550895702;4851.32081508582;4859.271109333628;4673.252279635242;4677.345171676036;4687.10944920464;4688.226442636927;4726.598239149574 07:31:43 INFO - PROCESS | 18874 | |1;ext.html;579.0763731847701;599.7900734742841;607.9209702738643;622.486448679839;641.7882098907361;29856.104316870475;30491.99999999997;30532.389352212944;36173.095672608135;36342;38868.61131388685;39754.60245397545;39779.60220397802;39780;39853.20293594126;7610.505317154381;7817.218278172194;7822.569758663271;7824.843503129962;7835.804104897366;7731;7868.645910933993;7871.960640196791;7877.803054923644;7878;7824.178461261571;8050.355971522294;8051.879221811678;8052.516848989079;8056;7925.484843485184;7975.601219939038;7982.920170798276;7999.040115186186;8009.67961281548;7849.529028258323;7954.721584744506;7961.36309095271;7966.362690984707;7968.960155199245;39624.20751584952;40062.198756025005;40178.39732404016;40188.59811401878;40216.396754048714;3169.889053883126;3265.053134590966;3270.869165233388;3332.7500437467043;3732.6080761520193;29500.70499295001;30021;30087.849560752056;30716.846415768003;31661.20846978821;3174.904752857418;3212.14878057315;3213.5179723041497;3226.8060817497676;3244.0592228253777;243653;245541;246190;246204;246315.76842115854;30131.548026779616;30710.69289307123;52958;53546.46453535493;53844;30994.22514437112;31009;31029;31093.53359699606;31098.823082384468;13154.079214455087;13418.530351437848;13421.798673019912;13422.060455768002;13424.664383390298;11059;11156.776864462827;11203.943980280046;11209;11222.607208747655;7690.038745156856;8301.335893128535;8304.875426868603;8351.791205219919;8358.205970432798;3170.6036745406823;3220.6135263768497;3241.5137729340786;3248.3828072666593;3250.756193285513;905.3888625177979;913.3560839608193;923.3628796130648;1002.3584905660383;1031.6028329093203;28723.856380717963;29467.579863020717;29581;30269.545956810667;30335;1015.1067060986433;1047.0105750066114;1052.9789404211872;1089.6131873185063;1129.0741591894732;15411.537653870402;15777.921110394374;15893.205339732967;15909.920450397674;16223.26995285215;359229;360160;364201;365577;365929;51601.741991289804;52493.47506524886;52505.737471313165;52633.473665262856;52646.736766315924;1135.517405102828;1163.168334640719;1227.2943057741657;1257.3838818978634;1304.1350868258482;26344.209673709818;28527.42945141044;28604.570931435628;28765.137045888656;29309.26726831846;40259.3961090578;40414.393784092674;40691.7965410171;40769.59230407776;40804.38793418042;227511;229138;229424;229982;230776;21001.159953601684;23343.649845251995;23350.416239594146;23556.52886942286;25867.61198581985;37207.627923720414;37452.43821342736;37770.43344349892;38032.80983595175;39019;32091.197720057186;32512.837435813617;33065.338693226484;33166.834165829016;33405.16487087842;32693.34613307768;32745.743053402904;32783.67216327806;33255.667443325256;34542.48186277158;35631.10922226861;35775.28449431049;35799.82100089483;35887.82056089703;36189.63810361863;30954.84522577463;32434.67565324411;32702.182445439055;32754.836225819672;32760.836195819822;24406.971435377058;25056.24831255065;25085.24744257675;25134.748652513972;25172.74827251704 07:31:43 INFO - PROCESS | 18874 | |2;jquery.html;373.1585275204415;376.23436307115026;379.24855175700293;386.23139951496523;400.28149471698333;10539.894601053997;11251.381174035425;11264.493097810608;11274.774504509905;16224.351025958962;18136.63726725468;18892.716609250838;19085.904570477127;19363.515912102168;19649.50876228095;5606.635568688042;5884.323302820188;5936.317323507808;5938.495227905633;5941.376155503674;4047.372657238118;4312.245357062501;6609.239937407212;7021.508494405393;7033.5428197167275;6831.2144103428245;6954.617496037716;6985.476089293298;7009.649517524129;7009.719611215545;6760.459163266952;6950.930490695079;6969.54697944632;7007.824804379906;7009.299070093001;3842.231553689245;6417.229932408094;6828.0440738296675;6831.487638427137;6837.111175547197;22709.318720438412;22793.77206227933;23746.406339841644;23754.287371378887;23926.162584309466;2046.3656266557414;2135.9359219223293;2197.9340619781433;2482.8510289382516;2497.525470160682;13644;14180.361883715257;14279.071860329046;14314.928425357806;14864.256787160706;1869.6354210928873;2018.9697154542694;2019.858609897293;2048.8156065954136;2197.8021978022057;70935.64532177358;75018.24981750222;78318.21681783166;80962.59518702369;82338.17661823364;16307.755383669255;16488.587785305463;16756;17125.828741712423;17461.15854512005;30565.694343056286;30955.380892382025;31028.53457198144;31305.37389252202;31497.37005259928;8504.44721093127;9001.099890011077;9037.909620903838;9113.908860911306;9147.725568232963;7250.673719682627;7315.451341149435;7441.920921466357;7585.2035536269;7900.446968712135;7062.268951942024;8435.240828325357;8579.2707619853;8662;8953.508131828592;2960.763138948879;3434.914127146841;3455.585329760445;3602.603713591503;3658.4512323151207;933.9579718912665;947.4220725357526;949.4777872170279;995.681381957781;1020.5560581147224;16292;16405.42581009659;17117.657646846994;17196.484105476855;17220.930925561624;874.6545114679666;939.9953000234955;945.4043952310001;965.1169180200038;1004.8542961270721;9476.478793666414;9478.905210947802;9576.281778866613;9697.460426944255;9882.357646752938;380412;388742;394097;401036;402851.78611604247;78481.60759196282;81601.59199203966;82319.5884020576;82369.58815205886;83570.58214708888;981.8674478945394;1015.3755440404099;1039.0700323210683;1039.9896001040045;1048.0672201740458;15791.052536847827;15899.284532195848;15964.521064368088;16090;16465;32816;32889.34221315608;33362.33275334528;33859.153521161184;35404;42847.35728964006;47642.761786190844;48267;48692.269615956495;48990;7271.490995630466;7737.729179478692;8067.193280671886;8099;8173.918260817316;7140.214576396696;8448.155184481502;8534.307998042721;11122.165837562054;11212.775744485229;9277.768055798659;9676.661316853877;9794.118529332394;9999.700008999742;10443.321184123008;9262.814743705223;9474.194693451134;9499.95250023773;9622.951885240529;9655.468949207861;9125.133112354315;9285.97854236047;10139;10449.68650940473;10734.463276836283;7728.613569321399;7852.568108754073;7980.640871160927;8043.195680432144;8103.189681032086;5070.594352451869;6699.8325041872395;8628.827423451621;8628.96452425713;10176 07:31:43 INFO - PROCESS | 18874 | |3;mootools.html;1304.3217526886015;1462.444271176953;1495.947641832536;1648.6537827056318;1799.999999999999;6511.283758786536;7147.53541019834;7347.742829000986;7349.228331025232;7362;7097.85804283914;7259.201487836333;7266.455015873804;7270.491065625409;7273.745418910339;1859.2562974810048;2101.0440249686394;2111.7782632823564;2156.2453141400465;2184.541246338271;2197.4726065744185;2219.2676416782506;2221.9777802222015;2222.799948004679;2224.3882932193615;2139.5934772393275;2195.2865318771383;2195.7804219577993;2196.176433837311;2197.6483762597986;1835.6604028254749;2096.4968407582223;2175.3473957812594;2178.5425060737266;2181.901814418355;2016.0826823795137;2063.484128967758;2072.1814883121083;2073.5541858500496;2127.659574468093;7489.176190619028;7589.81025474362;7676.040494938133;7709.653065612061;7716.459847810655;4492.505824359318;4640.837570685044;4657.278121891112;4661.930071048937;4680.64895132863;2723.6459260296033;2738.3701748597737;2784.5405508091344;2872.7845411594003;2897.2901639098345;950.3680052764903;979.363413781048;983.9065288797552;988.9505524723735;992.9602815887428;10309.484525773682;10355.534000969974;10371.11845493134;10377.169826413869;10389.064984151388;4098.877033688994;4205.9789701051295;4275.5296917339065;4318.892027699333;4322.546132656089;8782.824343513223;8806.427582207136;8822.86765698515;8830.955845220733;8840.381173317935;4008.9799551002056;4644.512326205768;4689.531046895283;4737.407824021997;4738.691985020962;4063.5326937401987;4143.440635514227;4181.059261666162;4183.790810459525;4200.5169405518145;3628.9637103628625;3652.945205821915;3680.3375392429084;3708.0915175782106;3791.090138366772;1174.1663418972626;1179.7522520270668;1181.9645410637695;1196.216478206776;1202.4709127983658;666.3336663336663;757.2881491398068;769.8922150898878;862.7153039496951;863;4886.242632391985;4925.13810083234;4962.6774259673;4963.329950456642;4984.850454486371;417.38019041723624;417.83495519270326;422.008280540733;423.64202249099463;916.2624087609538;3461.2558299965626;3461.567304086989;3465.358908601917;3483.512308276843;3502.3520648680073;8732.214100730966;9090.545472726337;9099.226565741987;9099.454032758056;9207.98712141664;8987.325950553735;9035.909640903637;9105.043970383147;9106.27149828012;9121.680741174026;6994.195667498201;7271.67277472515;7276.235995220532;7341.743038993716;7374.889376659355;4930.087933732271;5061.215511595708;5100.285959965534;5241.921371179512;5282.683039017671;7985;8052.798680032812;8172.754817355489;8184.877226841483;8271.090180080308;7965.681372745025;8214.83570328602;8305.792355191168;8475.194856488624;8485.618147183268;5831.854203644773;6291.087792270187;6376.9043464349;6462.224533056064;6478.70845811949;7251.274872512707;7359.411247100112;7414.5551266922;7431.145418276751;7441.255874412515;6487.253965793805;6730.8653826924165;6818.897716534157;6822.965885170543;6921.2386637468835;6471.514636402195;6508.284088750328;6714.328567143442;6753.628550429577;6860.656967151723;6192.628442293477;6254.843628909131;6257.28041275241;6268.122462855295;6283.874322513616;4255.744655320566;4362.192994296065;4402.5597440255715;4407.9338809917235;4433.733975961452;4418.4035155254915;4458.71018383804;4471.955280447284;4512.9323060153465;4562.817487300471 07:31:43 INFO - PROCESS | 18874 | |4;prototype.html;311.9937601247975;312.9780915335926;313.8305315129829;316.4793914011453;319.32781494953133;4643.558861908122;4694.765261736917;4697.624190064791;4751.809927602892;4772.66591338606;4640.538230457403;4678.181318269298;4687.578117969382;4705.788239529221;4715.882102947419;3567.4292113261818;3614.114541937229;3703.2778608171416;3750.9812450937707;3806.143617686026;3752.793596352213;3776.093737503007;3789.2042671039117;3789.5263092113487;3806.0865392305786;3543.4330507118866;3737.4393840923944;3750.15621485165;3754.887353379403;3758.3047136279874;3594.5866225384025;3734.533183352081;3735.3089678409447;3747.681447077002;3749.8125093745475;3310.9834450827834;3329.8501567429525;3341.2649217172184;3359.344927739092;3361.83190840457;4516.570925762047;4519.706219095749;4520.480144783326;4521.005378816655;4540.18276710192;3991.560928297885;4239.342901850218;4253.425787518708;4268.829246830154;4276.48682158143;4928.950710492885;4933.260010998343;4939.506049395031;4963.45402005779;4966.5778408835295;3538.9115272118147;3549;3551.485034669984;3580.1228698968657;3583.372909740785;5002;5104.668196567211;5110.437851836332;5159.458256883011;5171.482851714836;3632.3824949758605;3633.5821380541047;3635.1457407509215;3638.472421498868;3651.079136690637;3674.191677830873;3677.282929828711;3705.9814700926863;3718.5537735471376;3722.758020728644;4189.874303770892;4193.748375097504;4195.49654041517;4197.895052623709;4219.514755803122;4844.4186697596515;4921.2864134700985;4942.332785073969;4947.861991741919;4982.9252561211615;1330.3813726616977;1335.5592654424017;1341.8188544546556;1344.9731005380033;1346.7171893902391;848.249299370062;894.874717539545;908.6274627402734;917.6421195733669;919.6091661044029;4535.501094879561;4551.658625603093;4597.3793537872625;4610.861674149781;4619.353290539327;5397.028534863763;5408.2969214002715;5413.864653383697;5416.93729702723;5419.187121931663;4422.358757980075;4561.840335588305;4582.450105987236;4604.608608268268;4618.815247390134;2839.105681710255;2863.9427211455654;2872.956905646417;2873.5258682317185;2875.7268059534313;5035.949640503548;5048.091343558195;5058.696478211319;5058.848234552969;5086.516780905882;5008.924866127011;5230.3985041719925;5253.001929633358;5455.1544510600925;5510.201020852034;4853.9029219416125;4878.755917241152;4881.365422495053;4893.73084480357;4898.338724272177;5132.3327967364;5138.383393992595;5170;5180.912008478262;5188.9740551297;4865.221564549655;5041.109583906035;5060.49395060491;5067.39191297032;5076.517730815566;4832.830850920201;4838.588719958843;4868.634852386156;4886.53577910098;4907.141250281258;3613.620569840129;3671.210689701727;3678.282734866675;3682.429223470366;3696.7042636589545;4966.528179822911;5148.510891465305;5177.974110129425;5209.635325527328;5214.687118772886;4980.551750342486;4994.225894986283;5005.1241032819835;5010.198368261061;5010.223415370623;4977.751112444291;4982.825601103944;4987.9750601248215;5013.724245166551;5028.949710502849;4638.327442520748;4649.488556258876;4957.677750946177;4994.650374473752;5007.924881126859;4830.637702172421;4971.875703107451;4981.227909674007;4997.625178111729;5013.222950442687;4887.144749668865;4915.43472500667;4941.703497790144;4943.480934501969;4956.355673762532 07:31:43 INFO - PROCESS | 18874 | |5;yui.html;652.9118568993186;711.9072224135953;750.2347605442449;753.56669914799;791.9652249856094;11948.223365481237;12399.442025108869;12581.433835477403;12584.622461326151;12611.369431528421;12086.818697719542;12119.27284362939;12176.330301833395;12186;12189.634310970663;689.1867596236439;837.7863644770575;852.6205838401913;868.2576397180383;871.4205053639354;858.1675774498757;868.8783570300163;869.5347988825979;869.9652013919467;870.9825803483926;909.5043201455189;914.6707185413246;915.3226612306878;917.2616044084509;917.669638929988;717.7990162754437;887.9156480134377;916.3768637326615;916.7478943290582;917.7017469322464;674.1068084787627;674.2919934069257;674.9865002699919;677.5663575311755;677.9830504237434;12648.304343261118;12714.491420343174;12718.809217861739;12736.23582585048;12739.42672579736;12748.872511274954;13385.598432047054;13443;13517.729645407135;13647.044706870523;10108.342957707799;10350.482475876175;10563.73590660232;10598.364098154058;10753.408562529057;3334.333133373311;3360.9831950840335;3412.436947903593;3434.5363375944426;3473.0449126490166;46073.53926460726;46569.767151164364;46702.29946550805;46846.53153468456;46959.295610565525;9818.607255709834;9824.564900025365;10239.48802559869;10374.22193335503;10388.48057597117;17363.56591085233;17619.119044048002;17634.206460709298;17677.38129165473;17686.20412081434;6925.79222623312;7169.89245161323;7172.175199852084;7196.784096477114;7316.0489136411925;3590.98204508981;3977.164795392942;4043.939340909889;4058.411530328145;4120.91758164841;2901.9709802901702;2949.616549848506;2960.1119664100684;2964.851757412164;2965.3920946205976;516.8139469790872;532.4037078472136;533.0777754484685;549.1241469855574;584.0275940559006;507.5127877237819;527.9181726832347;548.1065862643865;567.8296511046669;612.087988896541;7225;7281.417486601059;7491.138519070268;7561.848763024709;7581.355584775356;528.413461058225;616.4359610956014;628.1331762168179;637.744902039188;637.9553431259767;3414.293704493842;3568.678818906311;3646.0520264731363;3693.1136527233807;3738.813059347022;48602;49565;49596;50269.74865125651;50977;43344.13311733748;43782.34326485105;44371;44550.10899782051;46321;40265.396019059735;40599.797001014806;40924.79537602293;41093.38359924604;41121.58878411238;7219.675114619749;7284.963575182091;7297.525660832029;7322.121345438582;7503.673404551119;27864.442711145257;28328.15015549537;28516.57225141583;28906.710932891245;29514.262143446587;35414.29171416609;35511.82244088763;36614.8169259152;37036;37090;10906;10939.507722152362;10947.671569852917;11002.284851484628;11103.777924441627;11692.532298708296;11850.348230847041;12059.57791477294;12135.878641213474;12264.22168785539;11433.256838305484;11473.4263286837;11579.073674105883;11606.187566870238;12191.268523888595;11283.323000619988;11461.885381146081;11605.446801703612;11823.645290641294;11962.58130965412;11148.609798657008;11186.608468703556;11606.651800446;11610.6516804496;11624.418779061183;9320.95339523298;9537.52312384364;9697.9030209697;9860.802783944138;9884.209263259067;9656.179224765974;9668.323217374716;9748.85376719364;9850.162736167505;9950.651727189514 07:31:43 INFO - PROCESS | 18874 | __end_tp_report 07:31:43 INFO - PROCESS | 18874 | __start_cc_report 07:31:43 INFO - PROCESS | 18874 | _x_x_mozilla_cycle_collect,860 07:31:43 INFO - PROCESS | 18874 | __end_cc_report 07:31:43 INFO - PROCESS | 18874 | __startTimestamp1462458703340__endTimestamp 07:31:43 INFO - PROCESS | 18874 | 07:31:43 INFO - PROCESS | 18874 | ------- Summary: start ------- 07:31:43 INFO - PROCESS | 18874 | Number of tests: 6 07:31:43 INFO - PROCESS | 18874 | 07:31:43 INFO - PROCESS | 18874 | [#0] dojo.html Cycles:165 Average:4615.68 Median:4746.67 stddev:482.93 (10.2%) stddev-sans-first:456.38 07:31:43 INFO - PROCESS | 18874 | Values: 2548.5 2614.8 2619.9 2645.4 2654.8 4473.3 4559.6 4571.4 4574.3 4592.2 4681.1 4705.6 4746.7 4771.6 4787.5 4249.1 4250.9 4278.9 4308.4 4398.5 4308.6 4353.0 4363.0 4367.9 4406.7 4186.7 4196.9 4265.4 4274.9 4289.2 4289.3 4291.5 4292.2 4334.0 4338.9 4259.6 4277.4 4280.8 4296.2 4300.3 4385.8 4455.5 4550.7 4617.8 4633.9 4943.2 4957.8 4969.2 4970.5 4997.1 5012.1 5021.9 5022.5 5025.2 5025.4 4583.5 4673.7 4739.0 4763.6 4773.7 5117.7 5167.7 5182.8 5186.1 5186.9 4794.1 4968.9 4970.3 4972.4 4991.9 4984.0 5001.2 5018.2 5023.3 5044.1 4915.5 4925.8 4970.7 4971.1 5026.3 4959.1 4962.3 4963.3 4969.3 5025.6 4144.5 4200.3 4208.2 4214.2 4216.6 3720.5 3741.4 3751.7 3762.0 3764.4 4260.4 4288.2 4371.5 4375.1 4377.5 5057.4 5063.9 5064.0 5066.9 5088.5 4294.1 4334.7 4335.7 4358.0 4379.5 4384.2 4505.9 4554.8 4570.2 4595.7 4674.4 4678.4 4678.8 4693.9 4726.6 4901.6 4908.8 4947.2 4965.5 4984.9 4573.8 4756.8 4795.5 4829.0 4854.3 4948.0 4965.1 4971.6 4974.5 5017.6 4904.2 5047.2 5047.7 5051.2 5107.5 4878.4 4879.6 4899.6 4931.1 4946.6 4826.4 4829.4 4830.7 4832.8 4875.4 4696.0 4768.2 4779.0 4783.1 4819.8 4775.6 4780.3 4812.8 4851.3 4859.3 4673.3 4677.3 4687.1 4688.2 4726.6 07:31:43 INFO - PROCESS | 18874 | 07:31:43 INFO - PROCESS | 18874 | [#1] ext.html Cycles:180 Average:42478.88 Median:32723.96 stddev:75142.93 (229.6%) stddev-sans-first:75287.87 07:31:43 INFO - PROCESS | 18874 | Values: 579.1 599.8 607.9 622.5 641.8 29856.1 30492.0 30532.4 36173.1 36342.0 38868.6 39754.6 39779.6 39780.0 39853.2 7610.5 7817.2 7822.6 7824.8 7835.8 7731.0 7868.6 7872.0 7877.8 7878.0 7824.2 8050.4 8051.9 8052.5 8056.0 7925.5 7975.6 7982.9 7999.0 8009.7 7849.5 7954.7 7961.4 7966.4 7969.0 39624.2 40062.2 40178.4 40188.6 40216.4 3169.9 3265.1 3270.9 3332.8 3732.6 29500.7 30021.0 30087.8 30716.8 31661.2 3174.9 3212.1 3213.5 3226.8 3244.1 243653.0 245541.0 246190.0 246204.0 246315.8 30131.5 30710.7 52958.0 53546.5 53844.0 30994.2 31009.0 31029.0 31093.5 31098.8 13154.1 13418.5 13421.8 13422.1 13424.7 11059.0 11156.8 11203.9 11209.0 11222.6 7690.0 8301.3 8304.9 8351.8 8358.2 3170.6 3220.6 3241.5 3248.4 3250.8 905.4 913.4 923.4 1002.4 1031.6 28723.9 29467.6 29581.0 30269.5 30335.0 1015.1 1047.0 1053.0 1089.6 1129.1 15411.5 15777.9 15893.2 15909.9 16223.3 359229.0 360160.0 364201.0 365577.0 365929.0 51601.7 52493.5 52505.7 52633.5 52646.7 1135.5 1163.2 1227.3 1257.4 1304.1 26344.2 28527.4 28604.6 28765.1 29309.3 40259.4 40414.4 40691.8 40769.6 40804.4 227511.0 229138.0 229424.0 229982.0 230776.0 21001.2 23343.6 23350.4 23556.5 25867.6 37207.6 37452.4 37770.4 38032.8 39019.0 32091.2 32512.8 33065.3 33166.8 33405.2 32693.3 32745.7 32783.7 33255.7 34542.5 35631.1 35775.3 35799.8 35887.8 36189.6 30954.8 32434.7 32702.2 32754.8 32760.8 24407.0 25056.2 25085.2 25134.7 25172.7 07:31:43 INFO - PROCESS | 18874 | 07:31:43 INFO - PROCESS | 18874 | [#2] jquery.html Cycles:180 Average:25626.32 Median:27030.30 stddev:65038.39 (240.6%) stddev-sans-first:65193.20 07:31:43 INFO - PROCESS | 18874 | Values: 373.2 376.2 379.2 386.2 400.3 10539.9 11251.4 11264.5 11274.8 16224.4 18136.6 18892.7 19085.9 19363.5 19649.5 5606.6 5884.3 5936.3 5938.5 5941.4 4047.4 4312.2 6609.2 7021.5 7033.5 6831.2 6954.6 6985.5 7009.6 7009.7 6760.5 6950.9 6969.5 7007.8 7009.3 3842.2 6417.2 6828.0 6831.5 6837.1 22709.3 22793.8 23746.4 23754.3 23926.2 2046.4 2135.9 2197.9 2482.9 2497.5 13644.0 14180.4 14279.1 14314.9 14864.3 1869.6 2019.0 2019.9 2048.8 2197.8 70935.6 75018.2 78318.2 80962.6 82338.2 16307.8 16488.6 16756.0 17125.8 17461.2 30565.7 30955.4 31028.5 31305.4 31497.4 8504.4 9001.1 9037.9 9113.9 9147.7 7250.7 7315.5 7441.9 7585.2 7900.4 7062.3 8435.2 8579.3 8662.0 8953.5 2960.8 3434.9 3455.6 3602.6 3658.5 934.0 947.4 949.5 995.7 1020.6 16292.0 16405.4 17117.7 17196.5 17220.9 874.7 940.0 945.4 965.1 1004.9 9476.5 9478.9 9576.3 9697.5 9882.4 380412.0 388742.0 394097.0 401036.0 402851.8 78481.6 81601.6 82319.6 82369.6 83570.6 981.9 1015.4 1039.1 1040.0 1048.1 15791.1 15899.3 15964.5 16090.0 16465.0 32816.0 32889.3 33362.3 33859.2 35404.0 42847.4 47642.8 48267.0 48692.3 48990.0 7271.5 7737.7 8067.2 8099.0 8173.9 7140.2 8448.2 8534.3 11122.2 11212.8 9277.8 9676.7 9794.1 9999.7 10443.3 9262.8 9474.2 9500.0 9623.0 9655.5 9125.1 9286.0 10139.0 10449.7 10734.5 7728.6 7852.6 7980.6 8043.2 8103.2 5070.6 6699.8 8628.8 8629.0 10176.0 07:31:43 INFO - PROCESS | 18874 | 07:31:43 INFO - PROCESS | 18874 | [#3] mootools.html Cycles:180 Average:4957.34 Median:4927.61 stddev:2728.83 (55.4%) stddev-sans-first:2722.67 07:31:43 INFO - PROCESS | 18874 | Values: 1304.3 1462.4 1495.9 1648.7 1800.0 6511.3 7147.5 7347.7 7349.2 7362.0 7097.9 7259.2 7266.5 7270.5 7273.7 1859.3 2101.0 2111.8 2156.2 2184.5 2197.5 2219.3 2222.0 2222.8 2224.4 2139.6 2195.3 2195.8 2196.2 2197.6 1835.7 2096.5 2175.3 2178.5 2181.9 2016.1 2063.5 2072.2 2073.6 2127.7 7489.2 7589.8 7676.0 7709.7 7716.5 4492.5 4640.8 4657.3 4661.9 4680.6 2723.6 2738.4 2784.5 2872.8 2897.3 950.4 979.4 983.9 989.0 993.0 10309.5 10355.5 10371.1 10377.2 10389.1 4098.9 4206.0 4275.5 4318.9 4322.5 8782.8 8806.4 8822.9 8831.0 8840.4 4009.0 4644.5 4689.5 4737.4 4738.7 4063.5 4143.4 4181.1 4183.8 4200.5 3629.0 3652.9 3680.3 3708.1 3791.1 1174.2 1179.8 1182.0 1196.2 1202.5 666.3 757.3 769.9 862.7 863.0 4886.2 4925.1 4962.7 4963.3 4984.9 417.4 417.8 422.0 423.6 916.3 3461.3 3461.6 3465.4 3483.5 3502.4 8732.2 9090.5 9099.2 9099.5 9208.0 8987.3 9035.9 9105.0 9106.3 9121.7 6994.2 7271.7 7276.2 7341.7 7374.9 4930.1 5061.2 5100.3 5241.9 5282.7 7985.0 8052.8 8172.8 8184.9 8271.1 7965.7 8214.8 8305.8 8475.2 8485.6 5831.9 6291.1 6376.9 6462.2 6478.7 7251.3 7359.4 7414.6 7431.1 7441.3 6487.3 6730.9 6818.9 6823.0 6921.2 6471.5 6508.3 6714.3 6753.6 6860.7 6192.6 6254.8 6257.3 6268.1 6283.9 4255.7 4362.2 4402.6 4407.9 4433.7 4418.4 4458.7 4472.0 4512.9 4562.8 07:31:43 INFO - PROCESS | 18874 | 07:31:43 INFO - PROCESS | 18874 | [#4] prototype.html Cycles:180 Average:4173.34 Median:4691.17 stddev:1197.86 (25.5%) stddev-sans-first:1165.63 07:31:43 INFO - PROCESS | 18874 | Values: 312.0 313.0 313.8 316.5 319.3 4643.6 4694.8 4697.6 4751.8 4772.7 4640.5 4678.2 4687.6 4705.8 4715.9 3567.4 3614.1 3703.3 3751.0 3806.1 3752.8 3776.1 3789.2 3789.5 3806.1 3543.4 3737.4 3750.2 3754.9 3758.3 3594.6 3734.5 3735.3 3747.7 3749.8 3311.0 3329.9 3341.3 3359.3 3361.8 4516.6 4519.7 4520.5 4521.0 4540.2 3991.6 4239.3 4253.4 4268.8 4276.5 4929.0 4933.3 4939.5 4963.5 4966.6 3538.9 3549.0 3551.5 3580.1 3583.4 5002.0 5104.7 5110.4 5159.5 5171.5 3632.4 3633.6 3635.1 3638.5 3651.1 3674.2 3677.3 3706.0 3718.6 3722.8 4189.9 4193.7 4195.5 4197.9 4219.5 4844.4 4921.3 4942.3 4947.9 4982.9 1330.4 1335.6 1341.8 1345.0 1346.7 848.2 894.9 908.6 917.6 919.6 4535.5 4551.7 4597.4 4610.9 4619.4 5397.0 5408.3 5413.9 5416.9 5419.2 4422.4 4561.8 4582.5 4604.6 4618.8 2839.1 2863.9 2873.0 2873.5 2875.7 5035.9 5048.1 5058.7 5058.8 5086.5 5008.9 5230.4 5253.0 5455.2 5510.2 4853.9 4878.8 4881.4 4893.7 4898.3 5132.3 5138.4 5170.0 5180.9 5189.0 4865.2 5041.1 5060.5 5067.4 5076.5 4832.8 4838.6 4868.6 4886.5 4907.1 3613.6 3671.2 3678.3 3682.4 3696.7 4966.5 5148.5 5178.0 5209.6 5214.7 4980.6 4994.2 5005.1 5010.2 5010.2 4977.8 4982.8 4988.0 5013.7 5028.9 4638.3 4649.5 4957.7 4994.7 5007.9 4830.6 4971.9 4981.2 4997.6 5013.2 4887.1 4915.4 4941.7 4943.5 4956.4 07:31:43 INFO - PROCESS | 18874 | 07:31:43 INFO - PROCESS | 18874 | [#5] yui.html Cycles:180 Average:12640.57 Median:41107.49 stddev:13904.15 (33.8%) stddev-sans-first:13914.01 07:31:43 INFO - PROCESS | 18874 | Values: 652.9 711.9 750.2 753.6 792.0 11948.2 12399.4 12581.4 12584.6 12611.4 12086.8 12119.3 12176.3 12186.0 12189.6 689.2 837.8 852.6 868.3 871.4 858.2 868.9 869.5 870.0 871.0 909.5 914.7 915.3 917.3 917.7 717.8 887.9 916.4 916.7 917.7 674.1 674.3 675.0 677.6 678.0 12648.3 12714.5 12718.8 12736.2 12739.4 12748.9 13385.6 13443.0 13517.7 13647.0 10108.3 10350.5 10563.7 10598.4 10753.4 3334.3 3361.0 3412.4 3434.5 3473.0 46073.5 46569.8 46702.3 46846.5 46959.3 9818.6 9824.6 10239.5 10374.2 10388.5 17363.6 17619.1 17634.2 17677.4 17686.2 6925.8 7169.9 7172.2 7196.8 7316.0 3591.0 3977.2 4043.9 4058.4 4120.9 2902.0 2949.6 2960.1 2964.9 2965.4 516.8 532.4 533.1 549.1 584.0 507.5 527.9 548.1 567.8 612.1 7225.0 7281.4 7491.1 7561.8 7581.4 528.4 616.4 628.1 637.7 638.0 3414.3 3568.7 3646.1 3693.1 3738.8 48602.0 49565.0 49596.0 50269.7 50977.0 43344.1 43782.3 44371.0 44550.1 46321.0 40265.4 40599.8 40924.8 41093.4 41121.6 7219.7 7285.0 7297.5 7322.1 7503.7 27864.4 28328.2 28516.6 28906.7 29514.3 35414.3 35511.8 36614.8 37036.0 37090.0 10906.0 10939.5 10947.7 11002.3 11103.8 11692.5 11850.3 12059.6 12135.9 12264.2 11433.3 11473.4 11579.1 11606.2 12191.3 11283.3 11461.9 11605.4 11823.6 11962.6 11148.6 11186.6 11606.7 11610.7 11624.4 9321.0 9537.5 9697.9 9860.8 9884.2 9656.2 9668.3 9748.9 9850.2 9950.7 07:31:43 INFO - PROCESS | 18874 | -------- Summary: end -------- 07:31:43 INFO - PROCESS | 18874 | 07:31:44 INFO - TEST-INFO | 18874: exit 0 07:31:44 INFO - TEST-OK | dromaeo_css | took 1117539ms 07:31:44 INFO - TEST-START | kraken 07:31:44 INFO - operating with platform_type : linux_ 07:31:44 INFO - Initialising browser for kraken test... 07:31:44 INFO - TEST-INFO | started process 19062 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxhEUS2/profile http://localhost:55462/getInfo.html) 07:31:48 INFO - PROCESS | 19062 | __metrics Screen width/height:1600/1200 07:31:48 INFO - PROCESS | 19062 | colorDepth:24 07:31:48 INFO - PROCESS | 19062 | Browser inner width/height: 1024/697 07:31:48 INFO - PROCESS | 19062 | __metrics 07:31:49 ERROR - PROCESS | 19062 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:31:50 INFO - TEST-INFO | 19062: exit 0 07:31:50 INFO - Browser initialized. 07:31:50 INFO - Running cycle 1/1 for kraken test... 07:31:50 INFO - TEST-INFO | started process 19143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxhEUS2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:32:02 INFO - PROCESS | 19143 | RSS: Main: 157065216 07:32:02 INFO - PROCESS | 19143 | 07:32:04 INFO - PROCESS | 19143 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55462/tests/kraken/driver.html?testName=audio-beat-detection) 07:32:05 INFO - PROCESS | 19143 | RSS: Main: 212008960 07:32:05 INFO - PROCESS | 19143 | 07:32:08 INFO - PROCESS | 19143 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55462/tests/kraken/driver.html?testName=audio-dft) 07:32:09 INFO - PROCESS | 19143 | RSS: Main: 197656576 07:32:09 INFO - PROCESS | 19143 | 07:32:12 INFO - PROCESS | 19143 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55462/tests/kraken/driver.html?testName=audio-fft) 07:32:12 INFO - PROCESS | 19143 | RSS: Main: 268263424 07:32:12 INFO - PROCESS | 19143 | 07:32:15 INFO - PROCESS | 19143 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55462/tests/kraken/driver.html?testName=audio-oscillator) 07:32:15 INFO - PROCESS | 19143 | RSS: Main: 175796224 07:32:15 INFO - PROCESS | 19143 | 07:32:17 INFO - PROCESS | 19143 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55462/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:32:18 INFO - PROCESS | 19143 | RSS: Main: 179847168 07:32:18 INFO - PROCESS | 19143 | 07:32:21 INFO - PROCESS | 19143 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55462/tests/kraken/driver.html?testName=imaging-darkroom) 07:32:22 INFO - PROCESS | 19143 | RSS: Main: 215760896 07:32:22 INFO - PROCESS | 19143 | 07:32:25 INFO - PROCESS | 19143 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55462/tests/kraken/driver.html?testName=imaging-desaturate) 07:32:26 INFO - PROCESS | 19143 | RSS: Main: 217202688 07:32:26 INFO - PROCESS | 19143 | 07:32:29 INFO - PROCESS | 19143 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55462/tests/kraken/driver.html?testName=json-parse-financial) 07:32:29 INFO - PROCESS | 19143 | RSS: Main: 216477696 07:32:29 INFO - PROCESS | 19143 | 07:32:31 INFO - PROCESS | 19143 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55462/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:32:32 INFO - PROCESS | 19143 | RSS: Main: 204742656 07:32:32 INFO - PROCESS | 19143 | 07:32:33 INFO - PROCESS | 19143 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55462/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:32:34 INFO - PROCESS | 19143 | RSS: Main: 206401536 07:32:34 INFO - PROCESS | 19143 | 07:32:36 INFO - PROCESS | 19143 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55462/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:32:37 INFO - PROCESS | 19143 | RSS: Main: 218939392 07:32:37 INFO - PROCESS | 19143 | 07:32:40 INFO - PROCESS | 19143 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:32:40 INFO - PROCESS | 19143 | RSS: Main: 226004992 07:32:40 INFO - PROCESS | 19143 | 07:32:43 INFO - PROCESS | 19143 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:32:44 INFO - PROCESS | 19143 | RSS: Main: 220807168 07:32:44 INFO - PROCESS | 19143 | 07:32:46 INFO - PROCESS | 19143 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55462/tests/kraken/driver.html?testName=ai-astar) 07:32:46 INFO - PROCESS | 19143 | RSS: Main: 284405760 07:32:46 INFO - PROCESS | 19143 | 07:32:46 INFO - PROCESS | 19143 | __start_tp_report 07:32:46 INFO - PROCESS | 19143 | _x_x_mozilla_page_load 07:32:46 INFO - PROCESS | 19143 | _x_x_mozilla_page_load_details 07:32:46 INFO - PROCESS | 19143 | |i|pagename|runs| 07:32:46 INFO - PROCESS | 19143 | |0;ai-astar;113;115;110;115;114;114;103;114;114;115 07:32:46 INFO - PROCESS | 19143 | |1;audio-beat-detection;163;132;156;183;132;162;154;134;184;136 07:32:46 INFO - PROCESS | 19143 | |2;audio-dft;161;160;161;160;163;160;161;162;161;164 07:32:46 INFO - PROCESS | 19143 | |3;audio-fft;74;74;102;108;75;73;73;109;104;74 07:32:46 INFO - PROCESS | 19143 | |4;audio-oscillator;94;95;150;95;95;94;151;94;92;143 07:32:46 INFO - PROCESS | 19143 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;117;117 07:32:46 INFO - PROCESS | 19143 | |6;imaging-darkroom;147;148;146;147;147;147;147;146;146;146 07:32:46 INFO - PROCESS | 19143 | |7;imaging-desaturate;95;95;94;95;95;95;94;95;95;94 07:32:46 INFO - PROCESS | 19143 | |8;json-parse-financial;67;68;69;66;67;67;67;82;66;65 07:32:46 INFO - PROCESS | 19143 | |9;json-stringify-tinderbox;65;64;65;64;65;64;64;65;64;64 07:32:46 INFO - PROCESS | 19143 | |10;stanford-crypto-aes;86;81;79;79;82;81;82;81;82;81 07:32:46 INFO - PROCESS | 19143 | |11;stanford-crypto-ccm;138;131;132;129;130;134;128;135;170;133 07:32:46 INFO - PROCESS | 19143 | |12;stanford-crypto-pbkdf2;186;176;183;185;181;180;179;183;183;187 07:32:46 INFO - PROCESS | 19143 | |13;stanford-crypto-sha256-iterative;74;75;72;73;72;72;71;75;74;72 07:32:46 INFO - PROCESS | 19143 | __end_tp_report 07:32:46 INFO - PROCESS | 19143 | __start_cc_report 07:32:46 INFO - PROCESS | 19143 | _x_x_mozilla_cycle_collect,1879 07:32:46 INFO - PROCESS | 19143 | __end_cc_report 07:32:46 INFO - PROCESS | 19143 | __startTimestamp1462458766526__endTimestamp 07:32:46 INFO - PROCESS | 19143 | 07:32:46 INFO - PROCESS | 19143 | ------- Summary: start ------- 07:32:46 INFO - PROCESS | 19143 | Number of tests: 14 07:32:46 INFO - PROCESS | 19143 | 07:32:46 INFO - PROCESS | 19143 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.71 (3.3%) stddev-sans-first:3.94 07:32:46 INFO - PROCESS | 19143 | Values: 113.0 115.0 110.0 115.0 114.0 114.0 103.0 114.0 114.0 115.0 07:32:46 INFO - PROCESS | 19143 | 07:32:46 INFO - PROCESS | 19143 | [#1] audio-beat-detection Cycles:10 Average:153.60 Median:159.00 stddev:19.95 (12.5%) stddev-sans-first:20.86 07:32:46 INFO - PROCESS | 19143 | Values: 163.0 132.0 156.0 183.0 132.0 162.0 154.0 134.0 184.0 136.0 07:32:46 INFO - PROCESS | 19143 | 07:32:46 INFO - PROCESS | 19143 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.34 (0.8%) stddev-sans-first:1.41 07:32:46 INFO - PROCESS | 19143 | Values: 161.0 160.0 161.0 160.0 163.0 160.0 161.0 162.0 161.0 164.0 07:32:46 INFO - PROCESS | 19143 | 07:32:46 INFO - PROCESS | 19143 | [#3] audio-fft Cycles:10 Average:86.60 Median:73.50 stddev:16.60 (22.6%) stddev-sans-first:16.97 07:32:46 INFO - PROCESS | 19143 | Values: 74.0 74.0 102.0 108.0 75.0 73.0 73.0 109.0 104.0 74.0 07:32:46 INFO - PROCESS | 19143 | 07:32:46 INFO - PROCESS | 19143 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:94.00 stddev:26.11 (27.8%) stddev-sans-first:27.02 07:32:46 INFO - PROCESS | 19143 | Values: 94.0 95.0 150.0 95.0 95.0 94.0 151.0 94.0 92.0 143.0 07:32:46 INFO - PROCESS | 19143 | 07:32:46 INFO - PROCESS | 19143 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 07:32:46 INFO - PROCESS | 19143 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 07:32:46 INFO - PROCESS | 19143 | 07:32:46 INFO - PROCESS | 19143 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 07:32:46 INFO - PROCESS | 19143 | Values: 147.0 148.0 146.0 147.0 147.0 147.0 147.0 146.0 146.0 146.0 07:32:46 INFO - PROCESS | 19143 | 07:32:46 INFO - PROCESS | 19143 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:32:46 INFO - PROCESS | 19143 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 07:32:46 INFO - PROCESS | 19143 | 07:32:46 INFO - PROCESS | 19143 | [#8] json-parse-financial Cycles:10 Average:68.40 Median:67.00 stddev:4.90 (7.3%) stddev-sans-first:5.17 07:32:46 INFO - PROCESS | 19143 | Values: 67.0 68.0 69.0 66.0 67.0 67.0 67.0 82.0 66.0 65.0 07:32:46 INFO - PROCESS | 19143 | 07:32:46 INFO - PROCESS | 19143 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 07:32:46 INFO - PROCESS | 19143 | Values: 65.0 64.0 65.0 64.0 65.0 64.0 64.0 65.0 64.0 64.0 07:32:46 INFO - PROCESS | 19143 | 07:32:46 INFO - PROCESS | 19143 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.50 stddev:1.96 (2.4%) stddev-sans-first:1.17 07:32:46 INFO - PROCESS | 19143 | Values: 86.0 81.0 79.0 79.0 82.0 81.0 82.0 81.0 82.0 81.0 07:32:46 INFO - PROCESS | 19143 | 07:32:46 INFO - PROCESS | 19143 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:133.50 stddev:12.31 (9.2%) stddev-sans-first:13.04 07:32:46 INFO - PROCESS | 19143 | Values: 138.0 131.0 132.0 129.0 130.0 134.0 128.0 135.0 170.0 133.0 07:32:46 INFO - PROCESS | 19143 | 07:32:46 INFO - PROCESS | 19143 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.30 Median:183.00 stddev:3.37 (1.8%) stddev-sans-first:3.30 07:32:46 INFO - PROCESS | 19143 | Values: 186.0 176.0 183.0 185.0 181.0 180.0 179.0 183.0 183.0 187.0 07:32:46 INFO - PROCESS | 19143 | 07:32:46 INFO - PROCESS | 19143 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:73.50 stddev:1.41 (1.9%) stddev-sans-first:1.45 07:32:46 INFO - PROCESS | 19143 | Values: 74.0 75.0 72.0 73.0 72.0 72.0 71.0 75.0 74.0 72.0 07:32:46 INFO - PROCESS | 19143 | -------- Summary: end -------- 07:32:46 INFO - PROCESS | 19143 | 07:32:47 INFO - TEST-INFO | 19143: exit 0 07:32:47 INFO - TEST-OK | kraken | took 63444ms 07:32:47 INFO - SUITE-END | took 1180s 07:32:47 INFO - Completed test suite (00:19:41) 07:32:47 INFO - javascript benchmark 07:32:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2548.4759016916687, 2614.8431094134353, 2619.908303209388, 2645.4047839236164, 2654.7610715035644, 4473.26191178456, 4559.612432943196, 4571.360009598655, 4574.31385292206, 4592.242280023796, 4681.133990211813, 4705.647076469261, 4746.667733258673, 4771.570558649721, 4787.49731278216, 4249.08644641402, 4250.851220207293, 4278.893027674302, 4308.3537469379535, 4398.472183338004, 4308.569143085698, 4352.978235108836, 4363.0, 4367.890802729926, 4406.713563618355, 4186.685998550106, 4196.895077623053, 4265.38151967966, 4274.893127671802, 4289.206496798102, 4289.270823959934, 4291.506476755182, 4292.1630282095, 4334.046509767846, 4338.869833904956, 4259.552746961586, 4277.379779931924, 4280.785960701953, 4296.162248361571, 4300.333448315516, 4385.758783266919, 4455.487618923833, 4550.726956382595, 4617.8152873885, 4633.907321853578, 4943.209086546171, 4957.752112394366, 4969.204927211665, 4970.527799859007, 4997.100521906055, 5012.097822391968, 5021.924671129936, 5022.522860328263, 5025.1708468102715, 5025.422076461217, 4583.518730533279, 4673.696209746389, 4738.95261047392, 4763.595094416944, 4773.71357718538, 5117.667351622133, 5167.6641018333685, 5182.818601348935, 5186.144286192812, 5186.870328241824, 4794.089123066676, 4968.90062198754, 4970.254461830682, 4972.378452693413, 4991.900161996739, 4984.0, 5001.174806157016, 5018.247262910592, 5023.34696489454, 5044.142495775727, 4915.459299477055, 4925.7783399747095, 4970.72661003641, 4971.130052240844, 5026.346574945233, 4959.082569724613, 4962.280469331999, 4963.305137280783, 4969.304297398367, 5025.623078269145, 4144.544100148981, 4200.306949353322, 4208.158368326347, 4214.178235244098, 4216.5572614875, 3720.534933133358, 3741.382671859167, 3751.7186211033736, 3761.981190094032, 3764.3976963685677, 4260.4248426462655, 4288.185244803477, 4371.453568303962, 4375.1031038637, 4377.474703035656, 5057.443681195065, 5063.8987220255385, 5064.0, 5066.898662026739, 5088.491150884882, 4294.0767734937135, 4334.696571240046, 4335.674824388184, 4357.9564204358185, 4379.4525684289465, 4384.232759267115, 4505.864824055284, 4554.795034223468, 4570.154521413549, 4595.747233902168, 4674.439067311944, 4678.368420263221, 4678.836240731558, 4693.929591056137, 4726.550977657186, 4901.632377571767, 4908.8464210911125, 4947.18371468718, 4965.47862474435, 4984.850454486371, 4573.7713114344815, 4756.785944632431, 4795.496472870438, 4829.034193161311, 4854.320395144612, 4947.975260123676, 4965.056639238677, 4971.6022718183185, 4974.477679843564, 5017.57350625201, 4904.239842824368, 5047.242913562848, 5047.7476126192805, 5051.166557517969, 5107.540321371094, 4878.390201224847, 4879.609631229422, 4899.559039686445, 4931.087748766489, 4946.579540738933, 4826.396700412449, 4829.372181616367, 4830.661853670209, 4832.782524786323, 4875.43932447773, 4696.0, 4768.237082066853, 4779.0, 4783.067301876101, 4819.807207711652, 4775.570198682135, 4780.282957556395, 4812.831550895702, 4851.32081508582, 4859.271109333628, 4673.252279635242, 4677.345171676036, 4687.10944920464, 4688.226442636927, 4726.598239149574], "value": 4585.037626394719, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.0763731847701, 599.7900734742841, 607.9209702738643, 622.486448679839, 641.7882098907361, 29856.104316870475, 30491.99999999997, 30532.389352212944, 36173.095672608135, 36342.0, 38868.61131388685, 39754.60245397545, 39779.60220397802, 39780.0, 39853.20293594126, 7610.505317154381, 7817.218278172194, 7822.569758663271, 7824.843503129962, 7835.804104897366, 7731.0, 7868.645910933993, 7871.960640196791, 7877.803054923644, 7878.0, 7824.178461261571, 8050.355971522294, 8051.879221811678, 8052.516848989079, 8056.0, 7925.484843485184, 7975.601219939038, 7982.920170798276, 7999.040115186186, 8009.67961281548, 7849.529028258323, 7954.721584744506, 7961.36309095271, 7966.362690984707, 7968.960155199245, 39624.20751584952, 40062.198756025005, 40178.39732404016, 40188.59811401878, 40216.396754048714, 3169.889053883126, 3265.053134590966, 3270.869165233388, 3332.7500437467043, 3732.6080761520193, 29500.70499295001, 30021.0, 30087.849560752056, 30716.846415768003, 31661.20846978821, 3174.904752857418, 3212.14878057315, 3213.5179723041497, 3226.8060817497676, 3244.0592228253777, 243653.0, 245541.0, 246190.0, 246204.0, 246315.76842115854, 30131.548026779616, 30710.69289307123, 52958.0, 53546.46453535493, 53844.0, 30994.22514437112, 31009.0, 31029.0, 31093.53359699606, 31098.823082384468, 13154.079214455087, 13418.530351437848, 13421.798673019912, 13422.060455768002, 13424.664383390298, 11059.0, 11156.776864462827, 11203.943980280046, 11209.0, 11222.607208747655, 7690.038745156856, 8301.335893128535, 8304.875426868603, 8351.791205219919, 8358.205970432798, 3170.6036745406823, 3220.6135263768497, 3241.5137729340786, 3248.3828072666593, 3250.756193285513, 905.3888625177979, 913.3560839608193, 923.3628796130648, 1002.3584905660383, 1031.6028329093203, 28723.856380717963, 29467.579863020717, 29581.0, 30269.545956810667, 30335.0, 1015.1067060986433, 1047.0105750066114, 1052.9789404211872, 1089.6131873185063, 1129.0741591894732, 15411.537653870402, 15777.921110394374, 15893.205339732967, 15909.920450397674, 16223.26995285215, 359229.0, 360160.0, 364201.0, 365577.0, 365929.0, 51601.741991289804, 52493.47506524886, 52505.737471313165, 52633.473665262856, 52646.736766315924, 1135.517405102828, 1163.168334640719, 1227.2943057741657, 1257.3838818978634, 1304.1350868258482, 26344.209673709818, 28527.42945141044, 28604.570931435628, 28765.137045888656, 29309.26726831846, 40259.3961090578, 40414.393784092674, 40691.7965410171, 40769.59230407776, 40804.38793418042, 227511.0, 229138.0, 229424.0, 229982.0, 230776.0, 21001.159953601684, 23343.649845251995, 23350.416239594146, 23556.52886942286, 25867.61198581985, 37207.627923720414, 37452.43821342736, 37770.43344349892, 38032.80983595175, 39019.0, 32091.197720057186, 32512.837435813617, 33065.338693226484, 33166.834165829016, 33405.16487087842, 32693.34613307768, 32745.743053402904, 32783.67216327806, 33255.667443325256, 34542.48186277158, 35631.10922226861, 35775.28449431049, 35799.82100089483, 35887.82056089703, 36189.63810361863, 30954.84522577463, 32434.67565324411, 32702.182445439055, 32754.836225819672, 32760.836195819822, 24406.971435377058, 25056.24831255065, 25085.24744257675, 25134.748652513972, 25172.74827251704], "value": 16204.238838902413, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.1585275204415, 376.23436307115026, 379.24855175700293, 386.23139951496523, 400.28149471698333, 10539.894601053997, 11251.381174035425, 11264.493097810608, 11274.774504509905, 16224.351025958962, 18136.63726725468, 18892.716609250838, 19085.904570477127, 19363.515912102168, 19649.50876228095, 5606.635568688042, 5884.323302820188, 5936.317323507808, 5938.495227905633, 5941.376155503674, 4047.372657238118, 4312.245357062501, 6609.239937407212, 7021.508494405393, 7033.5428197167275, 6831.2144103428245, 6954.617496037716, 6985.476089293298, 7009.649517524129, 7009.719611215545, 6760.459163266952, 6950.930490695079, 6969.54697944632, 7007.824804379906, 7009.299070093001, 3842.231553689245, 6417.229932408094, 6828.0440738296675, 6831.487638427137, 6837.111175547197, 22709.318720438412, 22793.77206227933, 23746.406339841644, 23754.287371378887, 23926.162584309466, 2046.3656266557414, 2135.9359219223293, 2197.9340619781433, 2482.8510289382516, 2497.525470160682, 13644.0, 14180.361883715257, 14279.071860329046, 14314.928425357806, 14864.256787160706, 1869.6354210928873, 2018.9697154542694, 2019.858609897293, 2048.8156065954136, 2197.8021978022057, 70935.64532177358, 75018.24981750222, 78318.21681783166, 80962.59518702369, 82338.17661823364, 16307.755383669255, 16488.587785305463, 16756.0, 17125.828741712423, 17461.15854512005, 30565.694343056286, 30955.380892382025, 31028.53457198144, 31305.37389252202, 31497.37005259928, 8504.44721093127, 9001.099890011077, 9037.909620903838, 9113.908860911306, 9147.725568232963, 7250.673719682627, 7315.451341149435, 7441.920921466357, 7585.2035536269, 7900.446968712135, 7062.268951942024, 8435.240828325357, 8579.2707619853, 8662.0, 8953.508131828592, 2960.763138948879, 3434.914127146841, 3455.585329760445, 3602.603713591503, 3658.4512323151207, 933.9579718912665, 947.4220725357526, 949.4777872170279, 995.681381957781, 1020.5560581147224, 16292.0, 16405.42581009659, 17117.657646846994, 17196.484105476855, 17220.930925561624, 874.6545114679666, 939.9953000234955, 945.4043952310001, 965.1169180200038, 1004.8542961270721, 9476.478793666414, 9478.905210947802, 9576.281778866613, 9697.460426944255, 9882.357646752938, 380412.0, 388742.0, 394097.0, 401036.0, 402851.78611604247, 78481.60759196282, 81601.59199203966, 82319.5884020576, 82369.58815205886, 83570.58214708888, 981.8674478945394, 1015.3755440404099, 1039.0700323210683, 1039.9896001040045, 1048.0672201740458, 15791.052536847827, 15899.284532195848, 15964.521064368088, 16090.0, 16465.0, 32816.0, 32889.34221315608, 33362.33275334528, 33859.153521161184, 35404.0, 42847.35728964006, 47642.761786190844, 48267.0, 48692.269615956495, 48990.0, 7271.490995630466, 7737.729179478692, 8067.193280671886, 8099.0, 8173.918260817316, 7140.214576396696, 8448.155184481502, 8534.307998042721, 11122.165837562054, 11212.775744485229, 9277.768055798659, 9676.661316853877, 9794.118529332394, 9999.700008999742, 10443.321184123008, 9262.814743705223, 9474.194693451134, 9499.95250023773, 9622.951885240529, 9655.468949207861, 9125.133112354315, 9285.97854236047, 10139.0, 10449.68650940473, 10734.463276836283, 7728.613569321399, 7852.568108754073, 7980.640871160927, 8043.195680432144, 8103.189681032086, 5070.594352451869, 6699.8325041872395, 8628.827423451621, 8628.96452425713, 10176.0], "value": 9234.090683185304, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.3217526886015, 1462.444271176953, 1495.947641832536, 1648.6537827056318, 1799.999999999999, 6511.283758786536, 7147.53541019834, 7347.742829000986, 7349.228331025232, 7362.0, 7097.85804283914, 7259.201487836333, 7266.455015873804, 7270.491065625409, 7273.745418910339, 1859.2562974810048, 2101.0440249686394, 2111.7782632823564, 2156.2453141400465, 2184.541246338271, 2197.4726065744185, 2219.2676416782506, 2221.9777802222015, 2222.799948004679, 2224.3882932193615, 2139.5934772393275, 2195.2865318771383, 2195.7804219577993, 2196.176433837311, 2197.6483762597986, 1835.6604028254749, 2096.4968407582223, 2175.3473957812594, 2178.5425060737266, 2181.901814418355, 2016.0826823795137, 2063.484128967758, 2072.1814883121083, 2073.5541858500496, 2127.659574468093, 7489.176190619028, 7589.81025474362, 7676.040494938133, 7709.653065612061, 7716.459847810655, 4492.505824359318, 4640.837570685044, 4657.278121891112, 4661.930071048937, 4680.64895132863, 2723.6459260296033, 2738.3701748597737, 2784.5405508091344, 2872.7845411594003, 2897.2901639098345, 950.3680052764903, 979.363413781048, 983.9065288797552, 988.9505524723735, 992.9602815887428, 10309.484525773682, 10355.534000969974, 10371.11845493134, 10377.169826413869, 10389.064984151388, 4098.877033688994, 4205.9789701051295, 4275.5296917339065, 4318.892027699333, 4322.546132656089, 8782.824343513223, 8806.427582207136, 8822.86765698515, 8830.955845220733, 8840.381173317935, 4008.9799551002056, 4644.512326205768, 4689.531046895283, 4737.407824021997, 4738.691985020962, 4063.5326937401987, 4143.440635514227, 4181.059261666162, 4183.790810459525, 4200.5169405518145, 3628.9637103628625, 3652.945205821915, 3680.3375392429084, 3708.0915175782106, 3791.090138366772, 1174.1663418972626, 1179.7522520270668, 1181.9645410637695, 1196.216478206776, 1202.4709127983658, 666.3336663336663, 757.2881491398068, 769.8922150898878, 862.7153039496951, 863.0, 4886.242632391985, 4925.13810083234, 4962.6774259673, 4963.329950456642, 4984.850454486371, 417.38019041723624, 417.83495519270326, 422.008280540733, 423.64202249099463, 916.2624087609538, 3461.2558299965626, 3461.567304086989, 3465.358908601917, 3483.512308276843, 3502.3520648680073, 8732.214100730966, 9090.545472726337, 9099.226565741987, 9099.454032758056, 9207.98712141664, 8987.325950553735, 9035.909640903637, 9105.043970383147, 9106.27149828012, 9121.680741174026, 6994.195667498201, 7271.67277472515, 7276.235995220532, 7341.743038993716, 7374.889376659355, 4930.087933732271, 5061.215511595708, 5100.285959965534, 5241.921371179512, 5282.683039017671, 7985.0, 8052.798680032812, 8172.754817355489, 8184.877226841483, 8271.090180080308, 7965.681372745025, 8214.83570328602, 8305.792355191168, 8475.194856488624, 8485.618147183268, 5831.854203644773, 6291.087792270187, 6376.9043464349, 6462.224533056064, 6478.70845811949, 7251.274872512707, 7359.411247100112, 7414.5551266922, 7431.145418276751, 7441.255874412515, 6487.253965793805, 6730.8653826924165, 6818.897716534157, 6822.965885170543, 6921.2386637468835, 6471.514636402195, 6508.284088750328, 6714.328567143442, 6753.628550429577, 6860.656967151723, 6192.628442293477, 6254.843628909131, 6257.28041275241, 6268.122462855295, 6283.874322513616, 4255.744655320566, 4362.192994296065, 4402.5597440255715, 4407.9338809917235, 4433.733975961452, 4418.4035155254915, 4458.71018383804, 4471.955280447284, 4512.9323060153465, 4562.817487300471], "value": 3982.2285724803473, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.9937601247975, 312.9780915335926, 313.8305315129829, 316.4793914011453, 319.32781494953133, 4643.558861908122, 4694.765261736917, 4697.624190064791, 4751.809927602892, 4772.66591338606, 4640.538230457403, 4678.181318269298, 4687.578117969382, 4705.788239529221, 4715.882102947419, 3567.4292113261818, 3614.114541937229, 3703.2778608171416, 3750.9812450937707, 3806.143617686026, 3752.793596352213, 3776.093737503007, 3789.2042671039117, 3789.5263092113487, 3806.0865392305786, 3543.4330507118866, 3737.4393840923944, 3750.15621485165, 3754.887353379403, 3758.3047136279874, 3594.5866225384025, 3734.533183352081, 3735.3089678409447, 3747.681447077002, 3749.8125093745475, 3310.9834450827834, 3329.8501567429525, 3341.2649217172184, 3359.344927739092, 3361.83190840457, 4516.570925762047, 4519.706219095749, 4520.480144783326, 4521.005378816655, 4540.18276710192, 3991.560928297885, 4239.342901850218, 4253.425787518708, 4268.829246830154, 4276.48682158143, 4928.950710492885, 4933.260010998343, 4939.506049395031, 4963.45402005779, 4966.5778408835295, 3538.9115272118147, 3549.0, 3551.485034669984, 3580.1228698968657, 3583.372909740785, 5002.0, 5104.668196567211, 5110.437851836332, 5159.458256883011, 5171.482851714836, 3632.3824949758605, 3633.5821380541047, 3635.1457407509215, 3638.472421498868, 3651.079136690637, 3674.191677830873, 3677.282929828711, 3705.9814700926863, 3718.5537735471376, 3722.758020728644, 4189.874303770892, 4193.748375097504, 4195.49654041517, 4197.895052623709, 4219.514755803122, 4844.4186697596515, 4921.2864134700985, 4942.332785073969, 4947.861991741919, 4982.9252561211615, 1330.3813726616977, 1335.5592654424017, 1341.8188544546556, 1344.9731005380033, 1346.7171893902391, 848.249299370062, 894.874717539545, 908.6274627402734, 917.6421195733669, 919.6091661044029, 4535.501094879561, 4551.658625603093, 4597.3793537872625, 4610.861674149781, 4619.353290539327, 5397.028534863763, 5408.2969214002715, 5413.864653383697, 5416.93729702723, 5419.187121931663, 4422.358757980075, 4561.840335588305, 4582.450105987236, 4604.608608268268, 4618.815247390134, 2839.105681710255, 2863.9427211455654, 2872.956905646417, 2873.5258682317185, 2875.7268059534313, 5035.949640503548, 5048.091343558195, 5058.696478211319, 5058.848234552969, 5086.516780905882, 5008.924866127011, 5230.3985041719925, 5253.001929633358, 5455.1544510600925, 5510.201020852034, 4853.9029219416125, 4878.755917241152, 4881.365422495053, 4893.73084480357, 4898.338724272177, 5132.3327967364, 5138.383393992595, 5170.0, 5180.912008478262, 5188.9740551297, 4865.221564549655, 5041.109583906035, 5060.49395060491, 5067.39191297032, 5076.517730815566, 4832.830850920201, 4838.588719958843, 4868.634852386156, 4886.53577910098, 4907.141250281258, 3613.620569840129, 3671.210689701727, 3678.282734866675, 3682.429223470366, 3696.7042636589545, 4966.528179822911, 5148.510891465305, 5177.974110129425, 5209.635325527328, 5214.687118772886, 4980.551750342486, 4994.225894986283, 5005.1241032819835, 5010.198368261061, 5010.223415370623, 4977.751112444291, 4982.825601103944, 4987.9750601248215, 5013.724245166551, 5028.949710502849, 4638.327442520748, 4649.488556258876, 4957.677750946177, 4994.650374473752, 5007.924881126859, 4830.637702172421, 4971.875703107451, 4981.227909674007, 4997.625178111729, 5013.222950442687, 4887.144749668865, 4915.43472500667, 4941.703497790144, 4943.480934501969, 4956.355673762532], "value": 3802.9368859811952, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.9118568993186, 711.9072224135953, 750.2347605442449, 753.56669914799, 791.9652249856094, 11948.223365481237, 12399.442025108869, 12581.433835477403, 12584.622461326151, 12611.369431528421, 12086.818697719542, 12119.27284362939, 12176.330301833395, 12186.0, 12189.634310970663, 689.1867596236439, 837.7863644770575, 852.6205838401913, 868.2576397180383, 871.4205053639354, 858.1675774498757, 868.8783570300163, 869.5347988825979, 869.9652013919467, 870.9825803483926, 909.5043201455189, 914.6707185413246, 915.3226612306878, 917.2616044084509, 917.669638929988, 717.7990162754437, 887.9156480134377, 916.3768637326615, 916.7478943290582, 917.7017469322464, 674.1068084787627, 674.2919934069257, 674.9865002699919, 677.5663575311755, 677.9830504237434, 12648.304343261118, 12714.491420343174, 12718.809217861739, 12736.23582585048, 12739.42672579736, 12748.872511274954, 13385.598432047054, 13443.0, 13517.729645407135, 13647.044706870523, 10108.342957707799, 10350.482475876175, 10563.73590660232, 10598.364098154058, 10753.408562529057, 3334.333133373311, 3360.9831950840335, 3412.436947903593, 3434.5363375944426, 3473.0449126490166, 46073.53926460726, 46569.767151164364, 46702.29946550805, 46846.53153468456, 46959.295610565525, 9818.607255709834, 9824.564900025365, 10239.48802559869, 10374.22193335503, 10388.48057597117, 17363.56591085233, 17619.119044048002, 17634.206460709298, 17677.38129165473, 17686.20412081434, 6925.79222623312, 7169.89245161323, 7172.175199852084, 7196.784096477114, 7316.0489136411925, 3590.98204508981, 3977.164795392942, 4043.939340909889, 4058.411530328145, 4120.91758164841, 2901.9709802901702, 2949.616549848506, 2960.1119664100684, 2964.851757412164, 2965.3920946205976, 516.8139469790872, 532.4037078472136, 533.0777754484685, 549.1241469855574, 584.0275940559006, 507.5127877237819, 527.9181726832347, 548.1065862643865, 567.8296511046669, 612.087988896541, 7225.0, 7281.417486601059, 7491.138519070268, 7561.848763024709, 7581.355584775356, 528.413461058225, 616.4359610956014, 628.1331762168179, 637.744902039188, 637.9553431259767, 3414.293704493842, 3568.678818906311, 3646.0520264731363, 3693.1136527233807, 3738.813059347022, 48602.0, 49565.0, 49596.0, 50269.74865125651, 50977.0, 43344.13311733748, 43782.34326485105, 44371.0, 44550.10899782051, 46321.0, 40265.396019059735, 40599.797001014806, 40924.79537602293, 41093.38359924604, 41121.58878411238, 7219.675114619749, 7284.963575182091, 7297.525660832029, 7322.121345438582, 7503.673404551119, 27864.442711145257, 28328.15015549537, 28516.57225141583, 28906.710932891245, 29514.262143446587, 35414.29171416609, 35511.82244088763, 36614.8169259152, 37036.0, 37090.0, 10906.0, 10939.507722152362, 10947.671569852917, 11002.284851484628, 11103.777924441627, 11692.532298708296, 11850.348230847041, 12059.57791477294, 12135.878641213474, 12264.22168785539, 11433.256838305484, 11473.4263286837, 11579.073674105883, 11606.187566870238, 12191.268523888595, 11283.323000619988, 11461.885381146081, 11605.446801703612, 11823.645290641294, 11962.58130965412, 11148.609798657008, 11186.608468703556, 11606.651800446, 11610.6516804496, 11624.418779061183, 9320.95339523298, 9537.52312384364, 9697.9030209697, 9860.802783944138, 9884.209263259067, 9656.179224765974, 9668.323217374716, 9748.85376719364, 9850.162736167505, 9950.651727189514], "value": 6021.950414754573, "unit": "score"}], "name": "dromaeo_css", "value": 6300.858859057816, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 110.0, 115.0, 114.0, 114.0, 103.0, 114.0, 114.0, 115.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 156.0, 183.0, 132.0, 162.0, 154.0, 134.0, 184.0, 136.0], "value": 153.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 163.0, 160.0, 161.0, 162.0, 161.0, 164.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 102.0, 108.0, 75.0, 73.0, 73.0, 109.0, 104.0, 74.0], "value": 86.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 150.0, 95.0, 95.0, 94.0, 151.0, 94.0, 92.0, 143.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 66.0, 67.0, 67.0, 67.0, 82.0, 66.0, 65.0], "value": 68.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 81.0, 79.0, 79.0, 82.0, 81.0, 82.0, 81.0, 82.0, 81.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 131.0, 132.0, 129.0, 130.0, 134.0, 128.0, 135.0, 170.0, 133.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 176.0, 183.0, 185.0, 181.0, 180.0, 179.0, 183.0, 183.0, 187.0], "value": 182.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 72.0, 73.0, 72.0, 72.0, 71.0, 75.0, 74.0, 72.0], "value": 73.0, "unit": "score"}], "name": "kraken", "value": 1588.2000000000003, "alertThreshold": 2.0}]} 07:32:47 INFO - Return code: 0 07:32:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:32:47 ERROR - # TBPL SUCCESS # 07:32:47 INFO - Running post-action listener: _resource_record_post_action 07:32:47 INFO - Running post-run listener: _resource_record_post_run 07:32:48 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 460783616; Read time: 0; Write time: 357256 07:32:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110432256; Read time: 0; Write time: 89812 07:32:48 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 284835840; Read time: 0; Write time: 175128 07:32:48 INFO - Running post-run listener: _upload_blobber_files 07:32:48 INFO - Blob upload gear active. 07:32:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:32:48 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 07:32:48 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:32:48 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:32:49 INFO - (blobuploader) - INFO - Open directory for files ... 07:32:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:32:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:32:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:50 INFO - (blobuploader) - INFO - Done attempting. 07:32:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:32:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:32:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:51 INFO - (blobuploader) - INFO - Done attempting. 07:32:51 INFO - (blobuploader) - INFO - Iteration through files over. 07:32:51 INFO - Return code: 0 07:32:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:32:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:32:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5963938e12bce9dad23178796c2e96ad5e59244eef2e632b90ff1064329c7c3ed0097344b9301100aa5be64661b7b717ed31d25edb4423806468f939232a03ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b4793902b918cc075aebafa3c9e1a22c29eb5b09006555d28b9fc64adf8e4b9e287d43a3c46366aab176dc51e7367d742c1fb87ab548492daefd9148ab4f311d"} 07:32:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:32:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:32:51 INFO - Contents: 07:32:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5963938e12bce9dad23178796c2e96ad5e59244eef2e632b90ff1064329c7c3ed0097344b9301100aa5be64661b7b717ed31d25edb4423806468f939232a03ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b4793902b918cc075aebafa3c9e1a22c29eb5b09006555d28b9fc64adf8e4b9e287d43a3c46366aab176dc51e7367d742c1fb87ab548492daefd9148ab4f311d"} 07:32:51 INFO - Running post-run listener: copy_logs_to_upload_dir 07:32:51 INFO - Copying logs to upload dir... 07:32:51 INFO - mkdir: /builds/slave/test/build/upload/logs 07:32:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.966731 ========= master_lag: 23.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-05-05 07:33:13.604260) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 07:33:13.607984) ========= 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=6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618 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-Non-PGO/sha512/5963938e12bce9dad23178796c2e96ad5e59244eef2e632b90ff1064329c7c3ed0097344b9301100aa5be64661b7b717ed31d25edb4423806468f939232a03ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b4793902b918cc075aebafa3c9e1a22c29eb5b09006555d28b9fc64adf8e4b9e287d43a3c46366aab176dc51e7367d742c1fb87ab548492daefd9148ab4f311d"} build_url:https://queue.taskcluster.net/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010341 build_url: 'https://queue.taskcluster.net/v1/task/dENsTtcoQFyL4crdDOfaJw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5963938e12bce9dad23178796c2e96ad5e59244eef2e632b90ff1064329c7c3ed0097344b9301100aa5be64661b7b717ed31d25edb4423806468f939232a03ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b4793902b918cc075aebafa3c9e1a22c29eb5b09006555d28b9fc64adf8e4b9e287d43a3c46366aab176dc51e7367d742c1fb87ab548492daefd9148ab4f311d"}' ========= master_lag: 0.27 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 07:33:13.891731) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 07:33:13.892069) ========= 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=6d15e502d8e29d5d2676d664000001c3-1462447808.354727-1545495618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 07:33:13.907946) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 07:33:13.908389) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 07:33:13.908699) ========= ========= Total master_lag: 23.52 =========