builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1461844289.85 results: success (0) buildid: 20160428034800 builduid: 2dfa8c73ae054518a25c5747e5d459c4 revision: 830f7765555a3740103c31100118bf318cf785b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:29.847125) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:29.847624) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:29.848108) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:29.869710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:29.870057) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 04:51:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 215M=0s 2016-04-28 04:51:30 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.068051 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:29.952511) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:29.953302) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017780 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:30.003560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:30.003974) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 830f7765555a3740103c31100118bf318cf785b2 --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 830f7765555a3740103c31100118bf318cf785b2 --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=74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 04:51:31,043 truncating revision to first 12 chars 2016-04-28 04:51:31,043 Setting DEBUG logging. 2016-04-28 04:51:31,043 attempt 1/10 2016-04-28 04:51:31,043 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/830f7765555a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 04:51:31,435 unpacking tar archive at: fx-team-830f7765555a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.666406 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:30.684633) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:30.685059) ========= script_repo_revision: 830f7765555a3740103c31100118bf318cf785b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:30.685630) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:30.686035) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:30.697168) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-28 04:51:30.697743) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:51:31 INFO - MultiFileLogger online at 20160428 04:51:31 in /builds/slave/test 04:51:31 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 04:51:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:51:31 INFO - {'append_to_log': False, 04:51:31 INFO - 'base_work_dir': '/builds/slave/test', 04:51:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:51:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:51:31 INFO - 'branch': 'Fx-Team-Non-PGO', 04:51:31 INFO - 'buildbot_json_path': 'buildprops.json', 04:51:31 INFO - 'config_files': ('talos/linux_config.py',), 04:51:31 INFO - 'default_actions': ('clobber', 04:51:31 INFO - 'read-buildbot-config', 04:51:31 INFO - 'download-and-extract', 04:51:31 INFO - 'populate-webroot', 04:51:31 INFO - 'create-virtualenv', 04:51:31 INFO - 'install', 04:51:31 INFO - 'run-tests'), 04:51:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:51:31 INFO - 'download_minidump_stackwalk': True, 04:51:31 INFO - 'download_symbols': 'ondemand', 04:51:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:51:31 INFO - 'tooltool.py': '/tools/tooltool.py', 04:51:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:51:31 INFO - '/tools/misc-python/virtualenv.py')}, 04:51:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:51:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:51:31 INFO - 'installer_path': 'installer.exe', 04:51:31 INFO - 'log_level': 'info', 04:51:31 INFO - 'log_name': 'talos', 04:51:31 INFO - 'log_to_console': True, 04:51:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:51:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:51:31 INFO - 'opt_config_files': (), 04:51:31 INFO - 'pip_index': False, 04:51:31 INFO - 'sps_profile': False, 04:51:31 INFO - 'sps_profile_interval': 0, 04:51:31 INFO - 'suite': 'dromaeojs', 04:51:31 INFO - 'system_bits': '32', 04:51:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:51:31 INFO - 'title': 'talos-linux64-ix-042', 04:51:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:51:31 INFO - 'use_talos_json': True, 04:51:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:51:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:51:31 INFO - 'work_dir': 'build'} 04:51:31 INFO - ##### 04:51:31 INFO - ##### Running clobber step. 04:51:31 INFO - ##### 04:51:31 INFO - Running pre-action listener: _resource_record_pre_action 04:51:31 INFO - Running main action method: clobber 04:51:31 INFO - rmtree: /builds/slave/test/build 04:51:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:51:32 INFO - Running post-action listener: _resource_record_post_action 04:51:32 INFO - ##### 04:51:32 INFO - ##### Running read-buildbot-config step. 04:51:32 INFO - ##### 04:51:32 INFO - Running pre-action listener: _resource_record_pre_action 04:51:32 INFO - Running main action method: read_buildbot_config 04:51:32 INFO - Using buildbot properties: 04:51:32 INFO - { 04:51:32 INFO - "project": "", 04:51:32 INFO - "product": "firefox", 04:51:32 INFO - "script_repo_revision": "production", 04:51:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:51:32 INFO - "repository": "", 04:51:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:51:32 INFO - "buildid": "20160428034800", 04:51:32 INFO - "pgo_build": "False", 04:51:32 INFO - "basedir": "/builds/slave/test", 04:51:32 INFO - "buildnumber": 2905, 04:51:32 INFO - "slavename": "talos-linux64-ix-042", 04:51:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:51:32 INFO - "platform": "ubuntu64_hw", 04:51:32 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:51:32 INFO - "branch": "fx-team", 04:51:32 INFO - "repo_path": "integration/fx-team", 04:51:32 INFO - "revision": "830f7765555a3740103c31100118bf318cf785b2", 04:51:32 INFO - "stage_platform": "linux64", 04:51:32 INFO - "builduid": "2dfa8c73ae054518a25c5747e5d459c4", 04:51:32 INFO - "slavebuilddir": "test" 04:51:32 INFO - } 04:51:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:51:32 INFO - Running post-action listener: _resource_record_post_action 04:51:32 INFO - ##### 04:51:32 INFO - ##### Running download-and-extract step. 04:51:32 INFO - ##### 04:51:32 INFO - Running pre-action listener: _resource_record_pre_action 04:51:32 INFO - Running main action method: download_and_extract 04:51:32 INFO - mkdir: /builds/slave/test/build/tests 04:51: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')]} 04:51:32 INFO - https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:51:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:51:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:51:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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 04:51:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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 04:51:36 INFO - Downloaded 1361 bytes. 04:51:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:51:36 INFO - Using the following test package requirements: 04:51:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:51:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:51:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:51:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:36 INFO - u'jsshell-linux-x86_64.zip'], 04:51:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:51:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:51:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:51:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:51:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:51:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:51:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:51:36 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')]} 04:51:36 INFO - https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:51:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:51:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:51:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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 04:51:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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 04:51:38 INFO - Downloaded 22293278 bytes. 04:51:38 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'] 04:51:38 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 04:51:39 INFO - Return code: 0 04:51:39 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 04:51: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')]} 04:51:39 INFO - https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:51:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:51:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:51:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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 04:51:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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 04:51:47 INFO - Downloaded 22293278 bytes. 04:51:47 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'] 04:51:47 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 04:51:48 INFO - Return code: 0 04:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:48 INFO - https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:51:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:51:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:51:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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 04:51:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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 04:51:49 INFO - Downloaded 10840145 bytes. 04:51:49 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'] 04:51:49 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 04:51:49 INFO - Return code: 0 04:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:49 INFO - https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:51:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:51:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:51:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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 04:51:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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 04:51:55 INFO - Downloaded 54839520 bytes. 04:51:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:51:55 INFO - mkdir: /builds/slave/test/properties 04:51:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:51:55 INFO - Writing to file /builds/slave/test/properties/build_url 04:51:55 INFO - Contents: 04:51:55 INFO - build_url:https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:51:55 INFO - Running post-action listener: _resource_record_post_action 04:51:55 INFO - Running post-action listener: set_extra_try_arguments 04:51:55 INFO - ##### 04:51:55 INFO - ##### Running populate-webroot step. 04:51:55 INFO - ##### 04:51:55 INFO - Running pre-action listener: _resource_record_pre_action 04:51:55 INFO - Running main action method: populate_webroot 04:51:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:51:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:51:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:51:55 INFO - '--tppagecycles', 04:51:55 INFO - '7'], 04:51:55 INFO - 'tests': ['tsvgm']}}, 04:51:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:51:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:51:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:51:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:51:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:51:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:51:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:55 INFO - 'talos_options': ['--disable-e10s'], 04:51:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:51:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:51:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:55 INFO - 'talos_options': ['--disable-e10s'], 04:51:55 INFO - 'tests': ['damp', 'tps']}, 04:51:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:55 INFO - 'tests': ['damp', 'tps']}, 04:51:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:51:55 INFO - 'tests': ['dromaeo_dom']}, 04:51:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:51:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:51:55 INFO - 'tests': ['a11yr', 04:51:55 INFO - 'ts_paint', 04:51:55 INFO - 'tpaint', 04:51:55 INFO - 'sessionrestore', 04:51:55 INFO - 'sessionrestore_no_auto_restore', 04:51:55 INFO - 'tabpaint']}, 04:51:55 INFO - 'other-e10s': {'tests': ['a11yr', 04:51:55 INFO - 'ts_paint', 04:51:55 INFO - 'tpaint', 04:51:55 INFO - 'sessionrestore', 04:51:55 INFO - 'sessionrestore_no_auto_restore', 04:51:55 INFO - 'tabpaint']}, 04:51:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:51:55 INFO - 'ts_paint', 04:51:55 INFO - 'tpaint', 04:51:55 INFO - 'sessionrestore', 04:51:55 INFO - 'sessionrestore_no_auto_restore', 04:51:55 INFO - 'tabpaint']}, 04:51:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:51:55 INFO - 'ts_paint', 04:51:55 INFO - 'tpaint', 04:51:55 INFO - 'sessionrestore', 04:51:55 INFO - 'sessionrestore_no_auto_restore', 04:51:55 INFO - 'tabpaint']}, 04:51:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:51:55 INFO - 'tests': ['a11yr', 04:51:55 INFO - 'ts_paint', 04:51:55 INFO - 'tpaint', 04:51:55 INFO - 'sessionrestore', 04:51:55 INFO - 'sessionrestore_no_auto_restore', 04:51:55 INFO - 'tabpaint']}, 04:51:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:51:55 INFO - 'tests': ['a11yr', 04:51:55 INFO - 'ts_paint', 04:51:55 INFO - 'tpaint', 04:51:55 INFO - 'sessionrestore', 04:51:55 INFO - 'sessionrestore_no_auto_restore', 04:51:55 INFO - 'tabpaint']}, 04:51:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:51:55 INFO - 'tests': ['tsvgx', 04:51:55 INFO - 'tsvgr_opacity', 04:51:55 INFO - 'tart', 04:51:55 INFO - 'tscrollx', 04:51:55 INFO - 'cart']}, 04:51:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:51:55 INFO - 'tsvgr_opacity', 04:51:55 INFO - 'tart', 04:51:55 INFO - 'tscrollx', 04:51:55 INFO - 'cart']}, 04:51:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:55 INFO - 'talos_options': ['--disable-e10s'], 04:51:55 INFO - 'tests': ['tp5o']}, 04:51:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:55 INFO - 'tests': ['tp5o']}, 04:51:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:55 INFO - 'talos_options': ['--disable-e10s', 04:51:55 INFO - '--xperf_path', 04:51:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:51:55 INFO - 'tests': ['tp5n']}, 04:51:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:55 INFO - 'talos_options': ['--xperf_path', 04:51:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:51:55 INFO - 'tests': ['tp5n']}}, 04:51:55 INFO - 'talos.zip': {'path': '', 04:51:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:51:55 INFO - Running post-action listener: _resource_record_post_action 04:51:55 INFO - ##### 04:51:55 INFO - ##### Running create-virtualenv step. 04:51:55 INFO - ##### 04:51:55 INFO - Running pre-action listener: _resource_record_pre_action 04:51:55 INFO - Running main action method: create_virtualenv 04:51:55 INFO - Creating virtualenv /builds/slave/test/build/venv 04:51:55 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 04:51:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:51:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:51:56 INFO - Using real prefix '/usr' 04:51:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:51:56 INFO - Installing distribute.............................................................................................................................................................................................done. 04:51:58 INFO - Installing pip.................done. 04:51:58 INFO - Return code: 0 04:51:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5f0324f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2619410>, '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 0x261a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', '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 04:51:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:51:58 INFO - Using env: {'DISPLAY': ':0', 04:51:58 INFO - 'HOME': '/home/cltbld', 04:51:58 INFO - 'LANG': 'en_US.UTF-8', 04:51:58 INFO - 'LANGUAGE': 'en_US:en', 04:51:58 INFO - 'LOGNAME': 'cltbld', 04:51:58 INFO - 'MAIL': '/var/mail/cltbld', 04:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:58 INFO - 'MOZ_NO_REMOTE': '1', 04:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:58 INFO - 'NO_EM_RESTART': '1', 04:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:58 INFO - 'PWD': '/builds/slave/test', 04:51:58 INFO - 'SHELL': '/bin/bash', 04:51:58 INFO - 'SHLVL': '1', 04:51:58 INFO - 'TERM': 'linux', 04:51:58 INFO - 'TMOUT': '86400', 04:51:58 INFO - 'USER': 'cltbld', 04:51:58 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', 04:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:58 INFO - '_': '/tools/buildbot/bin/python'} 04:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:58 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 04:51:58 INFO - Cleaning up... 04:51:58 INFO - Return code: 0 04:51:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc5f0324f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2619410>, '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 0x261a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', '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 04:51:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:51:58 INFO - Using env: {'DISPLAY': ':0', 04:51:58 INFO - 'HOME': '/home/cltbld', 04:51:58 INFO - 'LANG': 'en_US.UTF-8', 04:51:58 INFO - 'LANGUAGE': 'en_US:en', 04:51:58 INFO - 'LOGNAME': 'cltbld', 04:51:58 INFO - 'MAIL': '/var/mail/cltbld', 04:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:58 INFO - 'MOZ_NO_REMOTE': '1', 04:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:58 INFO - 'NO_EM_RESTART': '1', 04:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:58 INFO - 'PWD': '/builds/slave/test', 04:51:58 INFO - 'SHELL': '/bin/bash', 04:51:58 INFO - 'SHLVL': '1', 04:51:58 INFO - 'TERM': 'linux', 04:51:58 INFO - 'TMOUT': '86400', 04:51:58 INFO - 'USER': 'cltbld', 04:51:58 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', 04:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:58 INFO - '_': '/tools/buildbot/bin/python'} 04:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:58 INFO - Downloading/unpacking psutil>=0.7.1 04:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:52:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:00 INFO - Installing collected packages: psutil 04:52:00 INFO - Running setup.py install for psutil 04:52:01 INFO - building 'psutil._psutil_linux' extension 04:52:01 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 04:52:01 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 04:52:01 INFO - building 'psutil._psutil_posix' extension 04:52:01 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 04:52:01 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 04:52:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:01 INFO - Successfully installed psutil 04:52:01 INFO - Cleaning up... 04:52:01 INFO - Return code: 0 04:52:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc5f0324f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2619410>, '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 0x261a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', '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 04:52:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:52:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:52:01 INFO - Using env: {'DISPLAY': ':0', 04:52:01 INFO - 'HOME': '/home/cltbld', 04:52:01 INFO - 'LANG': 'en_US.UTF-8', 04:52:01 INFO - 'LANGUAGE': 'en_US:en', 04:52:01 INFO - 'LOGNAME': 'cltbld', 04:52:01 INFO - 'MAIL': '/var/mail/cltbld', 04:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:01 INFO - 'MOZ_NO_REMOTE': '1', 04:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:01 INFO - 'NO_EM_RESTART': '1', 04:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:01 INFO - 'PWD': '/builds/slave/test', 04:52:01 INFO - 'SHELL': '/bin/bash', 04:52:01 INFO - 'SHLVL': '1', 04:52:01 INFO - 'TERM': 'linux', 04:52:01 INFO - 'TMOUT': '86400', 04:52:01 INFO - 'USER': 'cltbld', 04:52:01 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', 04:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:01 INFO - '_': '/tools/buildbot/bin/python'} 04:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:52:03 INFO - Installing collected packages: mozsystemmonitor 04:52:03 INFO - Running setup.py install for mozsystemmonitor 04:52:03 INFO - Successfully installed mozsystemmonitor 04:52:03 INFO - Cleaning up... 04:52:03 INFO - Return code: 0 04:52:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5f0324f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2619410>, '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 0x261a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', '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 04:52:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:52:03 INFO - Using env: {'DISPLAY': ':0', 04:52:03 INFO - 'HOME': '/home/cltbld', 04:52:03 INFO - 'LANG': 'en_US.UTF-8', 04:52:03 INFO - 'LANGUAGE': 'en_US:en', 04:52:03 INFO - 'LOGNAME': 'cltbld', 04:52:03 INFO - 'MAIL': '/var/mail/cltbld', 04:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:03 INFO - 'MOZ_NO_REMOTE': '1', 04:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:03 INFO - 'NO_EM_RESTART': '1', 04:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:03 INFO - 'PWD': '/builds/slave/test', 04:52:03 INFO - 'SHELL': '/bin/bash', 04:52:03 INFO - 'SHLVL': '1', 04:52:03 INFO - 'TERM': 'linux', 04:52:03 INFO - 'TMOUT': '86400', 04:52:03 INFO - 'USER': 'cltbld', 04:52:03 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', 04:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:03 INFO - '_': '/tools/buildbot/bin/python'} 04:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:04 INFO - Downloading/unpacking blobuploader==1.2.4 04:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:05 INFO - Downloading blobuploader-1.2.4.tar.gz 04:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:52:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:52:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:52:06 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 04:52:06 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 04:52:06 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 04:52:06 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 04:52:06 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 04:52:06 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 04:52:06 INFO - Downloading docopt-0.6.1.tar.gz 04:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:52:06 INFO - Installing collected packages: blobuploader, requests, docopt 04:52:06 INFO - Running setup.py install for blobuploader 04:52:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:52:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:52:06 INFO - Running setup.py install for requests 04:52:07 INFO - Running setup.py install for docopt 04:52:07 INFO - Successfully installed blobuploader requests docopt 04:52:07 INFO - Cleaning up... 04:52:07 INFO - Return code: 0 04:52:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:07 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 0x7fc5f0324f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2619410>, '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 0x261a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', '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 04:52:07 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 04:52:07 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 04:52:07 INFO - Using env: {'DISPLAY': ':0', 04:52:07 INFO - 'HOME': '/home/cltbld', 04:52:07 INFO - 'LANG': 'en_US.UTF-8', 04:52:07 INFO - 'LANGUAGE': 'en_US:en', 04:52:07 INFO - 'LOGNAME': 'cltbld', 04:52:07 INFO - 'MAIL': '/var/mail/cltbld', 04:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:07 INFO - 'MOZ_NO_REMOTE': '1', 04:52:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:07 INFO - 'NO_EM_RESTART': '1', 04:52:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:07 INFO - 'PWD': '/builds/slave/test', 04:52:07 INFO - 'SHELL': '/bin/bash', 04:52:07 INFO - 'SHLVL': '1', 04:52:07 INFO - 'TERM': 'linux', 04:52:07 INFO - 'TMOUT': '86400', 04:52:07 INFO - 'USER': 'cltbld', 04:52:07 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', 04:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:07 INFO - '_': '/tools/buildbot/bin/python'} 04:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:07 INFO - Running setup.py (path:/tmp/pip-FIlEpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:07 INFO - Running setup.py (path:/tmp/pip-Cs3C80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:07 INFO - Running setup.py (path:/tmp/pip-kAeuCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:07 INFO - Running setup.py (path:/tmp/pip-LJl8cY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:07 INFO - Running setup.py (path:/tmp/pip-uufddT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:07 INFO - Running setup.py (path:/tmp/pip-SZxf8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:07 INFO - Running setup.py (path:/tmp/pip-Og0lwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:07 INFO - Running setup.py (path:/tmp/pip-tXNCM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:08 INFO - Running setup.py (path:/tmp/pip-O8wnYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:08 INFO - Running setup.py (path:/tmp/pip-BhWolT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:08 INFO - Running setup.py (path:/tmp/pip-T5itgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:08 INFO - Running setup.py (path:/tmp/pip-_iScdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:08 INFO - Running setup.py (path:/tmp/pip-x20TyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:08 INFO - Running setup.py (path:/tmp/pip-Bw6E4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:08 INFO - Running setup.py (path:/tmp/pip-ZY1sTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:08 INFO - Running setup.py (path:/tmp/pip-lyB8Uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:08 INFO - Running setup.py (path:/tmp/pip-AY6mtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:52:08 INFO - Running setup.py install for manifestparser 04:52:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:52:08 INFO - Running setup.py install for mozcrash 04:52:08 INFO - Running setup.py install for mozdebug 04:52:08 INFO - Running setup.py install for mozdevice 04:52:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:52:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:52:09 INFO - Running setup.py install for mozfile 04:52:09 INFO - Running setup.py install for mozhttpd 04:52:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:52:09 INFO - Running setup.py install for mozinfo 04:52:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:52:09 INFO - Running setup.py install for mozInstall 04:52:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:52:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:52:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:52:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:52:09 INFO - Running setup.py install for mozleak 04:52:09 INFO - Running setup.py install for mozlog 04:52:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:52:09 INFO - Running setup.py install for moznetwork 04:52:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:52:09 INFO - Running setup.py install for mozprocess 04:52:09 INFO - Running setup.py install for mozprofile 04:52:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:52:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:52:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:52:10 INFO - Running setup.py install for mozrunner 04:52:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:52:10 INFO - Running setup.py install for mozscreenshot 04:52:10 INFO - Running setup.py install for moztest 04:52:10 INFO - Running setup.py install for mozversion 04:52:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:52:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:52:10 INFO - Cleaning up... 04:52:10 INFO - Return code: 0 04:52:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5f0324f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2619410>, '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 0x261a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', '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 04:52:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:52:10 INFO - Using env: {'DISPLAY': ':0', 04:52:10 INFO - 'HOME': '/home/cltbld', 04:52:10 INFO - 'LANG': 'en_US.UTF-8', 04:52:10 INFO - 'LANGUAGE': 'en_US:en', 04:52:10 INFO - 'LOGNAME': 'cltbld', 04:52:10 INFO - 'MAIL': '/var/mail/cltbld', 04:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:10 INFO - 'MOZ_NO_REMOTE': '1', 04:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:10 INFO - 'NO_EM_RESTART': '1', 04:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:10 INFO - 'PWD': '/builds/slave/test', 04:52:10 INFO - 'SHELL': '/bin/bash', 04:52:10 INFO - 'SHLVL': '1', 04:52:10 INFO - 'TERM': 'linux', 04:52:10 INFO - 'TMOUT': '86400', 04:52:10 INFO - 'USER': 'cltbld', 04:52:10 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', 04:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:10 INFO - '_': '/tools/buildbot/bin/python'} 04:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:10 INFO - Running setup.py (path:/tmp/pip-8f47j3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:10 INFO - Running setup.py (path:/tmp/pip-Z6A3ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:10 INFO - Running setup.py (path:/tmp/pip-75ckyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:10 INFO - Running setup.py (path:/tmp/pip-Ry_Kvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:11 INFO - Running setup.py (path:/tmp/pip-XFjVgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:11 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)) 04:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:11 INFO - Running setup.py (path:/tmp/pip-BJofCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:11 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)) 04:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:11 INFO - Running setup.py (path:/tmp/pip-MTuU28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:11 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)) 04:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:11 INFO - Running setup.py (path:/tmp/pip-wBH9vP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:11 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)) 04:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:11 INFO - Running setup.py (path:/tmp/pip-L9nfLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:11 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)) 04:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:11 INFO - Running setup.py (path:/tmp/pip-E5j2bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:11 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)) 04:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:11 INFO - Running setup.py (path:/tmp/pip-7Yt4c_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:11 INFO - Running setup.py (path:/tmp/pip-D9NdxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:11 INFO - Running setup.py (path:/tmp/pip-9YLyqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:11 INFO - Running setup.py (path:/tmp/pip-CAm0IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:11 INFO - Running setup.py (path:/tmp/pip-nX8CqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:11 INFO - Running setup.py (path:/tmp/pip-t3ClMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:11 INFO - Running setup.py (path:/tmp/pip-vKNNXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:13 INFO - Downloading blessings-1.6.tar.gz 04:52:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:52:13 INFO - Installing collected packages: blessings 04:52:13 INFO - Running setup.py install for blessings 04:52:13 INFO - Successfully installed blessings 04:52:13 INFO - Cleaning up... 04:52:14 INFO - Return code: 0 04:52:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:52:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:14 INFO - Reading from file tmpfile_stdout 04:52:14 INFO - Current package versions: 04:52:14 INFO - argparse == 1.2.1 04:52:14 INFO - blessings == 1.6 04:52:14 INFO - blobuploader == 1.2.4 04:52:14 INFO - docopt == 0.6.1 04:52:14 INFO - manifestparser == 1.1 04:52:14 INFO - mozInstall == 1.12 04:52:14 INFO - mozcrash == 0.17 04:52:14 INFO - mozdebug == 0.1 04:52:14 INFO - mozdevice == 0.48 04:52:14 INFO - mozfile == 1.2 04:52:14 INFO - mozhttpd == 0.7 04:52:14 INFO - mozinfo == 0.9 04:52:14 INFO - mozleak == 0.1 04:52:14 INFO - mozlog == 3.1 04:52:14 INFO - moznetwork == 0.27 04:52:14 INFO - mozprocess == 0.22 04:52:14 INFO - mozprofile == 0.28 04:52:14 INFO - mozrunner == 6.11 04:52:14 INFO - mozscreenshot == 0.1 04:52:14 INFO - mozsystemmonitor == 0.0 04:52:14 INFO - moztest == 0.7 04:52:14 INFO - mozversion == 1.4 04:52:14 INFO - psutil == 3.1.1 04:52:14 INFO - requests == 1.2.3 04:52:14 INFO - wsgiref == 0.1.2 04:52:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:14 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 0x7fc5f0324f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2619410>, '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 0x261a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', '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 04:52:14 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 04:52:14 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 04:52:14 INFO - Using env: {'DISPLAY': ':0', 04:52:14 INFO - 'HOME': '/home/cltbld', 04:52:14 INFO - 'LANG': 'en_US.UTF-8', 04:52:14 INFO - 'LANGUAGE': 'en_US:en', 04:52:14 INFO - 'LOGNAME': 'cltbld', 04:52:14 INFO - 'MAIL': '/var/mail/cltbld', 04:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:14 INFO - 'MOZ_NO_REMOTE': '1', 04:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:14 INFO - 'NO_EM_RESTART': '1', 04:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:14 INFO - 'PWD': '/builds/slave/test', 04:52:14 INFO - 'SHELL': '/bin/bash', 04:52:14 INFO - 'SHLVL': '1', 04:52:14 INFO - 'TERM': 'linux', 04:52:14 INFO - 'TMOUT': '86400', 04:52:14 INFO - 'USER': 'cltbld', 04:52:14 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', 04:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:14 INFO - '_': '/tools/buildbot/bin/python'} 04:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:52:14 INFO - Cleaning up... 04:52:14 INFO - Return code: 0 04:52:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5f0324f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2619410>, '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 0x261a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', '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 04:52:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:52:14 INFO - Using env: {'DISPLAY': ':0', 04:52:14 INFO - 'HOME': '/home/cltbld', 04:52:14 INFO - 'LANG': 'en_US.UTF-8', 04:52:14 INFO - 'LANGUAGE': 'en_US:en', 04:52:14 INFO - 'LOGNAME': 'cltbld', 04:52:14 INFO - 'MAIL': '/var/mail/cltbld', 04:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:14 INFO - 'MOZ_NO_REMOTE': '1', 04:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:14 INFO - 'NO_EM_RESTART': '1', 04:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:14 INFO - 'PWD': '/builds/slave/test', 04:52:14 INFO - 'SHELL': '/bin/bash', 04:52:14 INFO - 'SHLVL': '1', 04:52:14 INFO - 'TERM': 'linux', 04:52:14 INFO - 'TMOUT': '86400', 04:52:14 INFO - 'USER': 'cltbld', 04:52:14 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', 04:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:14 INFO - '_': '/tools/buildbot/bin/python'} 04:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:14 INFO - Downloading/unpacking jsonschema 04:52:14 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 04:52:14 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 04:52:14 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 04:52:14 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 04:52:14 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 04:52:14 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 04:52:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:52:16 INFO - Downloading/unpacking functools32 (from jsonschema) 04:52:16 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 04:52:16 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 04:52:16 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 04:52:16 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 04:52:16 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 04:52:16 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 04:52:16 INFO - Downloading functools32-3.2.3-2.tar.gz 04:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:52:16 INFO - warning: no files found matching '*.txt' 04:52:16 INFO - no previously-included directories found matching 'build' 04:52:16 INFO - no previously-included directories found matching 'dist' 04:52:16 INFO - no previously-included directories found matching '.git*' 04:52:16 INFO - Installing collected packages: jsonschema, functools32 04:52:16 INFO - Running setup.py install for functools32 04:52:17 INFO - warning: no files found matching '*.txt' 04:52:17 INFO - no previously-included directories found matching 'build' 04:52:17 INFO - no previously-included directories found matching 'dist' 04:52:17 INFO - no previously-included directories found matching '.git*' 04:52:17 INFO - Successfully installed jsonschema functools32 04:52:17 INFO - Cleaning up... 04:52:17 INFO - Return code: 0 04:52:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:52:17 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')]} 04:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:17 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')]} 04:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:17 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 0x7fc5f0324f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2619410>, '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 0x261a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', '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 04:52:17 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 04:52:17 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 04:52:17 INFO - Using env: {'DISPLAY': ':0', 04:52:17 INFO - 'HOME': '/home/cltbld', 04:52:17 INFO - 'LANG': 'en_US.UTF-8', 04:52:17 INFO - 'LANGUAGE': 'en_US:en', 04:52:17 INFO - 'LOGNAME': 'cltbld', 04:52:17 INFO - 'MAIL': '/var/mail/cltbld', 04:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:17 INFO - 'MOZ_NO_REMOTE': '1', 04:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:17 INFO - 'NO_EM_RESTART': '1', 04:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:17 INFO - 'PWD': '/builds/slave/test', 04:52:17 INFO - 'SHELL': '/bin/bash', 04:52:17 INFO - 'SHLVL': '1', 04:52:17 INFO - 'TERM': 'linux', 04:52:17 INFO - 'TMOUT': '86400', 04:52:17 INFO - 'USER': 'cltbld', 04:52:17 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', 04:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:17 INFO - '_': '/tools/buildbot/bin/python'} 04:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:17 INFO - Downloading/unpacking flake8 04:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:52:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:52:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:52:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:52:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:52:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:52:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:52:19 INFO - no previously-included directories found matching 'docs/_build' 04:52:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:52:19 INFO - Running setup.py install for pep8 04:52:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:52:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:52:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:52:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:52:20 INFO - no previously-included directories found matching 'docs/_build' 04:52:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:52:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:52:20 INFO - Cleaning up... 04:52:20 INFO - Return code: 0 04:52:20 INFO - Running post-action listener: _resource_record_post_action 04:52:20 INFO - Running post-action listener: _start_resource_monitoring 04:52:20 INFO - Starting resource monitoring. 04:52:20 INFO - ##### 04:52:20 INFO - ##### Running install step. 04:52:20 INFO - ##### 04:52:20 INFO - Running pre-action listener: _resource_record_pre_action 04:52:20 INFO - Running main action method: install 04:52:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:20 INFO - Reading from file tmpfile_stdout 04:52:20 INFO - Detecting whether we're running mozinstall >=1.0... 04:52:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:52:20 INFO - Reading from file tmpfile_stdout 04:52:20 INFO - Output received: 04:52:20 INFO - Usage: mozinstall [options] installer 04:52:20 INFO - Options: 04:52:20 INFO - -h, --help show this help message and exit 04:52:20 INFO - -d DEST, --destination=DEST 04:52:20 INFO - Directory to install application into. [default: 04:52:20 INFO - "/builds/slave/test"] 04:52:20 INFO - --app=APP Application being installed. [default: firefox] 04:52:20 INFO - mkdir: /builds/slave/test/build/application 04:52:20 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'] 04:52:20 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 04:52:36 INFO - Reading from file tmpfile_stdout 04:52:36 INFO - Output received: 04:52:36 INFO - /builds/slave/test/build/application/firefox/firefox 04:52:36 INFO - Running post-action listener: _resource_record_post_action 04:52:36 INFO - ##### 04:52:36 INFO - ##### Running run-tests step. 04:52:36 INFO - ##### 04:52:36 INFO - Running pre-action listener: _resource_record_pre_action 04:52:36 INFO - Running main action method: run_tests 04:52:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:52:36 INFO - Python 2.7.3 04:52:36 INFO - Return code: 0 04:52:36 INFO - grabbing minidump binary from tooltool 04:52:36 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')]} 04:52:36 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 0x2619410>, '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 0x261a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:52:36 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 04:52:36 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 04:52:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:52:36 INFO - Return code: 0 04:52:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:52:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:52:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:52:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:52:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:52:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:52:37 INFO - Return code: 0 04:52:37 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/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 04:52:37 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/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 04:52:37 INFO - Using env: {'DISPLAY': ':0', 04:52:37 INFO - 'HOME': '/home/cltbld', 04:52:37 INFO - 'LANG': 'en_US.UTF-8', 04:52:37 INFO - 'LANGUAGE': 'en_US:en', 04:52:37 INFO - 'LOGNAME': 'cltbld', 04:52:37 INFO - 'MAIL': '/var/mail/cltbld', 04:52:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:52:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:37 INFO - 'MOZ_NO_REMOTE': '1', 04:52:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:52:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:37 INFO - 'NO_EM_RESTART': '1', 04:52:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:37 INFO - 'PWD': '/builds/slave/test', 04:52:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:52:37 INFO - 'SHELL': '/bin/bash', 04:52:37 INFO - 'SHLVL': '1', 04:52:37 INFO - 'TERM': 'linux', 04:52:37 INFO - 'TMOUT': '86400', 04:52:37 INFO - 'USER': 'cltbld', 04:52:37 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350', 04:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:37 INFO - '_': '/tools/buildbot/bin/python'} 04:52:37 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/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 04:52:37 INFO - mozversion application_buildid: 20160428034800 04:52:37 INFO - mozversion application_changeset: 830f7765555a3740103c31100118bf318cf785b2 04:52:37 INFO - mozversion application_display_name: Nightly 04:52:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:52:37 INFO - mozversion application_name: Firefox 04:52:37 INFO - mozversion application_remotingname: firefox 04:52:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:52:37 INFO - mozversion application_vendor: Mozilla 04:52:37 INFO - mozversion application_version: 49.0a1 04:52:37 INFO - mozversion platform_buildid: 20160428034800 04:52:37 INFO - mozversion platform_changeset: 830f7765555a3740103c31100118bf318cf785b2 04:52:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:52:37 INFO - mozversion platform_version: 49.0a1 04:52:37 INFO - using testdate: 1461844357 04:52:37 INFO - actual date: 1461844357 04:52:37 INFO - starting webserver on 'localhost:49481' 04:52:37 INFO - SUITE-START | Running 2 tests 04:52:37 INFO - TEST-START | dromaeo_css 04:52:37 INFO - operating with platform_type : linux_ 04:52:37 INFO - Initialising browser for dromaeo_css test... 04:52:37 INFO - TEST-INFO | started process 29062 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptE9mVe/profile http://localhost:49481/getInfo.html) 04:52:41 INFO - PROCESS | 29062 | __metrics Screen width/height:1600/1200 04:52:41 INFO - PROCESS | 29062 | colorDepth:24 04:52:41 INFO - PROCESS | 29062 | Browser inner width/height: 1024/697 04:52:41 INFO - PROCESS | 29062 | __metrics 04:52:43 ERROR - PROCESS | 29062 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:52:43 INFO - TEST-INFO | 29062: exit 0 04:52:43 INFO - Browser initialized. 04:52:43 INFO - Running cycle 1/1 for dromaeo_css test... 04:52:43 INFO - TEST-INFO | started process 29145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptE9mVe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:55 INFO - PROCESS | 29145 | RSS: Main: 156872704 04:52:55 INFO - PROCESS | 29145 | 04:53:47 INFO - PROCESS | 29145 | 1461844427004 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] 04:55:58 INFO - PROCESS | 29145 | Cycle 1(1): loaded http://localhost:49481/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49481/tests/dromaeo/cssquery-ext.html) 04:56:00 INFO - PROCESS | 29145 | RSS: Main: 274391040 04:56:00 INFO - PROCESS | 29145 | 04:59:02 INFO - PROCESS | 29145 | Cycle 1(1): loaded http://localhost:49481/tests/dromaeo/cssquery-ext.html (next: http://localhost:49481/tests/dromaeo/cssquery-jquery.html) 04:59:03 INFO - PROCESS | 29145 | RSS: Main: 241070080 04:59:03 INFO - PROCESS | 29145 | 05:02:05 INFO - PROCESS | 29145 | Cycle 1(1): loaded http://localhost:49481/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49481/tests/dromaeo/cssquery-mootools.html) 05:02:06 INFO - PROCESS | 29145 | RSS: Main: 236003328 05:02:06 INFO - PROCESS | 29145 | 05:05:08 INFO - PROCESS | 29145 | Cycle 1(1): loaded http://localhost:49481/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49481/tests/dromaeo/cssquery-prototype.html) 05:05:08 INFO - PROCESS | 29145 | RSS: Main: 244940800 05:05:08 INFO - PROCESS | 29145 | 05:08:11 INFO - PROCESS | 29145 | Cycle 1(1): loaded http://localhost:49481/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49481/tests/dromaeo/cssquery-yui.html) 05:08:12 INFO - PROCESS | 29145 | RSS: Main: 216367104 05:08:12 INFO - PROCESS | 29145 | 05:11:14 INFO - PROCESS | 29145 | Cycle 1(1): loaded http://localhost:49481/tests/dromaeo/cssquery-yui.html (next: http://localhost:49481/tests/dromaeo/cssquery-dojo.html) 05:11:15 INFO - PROCESS | 29145 | RSS: Main: 275963904 05:11:15 INFO - PROCESS | 29145 | 05:11:15 INFO - PROCESS | 29145 | __start_tp_report 05:11:15 INFO - PROCESS | 29145 | _x_x_mozilla_page_load 05:11:15 INFO - PROCESS | 29145 | _x_x_mozilla_page_load_details 05:11:15 INFO - PROCESS | 29145 | |i|pagename|runs| 05:11:15 INFO - PROCESS | 29145 | |0;dojo.html;2627.080521817364;2696.042904768807;2700.081972129478;2715.6876959149704;2734.1797460761773;4571.06293209892;4619.74591397473;4636.466806317275;4645.070985802836;4701.153792317382;4581.954180458194;4675.509071547481;4780.0917825613105;4786.760661966905;4805.471398146201;4231.915361692764;4290;4290.892727681801;4301.946023224315;4370.4755429348525;4340.283853164224;4363.672724545656;4369.847055353063;4417.138657961698;4421.911561768763;4160.084781348099;4257.254980378421;4315.762633055181;4319.352097185416;4398.692091553577;4218.388333691628;4248.192843359751;4258.5528519505315;4263.147370525907;4275.615194632467;4244.172386384656;4249.532551419341;4262.339337402707;4263.381809637616;4265.104328091104;4557.270836666151;4607.746573938432;4612.861614151548;4614.953850461519;4662.580367766917;5013.548780609726;5032.119379108642;5032.597392208614;5033.697978121288;5081.568066714333;4904.5831104356175;5049.873753156164;5056.595472362203;5069.391672999227;5119.744012799345;4636.652251081183;4647.442306923191;4684.648651351163;4688.156131896291;4696.319033740157;5100.974495127501;5112.590992720573;5114.3095682083185;5140.948590514047;5174.508421699932;4823.324734537167;4885.6335774817035;4921.483244259372;4927.482614325444;4987.9525299687475;5033.924491132636;5050.873728156826;5051.217061355423;5054.16606259963;5072.797088116507;5012.423571289275;5016.698998060128;5017.82437614689;5018.774155163026;5043.142665746832;4874.46380898101;4972.925406118911;4974.950250497449;4975.477574854661;5003.24951257307;3844.2695887781233;3865.284922289329;3917.0990672144994;3943.8028098594955;3958.267720471722;3495;3495.038864312334;3495.1611613213154;3516.4197907345515;3528.1885166411357;4196.601322874322;4313.9137217255475;4317.093410383792;4339.674524410681;4357.128574285156;4973.179425394842;5020.949790502122;5038.823641172615;5075.111855425286;5084.669496482717;4298.20483210607;4315.09383029561;4315.633171180485;4347.217500849814;4351.6518678505645;4438;4564.132814765184;4572.542745725467;4581.862544123682;4587.564181402761;4826.372571565674;4840.878978025507;4850.296706977398;4860.586850117638;4905.55849973497;5079.644424890223;5082.4409314976065;5085.0338435697095;5085.364329458817;5119.564836988898;4704.247320428715;4827.565519103297;4838.927416088691;4902.093112774148;4906.484819094087;4968.950310496994;4984.601231901512;4986.526280003394;4991.201407774739;5019.0463811875625;5028.1200789860895;5063.746812659426;5064.898702026013;5071.771770270273;5092.210707340369;4765.142274390643;4806.327114204084;4860.198067318995;4893.461719210813;4954.455009948975;4818.277258411266;4826.131296366688;4845.370101886732;4851.51484851512;4894.779734911866;4808.447028591757;4820;4828.927566086441;4829;4864;4686.27362758773;4823.204171311834;4905.3623029006;4911.582515486224;4989.55094041538;4675.6259499239295;4765.499622539722;4772.427308722976;4790.209615413418;4808.230683090689 05:11:15 INFO - PROCESS | 29145 | |1;ext.html;571.4571157400468;609.44236024038;610.3438803286468;614.0482252508612;629.6348118091507;26506.734932650666;34807.65192348076;35399.82300088499;35409.822950885275;35411.645883541154;36289.09277268063;36632.81683591585;36979;37045.07387315318;37067;7416.221296763816;7622.123455802571;7631.54210747357;7636.969009183773;7858.332041776427;7424.294692004251;9340.57967391469;9604.711858644252;9613.951930240339;9619.759506012371;9607;9736.26977976651;9737.805243895118;9744.269179811507;9745.269104817131;7248.0939882514685;9463.621455141785;9595.568199431007;9667.90332096677;9729.513524323791;9260.073992600754;9400.106989835955;9401.952990235006;9404.200642945358;9406.529673516297;33202.50196247058;33994.15014624629;34021.659783402094;34065;34068.659313406795;2843.2241803564466;2928.677845437;2975.181824998121;2985.358147998191;2986.5818785370066;26118.34704132393;27763.444731105265;27837.721622783716;28051.57922631162;28205;3140.1835522764018;3177.491601343797;3179.443597370474;3227.2738633807207;3266.4283750343593;193892;194162.02918985314;194359;194466.02766986075;194704;50350.49649503458;50716;50733;50822.745886270335;50854.23718644223;50191.74904125456;51344.74327628338;53173.93652126936;53586.73206633942;53692.463075368745;13107.868921310856;13265.336733163496;13290;13295.135816171918;13298.800517992238;9330.860037099448;10043.748906277255;10348.793024139475;10375.481225938673;10418.166546676248;16972.15139243033;17044;17091.230894609773;17133.31466741341;17160.742588861176;6472.870542589122;6547.312532184147;6739.123913891162;6768.9508126239525;6858.931410685929;835.302522393808;943.2124176312856;965.6620182935916;976.3653625143571;1002.5789168549227;27415.314617134733;27453;27913;28167.43665126727;28219.57670634942;1020.4642562654666;1025.8974102589682;1028.3675539543126;1035.0425856083093;1052.4106500359824;14344.713105737826;14810.925945370203;14895.851041489663;14917.552473425814;14956.850431495546;205220;210068;210494;210625;269613;43462.34806477906;44419.555804441545;44592.77703611526;44604.330935036;44636;1107.4905543450104;1137.533611219396;1144.7596004839077;1204.0848954794244;1206.4209179593845;26131;28333.57499637466;28785.136445906657;28828.135155945354;28882.566761499016;40202.195956080126;40815.795921021396;41055;41060.58939410687;41146.38280425856;226041;227927;228176;228308;228720;20803.479913002295;23303;24002.639960400957;24005.639915400934;24857.1300004499;36224.818875905454;36299.81850090733;36391.45412818863;36996.630033699315;37318.25363492661;31511.527327089654;31667.683323167395;31910.361792764477;32163.35673286568;32453.837730811196;31588.526172106976;31671.366572668878;32198.517022245152;32478.512822307213;32608.51087233646;33222.16944576405;33829.83085084559;34036.82981585076;34102.65897340995;34132.65867341394;29026.27434314159;30193.245168870955;30859.84570077135;30990.845045774626;31042.534361984137;24080;24222.51554968926;24286.63570046486;24651;24707.382315442257 05:11:15 INFO - PROCESS | 29145 | |2;jquery.html;384.1759426031163;392.48388369294395;394.24560704863364;396.3302019586899;396.6985091330588;15208.315625796839;15468.767968480453;15749.527514174579;15755.212239388013;15766.842331576681;15367.846321536781;15898;16136.435224767136;16188.27152778125;16249.675006499863;4736.076465089301;4874.536918992708;4877.487863774288;4888.071266459379;4888.73111978841;4951.727654978975;5046.924296135561;5074;5079.187330027196;5084.618653600976;4918.827841025565;5024.271480635306;5032.169692000815;5045.470225626312;5061.1143049966295;5013.874653133665;5053.545180933734;5058.772355244023;5060.2409638554145;5353.839384818461;5157.845264642029;5185.870353241162;5199.168133098686;5202.817901373433;5208.348956380452;12117.515299388015;13757.518486852912;19625.705614415794;19639.607207855763;19643.508912277164;1719.4755599542134;1889.8677092603523;1932.5361913140885;1940.7477027986413;2465.9753402465926;8779.385443018991;8780.956095219482;9033.638654453815;9204.539773011322;9445.433274003582;1696.6012986948058;1769.4160926894094;1854.2768320355071;1856.3873921605973;1904.1621686457913;50032.74983625095;55636;57585.712071439375;59328;61056.694716527025;9649.93850676425;9662.806743865083;10029.949850250849;10165.52599873029;10258.640947566799;13739.862601373858;13979.860201397856;14027;14066;14097.647558810906;6934.965325173443;6963.79108626742;7207.71169153228;7275.454340924452;7365.742199023009;6729.69716362755;6764.695588698521;6770.187577490634;6807.18313802337;6946.51374403797;4328.134373125387;4374.4094547236355;4404.361367601744;4409.691321607456;4433.401490798701;1801.5316017835457;1877.11775465531;1881.560606136307;1886.1983656945742;1899.6485650154766;814.2997022560593;894.9776255593662;918.3047754839567;924.4499522783933;942.2273735536932;15573.844261557466;15840.920795395949;15935.760963585555;16298.348066077462;16578.83421165797;796.9481983671043;812.5206128384282;817.5094943034132;829.5561874397168;867.4318321499428;9086.591103400362;9188.770280743034;9350.205232555309;9364.484953327632;9576.76058098553;366363;370784;372803;373913;379826;61418.38581614216;63197.368026320066;64519.35480645134;66653;67217.66391168111;891.5943245823264;892.7857314244665;893.1247377569888;898.0301274623391;907.3331101640289;14091.788623170865;14153.363098660378;14340.641483962985;14521.564353069425;14811.555653330417;30763.53854692226;31081.37837243288;31116.377672446877;31198.68801311958;31519.527207091454;42046.36930446107;42503;43319.13361732685;43414;43591.782041089595;7539.886901696588;7554.773356799305;7569.886451703119;7603.20166382544;7658.885116723142;10057.899421005697;11068.5572577096;11224.326540407601;11281.435928203393;11417.200795944203;9611.471369074769;9659.71020869375;9700.126988571063;9714.465704386326;9845.064718851698;9799.706008819747;9914.454704991007;9920.801583968425;9926.851097233402;10010.799784004425;9796.21630269591;9925.305228634215;9936.801263974536;9996.700098997042;10053.296269261082;7475.327220550176;7530;7620.69517219305;7661.463697541119;7710.074791025113;8166.346692264486;9158.221551168226;9831.508424578886;9886.209103271578;10081.899181008095 05:11:15 INFO - PROCESS | 29145 | |3;mootools.html;1221.6884694402927;1412.5479846449136;1444.3716983112345;1531.9540413787583;1746.0658547676996;6657.600543967359;7295.124585049794;7425.665845036973;7469.178390377054;7493.138289096755;7232.710691572331;7393.556386616807;7400.444966627498;7403.629818509066;7404.2225566315565;2250.8199344052477;2279.418748219202;2283.303592404316;2283.851549649276;2288.0733303012225;2228.4317499037725;2259.6949411829355;2260.0959616153505;2265.0713207584895;2281.863088214712;2228.832837537191;2242.1255710272926;2249.1116009176367;2267.4784799496124;2273.056681477185;2197.9450513737124;2222.555488902226;2222.84440089193;2230.197129033547;2231.4867580456503;2162.48100455891;2169.40341406113;2170.6092903277404;2171.5982543229397;2176.1404245323165;7356.926430735678;7425.220351863085;7470.850582988364;7496.662650180755;7506.474546781727;4526.23054080807;4671.556202160789;4674.69614475058;4679.344891715163;4689.366935463737;2982.776291778125;2987.2382542451537;3004.2789730464533;3009.277773334406;3067.4018566379564;900.8963969143567;904.674317245791;908.7728067983004;910.2854259406334;913.3560839608127;9559.235261179088;9622.037796220391;9896.95051524745;9907.801843963152;9910.653127140587;4146.937795933063;4194.937075943863;4306.20335237982;4307.267764480046;4311.33174357975;8026.678932842738;8030.558319292378;8032.959835200903;8062.234087761653;8085.312748416332;4670.416197975253;4689.179393606105;4725.763711814464;4735.95264047362;4738.47876733559;3681.4845921571;4142.565030671796;4182.163567286555;4326.459192600925;4327.783610819446;3361.478970759536;3397.320535892782;3431.987563668724;3470.149813295708;3522.1018640246575;1074.5164675895721;1075.370908018802;1083.3716444462193;1084.9186311026704;1089.5042755546208;583.3959577581734;683.2040672616446;828.1552816127517;859.5573279760928;863.6847550644095;5162.586993040548;5423.972880135653;5453.836384908459;5510.228568000483;5616.2698849150165;862.6980556805194;870.6430363550913;898.3397203055749;903.5437104262305;927.0729270729271;3478.32172726321;3761.6238376162714;3774.3772277573894;3806.3719486284454;3819.4461803038957;9019.368644194974;9221.400608960395;9403.34176607631;9426.481543515036;9434.103760142776;9107.908920910839;9275.489848058287;9303.674371396968;9321.347505674537;9323.813523729488;7029.89455158173;7249.311315425026;7296.12446506412;7307.26927307265;7347.412207023425;5217.399999000164;5260.658057226268;5281.55106815925;5374.4088150304215;5375.784968601212;8605.483670979762;8719.433236839584;8750.82498350042;8751.737447876574;8829.911700882909;8716.956415218137;9055.864162037706;9174.633014679339;9208.815823683355;9296.907030929875;6405.231372235362;6513.348665133449;6533.346665333429;6538.1500404947055;6542.34576542342;7267.164276108315;7339.302766237199;7364.742234021784;7411.777646670608;7418.072740907387;6388.265349484683;6544.345565443417;6574.737010519526;6595.1096601958125;6678.3989440950545;6734.461243100638;6782.525223234326;6818.352256535622;6826.385625293748;6855.862882742417;6182.258129024546;6297.937020629918;6392.808215753535;6393.712282947372;6451.032345148077;4527.094581083862;4541.72749635023;4590.0590378971565;4661.277501987197;4743.928841067456;4539.409876716006;4575.771211439348;4601.240795268744;4659.953400466087;4711.458182309078 05:11:15 INFO - PROCESS | 29145 | |4;prototype.html;293.3238884371524;307.8368464713701;308.87644942023195;314.84100529232734;315.11767052253686;4497.2354699701045;4680.180968330541;4717.150912835688;4751.311059896313;4791.808327666889;4523.45718513778;4746.501617330183;4750.691205071668;4764.90470190596;4784.66507344486;3769.0954170998966;3789.5263092113487;3791.2986097571898;3803.410471376927;3829.5404551453726;3536.9292614147703;3585.8027808470524;3771.0949372150762;3780.3384407728677;3787.9810600946957;3715.8885233442907;3726.919193433901;3729.4219395993664;3750.474933509311;3751.4747935288947;3707.6663100320966;3716.4239542870628;3722.3299806034765;3726.5155529781227;3753.9676588937987;3270.4440245158144;3315.3037862049;3324.5678061851804;3331.3170799985946;3335.5497007903864;4330.523642399334;4562.88592785183;4613.83851565197;4625.283081122431;4638.605718513931;4308.3537469379535;4310.676699247538;4322.438083049184;4328.264195086843;4339.5443478434945;5004.674696144775;5006.499350064964;5011.223260394645;5025.447200807908;5039.72281524516;3592.586852511942;3640.6177351377987;3701.444783282502;3703.092742278159;3710.443433484972;5097.821576244851;5153.149730294497;5195.844124676266;5200.6879587224885;5211.661242019294;3754.8310326035394;3761.5486141663177;3770.377887648562;3777.9244415112094;3781.5084039074745;3759.8793001808435;3816.542014958223;3817.751846129993;3836.3094642963974;3842.1547259602844;4124.649404800565;4274.358846173037;4274.572542745763;4275;4294.570542945743;4911.238757992517;4926.802927882916;4939.357883475125;4949.7873021109335;4987.900241995212;1296.2999980010877;1320.2078752748275;1379.200063962899;1388.999920057557;1398.8461269260374;949.8052899155656;962.5957098018708;968.5447839515416;968.7529679931572;976.3653625143713;4580.862574122782;4585.472670642852;4592.173408786383;4604.861854144381;4608.654350923627;5383.730813459311;5385.838424847261;5391.867707781332;5400.567954563704;5412.188171774265;4483.21543729846;4579.931301030487;4588.128255631419;4593.954060459353;4595.448546174413;2852.0873320537644;2890.248535380816;2898.174020404175;2899.2027192522223;2905.8111222770876;5110.540051395318;5170.1469257572835;5170.71561064145;5171.97414012935;5185.662931909414;5409.945900541023;5511.118221084607;5531.3915469298345;5544.528715059265;5554.6944918029085;5135.050015747024;5143.5113664201845;5145.922811157836;5149.510796474329;5174.120399532088;5397.406285308692;5406.486383793534;5406.864828379322;5416.322959630046;5423.728813559385;5105.2342148678;5271.525562699376;5291.285676433632;5300.893982120413;5303.071962406486;5101.668391554537;5105.897882042413;5128.897422051613;5130.948690513047;5135.229715542699;3906.2968665640456;3924.9215015700097;3929.565708516428;3937.27160475313;3942.4086387042175;4904.5340692634145;5247.55395791362;5379.973100134474;5399.109146990702;5402.108652072364;4851.805927762991;4934.827281045146;4963.429205641398;4964.8758781030765;4998.376177271449;4900.5099490052135;4945.109880221451;4954.702717836942;4974.353334066548;4982.2775697524385;4793;4868.537488938545;4896.36347274852;4906.92639610399;4926.482719314564;4961.875953101057;4984.975075124601;4989.25161225819;4993.475685053162;5015.548600625962;4855.975720121377;4871.123197824426;4876.634252431011;4882.975585122052;4886.804527818847 05:11:15 INFO - PROCESS | 29145 | |5;yui.html;587.3509771702269;653.7450394346206;660.8149718078938;682.0894106367998;701.0815831261046;12138.635840924764;12520.186187897792;12546.498140074398;13038.674033149153;13514.054016218868;12660.240385576872;12755.04337174711;12770.16993895396;12790.360481975911;12804.871951280484;626.3392121312014;792.7978365516785;810.7648781853255;814.8899898513714;814.914433984432;826.7313123234943;832.0556168748484;832.1096426823301;832.3590835057033;832.81261716114;858.4076986879064;868.8479516084692;868.9826203475926;870.1602953150209;871.1593312453481;655.573876979962;827.5655280977475;859.2352806002663;865.519636601689;866.8873046503945;625.7497001199556;627.1345543150469;627.3663599764226;627.5513008199114;627.7614506487505;11992.400379981053;12081.87918120825;12081.93959030208;12097.274163550215;12135.029197664255;10924.508397122148;11246.831297530543;11466.426678666034;11523.790002049831;11627.476763545661;9694.687746561898;9891.060349266809;9959.75100622483;9981.850272245922;10269.486525673687;3266.70599646033;3293.2425542125447;3302.058913209724;3342.097633638904;3399.031276086328;43511.78244108791;43937;44381;46755.29867051997;47206.291905621445;9315.72052838416;9364.391314564531;9396.530173491297;9522.0954009369;9567.186789122863;16205.756913646304;16228.432004879773;16236.59408514773;16246.350145994264;16255.349786008428;6326.873462530723;6364.745410183634;6407.583507072025;6408.935910640927;6496.545241833026;3552.786832789989;3673.797941113211;3674.5590529136675;3679.77921324716;3822.6559609635265;2763.3367991681853;2832.8017038807084;3046.1166261783833;3135.106494649014;3158.7630927680516;553.9639923404966;563.374654133911;564.6442741073098;565.9886802263932;566.9603127781098;563.5435297409111;573.1374281706006;579.1573260905373;581.4505292498549;608.1111293279453;7593.696252149963;8254.752357429286;8532.829343413097;8739.169778870997;8840.292776577859;580.3239226301312;581.1254062635707;585.280105470274;593.1676245925653;600.0459269761101;3717.8141092945243;3795.2409518096492;3832.5017747693178;3839.251345987506;4028.939565906514;46434.767826160656;51280.48719512832;51320.74339628278;51397.48602513927;61051;44077.33883991743;44306.33540496895;48076.27885581719;48674.51325486771;50254.24618630723;44337.556624433986;45097.32354014692;45626;45668.54331456643;47051.76474117676;8263.95868020656;8315.459495132796;8327.875081873655;8349.332053435832;8473.804100227937;29125.417491649623;29134;29758.55362169526;30802.229944251572;30895.382092358475;34090.14774630654;36838;38796.2240755189;39060.414093789186;40325.39511907382;9351.766205844908;10065.798684026426;10193.541290641791;10303.896961030294;10699.411532365795;10863.456827158452;11522.366269855238;11796.29222246668;11830.349330786888;11890.643280701594;11063.557457701601;11113.944430277797;11242.55029798799;11258.268212566158;11393.202475826612;9859.950700246452;9996.650117246152;10048.598056077675;10194.796104078025;10430;10286.177105831664;10742.355458672504;10929.507174048658;11125.944370278097;11221.382823944761;9371.437713737198;9471.905280947103;9671.516424178622;9701.417914925127;10069.647562335284;8910.732678019669;9683.564239609093;9767.511624418608;9775.608975641178;9877.308588398742 05:11:15 INFO - PROCESS | 29145 | __end_tp_report 05:11:15 INFO - PROCESS | 29145 | __start_cc_report 05:11:15 INFO - PROCESS | 29145 | _x_x_mozilla_cycle_collect,1158 05:11:15 INFO - PROCESS | 29145 | __end_cc_report 05:11:15 INFO - PROCESS | 29145 | __startTimestamp1461845475027__endTimestamp 05:11:15 INFO - PROCESS | 29145 | 05:11:15 INFO - PROCESS | 29145 | ------- Summary: start ------- 05:11:15 INFO - PROCESS | 29145 | Number of tests: 6 05:11:15 INFO - PROCESS | 29145 | 05:11:15 INFO - PROCESS | 29145 | [#0] dojo.html Cycles:165 Average:4624.04 Median:4806.33 stddev:508.78 (10.6%) stddev-sans-first:485.62 05:11:15 INFO - PROCESS | 29145 | Values: 2627.1 2696.0 2700.1 2715.7 2734.2 4571.1 4619.7 4636.5 4645.1 4701.2 4582.0 4675.5 4780.1 4786.8 4805.5 4231.9 4290.0 4290.9 4301.9 4370.5 4340.3 4363.7 4369.8 4417.1 4421.9 4160.1 4257.3 4315.8 4319.4 4398.7 4218.4 4248.2 4258.6 4263.1 4275.6 4244.2 4249.5 4262.3 4263.4 4265.1 4557.3 4607.7 4612.9 4615.0 4662.6 5013.5 5032.1 5032.6 5033.7 5081.6 4904.6 5049.9 5056.6 5069.4 5119.7 4636.7 4647.4 4684.6 4688.2 4696.3 5101.0 5112.6 5114.3 5140.9 5174.5 4823.3 4885.6 4921.5 4927.5 4988.0 5033.9 5050.9 5051.2 5054.2 5072.8 5012.4 5016.7 5017.8 5018.8 5043.1 4874.5 4972.9 4975.0 4975.5 5003.2 3844.3 3865.3 3917.1 3943.8 3958.3 3495.0 3495.0 3495.2 3516.4 3528.2 4196.6 4313.9 4317.1 4339.7 4357.1 4973.2 5020.9 5038.8 5075.1 5084.7 4298.2 4315.1 4315.6 4347.2 4351.7 4438.0 4564.1 4572.5 4581.9 4587.6 4826.4 4840.9 4850.3 4860.6 4905.6 5079.6 5082.4 5085.0 5085.4 5119.6 4704.2 4827.6 4838.9 4902.1 4906.5 4969.0 4984.6 4986.5 4991.2 5019.0 5028.1 5063.7 5064.9 5071.8 5092.2 4765.1 4806.3 4860.2 4893.5 4954.5 4818.3 4826.1 4845.4 4851.5 4894.8 4808.4 4820.0 4828.9 4829.0 4864.0 4686.3 4823.2 4905.4 4911.6 4989.6 4675.6 4765.5 4772.4 4790.2 4808.2 05:11:15 INFO - PROCESS | 29145 | 05:11:15 INFO - PROCESS | 29145 | [#1] ext.html Cycles:180 Average:37471.76 Median:17712.90 stddev:55792.90 (315.0%) stddev-sans-first:55880.61 05:11:15 INFO - PROCESS | 29145 | Values: 571.5 609.4 610.3 614.0 629.6 26506.7 34807.7 35399.8 35409.8 35411.6 36289.1 36632.8 36979.0 37045.1 37067.0 7416.2 7622.1 7631.5 7637.0 7858.3 7424.3 9340.6 9604.7 9614.0 9619.8 9607.0 9736.3 9737.8 9744.3 9745.3 7248.1 9463.6 9595.6 9667.9 9729.5 9260.1 9400.1 9402.0 9404.2 9406.5 33202.5 33994.2 34021.7 34065.0 34068.7 2843.2 2928.7 2975.2 2985.4 2986.6 26118.3 27763.4 27837.7 28051.6 28205.0 3140.2 3177.5 3179.4 3227.3 3266.4 193892.0 194162.0 194359.0 194466.0 194704.0 50350.5 50716.0 50733.0 50822.7 50854.2 50191.7 51344.7 53173.9 53586.7 53692.5 13107.9 13265.3 13290.0 13295.1 13298.8 9330.9 10043.7 10348.8 10375.5 10418.2 16972.2 17044.0 17091.2 17133.3 17160.7 6472.9 6547.3 6739.1 6769.0 6858.9 835.3 943.2 965.7 976.4 1002.6 27415.3 27453.0 27913.0 28167.4 28219.6 1020.5 1025.9 1028.4 1035.0 1052.4 14344.7 14810.9 14895.9 14917.6 14956.9 205220.0 210068.0 210494.0 210625.0 269613.0 43462.3 44419.6 44592.8 44604.3 44636.0 1107.5 1137.5 1144.8 1204.1 1206.4 26131.0 28333.6 28785.1 28828.1 28882.6 40202.2 40815.8 41055.0 41060.6 41146.4 226041.0 227927.0 228176.0 228308.0 228720.0 20803.5 23303.0 24002.6 24005.6 24857.1 36224.8 36299.8 36391.5 36996.6 37318.3 31511.5 31667.7 31910.4 32163.4 32453.8 31588.5 31671.4 32198.5 32478.5 32608.5 33222.2 33829.8 34036.8 34102.7 34132.7 29026.3 30193.2 30859.8 30990.8 31042.5 24080.0 24222.5 24286.6 24651.0 24707.4 05:11:15 INFO - PROCESS | 29145 | 05:11:15 INFO - PROCESS | 29145 | [#2] jquery.html Cycles:180 Average:22412.44 Median:5028.22 stddev:61110.70 (1215.4%) stddev-sans-first:61259.75 05:11:15 INFO - PROCESS | 29145 | Values: 384.2 392.5 394.2 396.3 396.7 15208.3 15468.8 15749.5 15755.2 15766.8 15367.8 15898.0 16136.4 16188.3 16249.7 4736.1 4874.5 4877.5 4888.1 4888.7 4951.7 5046.9 5074.0 5079.2 5084.6 4918.8 5024.3 5032.2 5045.5 5061.1 5013.9 5053.5 5058.8 5060.2 5353.8 5157.8 5185.9 5199.2 5202.8 5208.3 12117.5 13757.5 19625.7 19639.6 19643.5 1719.5 1889.9 1932.5 1940.7 2466.0 8779.4 8781.0 9033.6 9204.5 9445.4 1696.6 1769.4 1854.3 1856.4 1904.2 50032.7 55636.0 57585.7 59328.0 61056.7 9649.9 9662.8 10029.9 10165.5 10258.6 13739.9 13979.9 14027.0 14066.0 14097.6 6935.0 6963.8 7207.7 7275.5 7365.7 6729.7 6764.7 6770.2 6807.2 6946.5 4328.1 4374.4 4404.4 4409.7 4433.4 1801.5 1877.1 1881.6 1886.2 1899.6 814.3 895.0 918.3 924.4 942.2 15573.8 15840.9 15935.8 16298.3 16578.8 796.9 812.5 817.5 829.6 867.4 9086.6 9188.8 9350.2 9364.5 9576.8 366363.0 370784.0 372803.0 373913.0 379826.0 61418.4 63197.4 64519.4 66653.0 67217.7 891.6 892.8 893.1 898.0 907.3 14091.8 14153.4 14340.6 14521.6 14811.6 30763.5 31081.4 31116.4 31198.7 31519.5 42046.4 42503.0 43319.1 43414.0 43591.8 7539.9 7554.8 7569.9 7603.2 7658.9 10057.9 11068.6 11224.3 11281.4 11417.2 9611.5 9659.7 9700.1 9714.5 9845.1 9799.7 9914.5 9920.8 9926.9 10010.8 9796.2 9925.3 9936.8 9996.7 10053.3 7475.3 7530.0 7620.7 7661.5 7710.1 8166.3 9158.2 9831.5 9886.2 10081.9 05:11:15 INFO - PROCESS | 29145 | 05:11:15 INFO - PROCESS | 29145 | [#3] mootools.html Cycles:180 Average:5036.13 Median:3382.83 stddev:2719.00 (80.4%) stddev-sans-first:2711.51 05:11:15 INFO - PROCESS | 29145 | Values: 1221.7 1412.5 1444.4 1532.0 1746.1 6657.6 7295.1 7425.7 7469.2 7493.1 7232.7 7393.6 7400.4 7403.6 7404.2 2250.8 2279.4 2283.3 2283.9 2288.1 2228.4 2259.7 2260.1 2265.1 2281.9 2228.8 2242.1 2249.1 2267.5 2273.1 2197.9 2222.6 2222.8 2230.2 2231.5 2162.5 2169.4 2170.6 2171.6 2176.1 7356.9 7425.2 7470.9 7496.7 7506.5 4526.2 4671.6 4674.7 4679.3 4689.4 2982.8 2987.2 3004.3 3009.3 3067.4 900.9 904.7 908.8 910.3 913.4 9559.2 9622.0 9897.0 9907.8 9910.7 4146.9 4194.9 4306.2 4307.3 4311.3 8026.7 8030.6 8033.0 8062.2 8085.3 4670.4 4689.2 4725.8 4736.0 4738.5 3681.5 4142.6 4182.2 4326.5 4327.8 3361.5 3397.3 3432.0 3470.1 3522.1 1074.5 1075.4 1083.4 1084.9 1089.5 583.4 683.2 828.2 859.6 863.7 5162.6 5424.0 5453.8 5510.2 5616.3 862.7 870.6 898.3 903.5 927.1 3478.3 3761.6 3774.4 3806.4 3819.4 9019.4 9221.4 9403.3 9426.5 9434.1 9107.9 9275.5 9303.7 9321.3 9323.8 7029.9 7249.3 7296.1 7307.3 7347.4 5217.4 5260.7 5281.6 5374.4 5375.8 8605.5 8719.4 8750.8 8751.7 8829.9 8717.0 9055.9 9174.6 9208.8 9296.9 6405.2 6513.3 6533.3 6538.2 6542.3 7267.2 7339.3 7364.7 7411.8 7418.1 6388.3 6544.3 6574.7 6595.1 6678.4 6734.5 6782.5 6818.4 6826.4 6855.9 6182.3 6297.9 6392.8 6393.7 6451.0 4527.1 4541.7 4590.1 4661.3 4743.9 4539.4 4575.8 4601.2 4660.0 4711.5 05:11:15 INFO - PROCESS | 29145 | 05:11:15 INFO - PROCESS | 29145 | [#4] prototype.html Cycles:180 Average:4241.41 Median:4751.00 stddev:1217.71 (25.6%) stddev-sans-first:1184.53 05:11:15 INFO - PROCESS | 29145 | Values: 293.3 307.8 308.9 314.8 315.1 4497.2 4680.2 4717.2 4751.3 4791.8 4523.5 4746.5 4750.7 4764.9 4784.7 3769.1 3789.5 3791.3 3803.4 3829.5 3536.9 3585.8 3771.1 3780.3 3788.0 3715.9 3726.9 3729.4 3750.5 3751.5 3707.7 3716.4 3722.3 3726.5 3754.0 3270.4 3315.3 3324.6 3331.3 3335.5 4330.5 4562.9 4613.8 4625.3 4638.6 4308.4 4310.7 4322.4 4328.3 4339.5 5004.7 5006.5 5011.2 5025.4 5039.7 3592.6 3640.6 3701.4 3703.1 3710.4 5097.8 5153.1 5195.8 5200.7 5211.7 3754.8 3761.5 3770.4 3777.9 3781.5 3759.9 3816.5 3817.8 3836.3 3842.2 4124.6 4274.4 4274.6 4275.0 4294.6 4911.2 4926.8 4939.4 4949.8 4987.9 1296.3 1320.2 1379.2 1389.0 1398.8 949.8 962.6 968.5 968.8 976.4 4580.9 4585.5 4592.2 4604.9 4608.7 5383.7 5385.8 5391.9 5400.6 5412.2 4483.2 4579.9 4588.1 4594.0 4595.4 2852.1 2890.2 2898.2 2899.2 2905.8 5110.5 5170.1 5170.7 5172.0 5185.7 5409.9 5511.1 5531.4 5544.5 5554.7 5135.1 5143.5 5145.9 5149.5 5174.1 5397.4 5406.5 5406.9 5416.3 5423.7 5105.2 5271.5 5291.3 5300.9 5303.1 5101.7 5105.9 5128.9 5130.9 5135.2 3906.3 3924.9 3929.6 3937.3 3942.4 4904.5 5247.6 5380.0 5399.1 5402.1 4851.8 4934.8 4963.4 4964.9 4998.4 4900.5 4945.1 4954.7 4974.4 4982.3 4793.0 4868.5 4896.4 4906.9 4926.5 4961.9 4985.0 4989.3 4993.5 5015.5 4856.0 4871.1 4876.6 4883.0 4886.8 05:11:15 INFO - PROCESS | 29145 | 05:11:15 INFO - PROCESS | 29145 | [#5] yui.html Cycles:180 Average:12745.61 Median:47129.03 stddev:14605.64 (31.0%) stddev-sans-first:14618.08 05:11:15 INFO - PROCESS | 29145 | Values: 587.4 653.7 660.8 682.1 701.1 12138.6 12520.2 12546.5 13038.7 13514.1 12660.2 12755.0 12770.2 12790.4 12804.9 626.3 792.8 810.8 814.9 814.9 826.7 832.1 832.1 832.4 832.8 858.4 868.8 869.0 870.2 871.2 655.6 827.6 859.2 865.5 866.9 625.7 627.1 627.4 627.6 627.8 11992.4 12081.9 12081.9 12097.3 12135.0 10924.5 11246.8 11466.4 11523.8 11627.5 9694.7 9891.1 9959.8 9981.9 10269.5 3266.7 3293.2 3302.1 3342.1 3399.0 43511.8 43937.0 44381.0 46755.3 47206.3 9315.7 9364.4 9396.5 9522.1 9567.2 16205.8 16228.4 16236.6 16246.4 16255.3 6326.9 6364.7 6407.6 6408.9 6496.5 3552.8 3673.8 3674.6 3679.8 3822.7 2763.3 2832.8 3046.1 3135.1 3158.8 554.0 563.4 564.6 566.0 567.0 563.5 573.1 579.2 581.5 608.1 7593.7 8254.8 8532.8 8739.2 8840.3 580.3 581.1 585.3 593.2 600.0 3717.8 3795.2 3832.5 3839.3 4028.9 46434.8 51280.5 51320.7 51397.5 61051.0 44077.3 44306.3 48076.3 48674.5 50254.2 44337.6 45097.3 45626.0 45668.5 47051.8 8264.0 8315.5 8327.9 8349.3 8473.8 29125.4 29134.0 29758.6 30802.2 30895.4 34090.1 36838.0 38796.2 39060.4 40325.4 9351.8 10065.8 10193.5 10303.9 10699.4 10863.5 11522.4 11796.3 11830.3 11890.6 11063.6 11113.9 11242.6 11258.3 11393.2 9860.0 9996.7 10048.6 10194.8 10430.0 10286.2 10742.4 10929.5 11125.9 11221.4 9371.4 9471.9 9671.5 9701.4 10069.6 8910.7 9683.6 9767.5 9775.6 9877.3 05:11:15 INFO - PROCESS | 29145 | -------- Summary: end -------- 05:11:15 INFO - PROCESS | 29145 | 05:11:15 INFO - TEST-INFO | 29145: exit 0 05:11:15 INFO - TEST-OK | dromaeo_css | took 1118371ms 05:11:15 INFO - TEST-START | kraken 05:11:15 INFO - operating with platform_type : linux_ 05:11:15 INFO - Initialising browser for kraken test... 05:11:15 INFO - TEST-INFO | started process 29317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjdHjqa/profile http://localhost:49481/getInfo.html) 05:11:20 INFO - PROCESS | 29317 | __metrics Screen width/height:1600/1200 05:11:20 INFO - PROCESS | 29317 | colorDepth:24 05:11:20 INFO - PROCESS | 29317 | Browser inner width/height: 1024/697 05:11:20 INFO - PROCESS | 29317 | __metrics 05:11:21 ERROR - PROCESS | 29317 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:11:22 INFO - TEST-INFO | 29317: exit 0 05:11:22 INFO - Browser initialized. 05:11:22 INFO - Running cycle 1/1 for kraken test... 05:11:22 INFO - TEST-INFO | started process 29397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjdHjqa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:33 INFO - PROCESS | 29397 | RSS: Main: 155627520 05:11:33 INFO - PROCESS | 29397 | 05:11:36 INFO - PROCESS | 29397 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49481/tests/kraken/driver.html?testName=audio-beat-detection) 05:11:37 INFO - PROCESS | 29397 | RSS: Main: 210722816 05:11:37 INFO - PROCESS | 29397 | 05:11:40 INFO - PROCESS | 29397 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49481/tests/kraken/driver.html?testName=audio-dft) 05:11:41 INFO - PROCESS | 29397 | RSS: Main: 195928064 05:11:41 INFO - PROCESS | 29397 | 05:11:44 INFO - PROCESS | 29397 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49481/tests/kraken/driver.html?testName=audio-fft) 05:11:44 INFO - PROCESS | 29397 | RSS: Main: 267366400 05:11:44 INFO - PROCESS | 29397 | 05:11:46 INFO - PROCESS | 29397 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49481/tests/kraken/driver.html?testName=audio-oscillator) 05:11:47 INFO - PROCESS | 29397 | RSS: Main: 175738880 05:11:47 INFO - PROCESS | 29397 | 05:11:49 INFO - PROCESS | 29397 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49481/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:11:50 INFO - PROCESS | 29397 | RSS: Main: 179949568 05:11:50 INFO - PROCESS | 29397 | 05:11:53 INFO - PROCESS | 29397 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49481/tests/kraken/driver.html?testName=imaging-darkroom) 05:11:54 INFO - PROCESS | 29397 | RSS: Main: 216207360 05:11:54 INFO - PROCESS | 29397 | 05:11:57 INFO - PROCESS | 29397 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49481/tests/kraken/driver.html?testName=imaging-desaturate) 05:11:58 INFO - PROCESS | 29397 | RSS: Main: 216109056 05:11:58 INFO - PROCESS | 29397 | 05:12:01 INFO - PROCESS | 29397 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49481/tests/kraken/driver.html?testName=json-parse-financial) 05:12:01 INFO - PROCESS | 29397 | RSS: Main: 217030656 05:12:01 INFO - PROCESS | 29397 | 05:12:03 INFO - PROCESS | 29397 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49481/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:12:04 INFO - PROCESS | 29397 | RSS: Main: 204476416 05:12:04 INFO - PROCESS | 29397 | 05:12:05 INFO - PROCESS | 29397 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49481/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:12:06 INFO - PROCESS | 29397 | RSS: Main: 207212544 05:12:06 INFO - PROCESS | 29397 | 05:12:08 INFO - PROCESS | 29397 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49481/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:12:09 INFO - PROCESS | 29397 | RSS: Main: 217939968 05:12:09 INFO - PROCESS | 29397 | 05:12:12 INFO - PROCESS | 29397 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:12:12 INFO - PROCESS | 29397 | RSS: Main: 224727040 05:12:12 INFO - PROCESS | 29397 | 05:12:16 INFO - PROCESS | 29397 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:12:16 INFO - PROCESS | 29397 | RSS: Main: 220688384 05:12:16 INFO - PROCESS | 29397 | 05:12:18 INFO - PROCESS | 29397 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49481/tests/kraken/driver.html?testName=ai-astar) 05:12:18 INFO - PROCESS | 29397 | RSS: Main: 283709440 05:12:18 INFO - PROCESS | 29397 | 05:12:18 INFO - PROCESS | 29397 | __start_tp_report 05:12:18 INFO - PROCESS | 29397 | _x_x_mozilla_page_load 05:12:18 INFO - PROCESS | 29397 | _x_x_mozilla_page_load_details 05:12:18 INFO - PROCESS | 29397 | |i|pagename|runs| 05:12:18 INFO - PROCESS | 29397 | |0;ai-astar;113;116;107;113;114;113;101;113;113;115 05:12:18 INFO - PROCESS | 29397 | |1;audio-beat-detection;165;133;155;200;133;155;162;139;192;136 05:12:18 INFO - PROCESS | 29397 | |2;audio-dft;161;160;161;159;162;163;162;161;162;162 05:12:18 INFO - PROCESS | 29397 | |3;audio-fft;78;75;127;109;78;74;73;114;102;74 05:12:18 INFO - PROCESS | 29397 | |4;audio-oscillator;95;96;155;93;95;94;150;94;93;143 05:12:18 INFO - PROCESS | 29397 | |5;imaging-gaussian-blur;118;116;117;117;117;117;117;118;118;118 05:12:18 INFO - PROCESS | 29397 | |6;imaging-darkroom;145;145;146;146;146;146;146;145;145;146 05:12:18 INFO - PROCESS | 29397 | |7;imaging-desaturate;94;94;95;95;94;94;95;95;95;94 05:12:18 INFO - PROCESS | 29397 | |8;json-parse-financial;65;64;64;64;65;63;65;80;63;62 05:12:18 INFO - PROCESS | 29397 | |9;json-stringify-tinderbox;64;64;65;64;65;65;65;64;65;65 05:12:18 INFO - PROCESS | 29397 | |10;stanford-crypto-aes;78;87;77;77;80;80;86;80;79;80 05:12:18 INFO - PROCESS | 29397 | |11;stanford-crypto-ccm;137;134;137;133;143;137;130;135;168;140 05:12:18 INFO - PROCESS | 29397 | |12;stanford-crypto-pbkdf2;220;221;216;214;220;220;217;217;217;217 05:12:18 INFO - PROCESS | 29397 | |13;stanford-crypto-sha256-iterative;74;76;74;77;76;74;72;72;72;74 05:12:18 INFO - PROCESS | 29397 | __end_tp_report 05:12:18 INFO - PROCESS | 29397 | __start_cc_report 05:12:18 INFO - PROCESS | 29397 | _x_x_mozilla_cycle_collect,1885 05:12:18 INFO - PROCESS | 29397 | __end_cc_report 05:12:18 INFO - PROCESS | 29397 | __startTimestamp1461845538843__endTimestamp 05:12:18 INFO - PROCESS | 29397 | 05:12:18 INFO - PROCESS | 29397 | ------- Summary: start ------- 05:12:18 INFO - PROCESS | 29397 | Number of tests: 14 05:12:18 INFO - PROCESS | 29397 | 05:12:18 INFO - PROCESS | 29397 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:4.47 (4.0%) stddev-sans-first:4.72 05:12:18 INFO - PROCESS | 29397 | Values: 113.0 116.0 107.0 113.0 114.0 113.0 101.0 113.0 113.0 115.0 05:12:18 INFO - PROCESS | 29397 | 05:12:18 INFO - PROCESS | 29397 | [#1] audio-beat-detection Cycles:10 Average:157.00 Median:158.50 stddev:23.78 (15.0%) stddev-sans-first:25.04 05:12:18 INFO - PROCESS | 29397 | Values: 165.0 133.0 155.0 200.0 133.0 155.0 162.0 139.0 192.0 136.0 05:12:18 INFO - PROCESS | 29397 | 05:12:18 INFO - PROCESS | 29397 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 05:12:18 INFO - PROCESS | 29397 | Values: 161.0 160.0 161.0 159.0 162.0 163.0 162.0 161.0 162.0 162.0 05:12:18 INFO - PROCESS | 29397 | 05:12:18 INFO - PROCESS | 29397 | [#3] audio-fft Cycles:10 Average:90.40 Median:74.00 stddev:20.45 (27.6%) stddev-sans-first:21.19 05:12:18 INFO - PROCESS | 29397 | Values: 78.0 75.0 127.0 109.0 78.0 74.0 73.0 114.0 102.0 74.0 05:12:18 INFO - PROCESS | 29397 | 05:12:18 INFO - PROCESS | 29397 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:94.00 stddev:26.76 (28.5%) stddev-sans-first:27.76 05:12:18 INFO - PROCESS | 29397 | Values: 95.0 96.0 155.0 93.0 95.0 94.0 150.0 94.0 93.0 143.0 05:12:18 INFO - PROCESS | 29397 | 05:12:18 INFO - PROCESS | 29397 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 05:12:18 INFO - PROCESS | 29397 | Values: 118.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 05:12:18 INFO - PROCESS | 29397 | 05:12:18 INFO - PROCESS | 29397 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:12:18 INFO - PROCESS | 29397 | Values: 145.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 05:12:18 INFO - PROCESS | 29397 | 05:12:18 INFO - PROCESS | 29397 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 05:12:18 INFO - PROCESS | 29397 | Values: 94.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 05:12:18 INFO - PROCESS | 29397 | 05:12:18 INFO - PROCESS | 29397 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:64.50 stddev:5.19 (8.0%) stddev-sans-first:5.50 05:12:18 INFO - PROCESS | 29397 | Values: 65.0 64.0 64.0 64.0 65.0 63.0 65.0 80.0 63.0 62.0 05:12:18 INFO - PROCESS | 29397 | 05:12:18 INFO - PROCESS | 29397 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 05:12:18 INFO - PROCESS | 29397 | Values: 64.0 64.0 65.0 64.0 65.0 65.0 65.0 64.0 65.0 65.0 05:12:18 INFO - PROCESS | 29397 | 05:12:18 INFO - PROCESS | 29397 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:3.44 (4.3%) stddev-sans-first:3.54 05:12:18 INFO - PROCESS | 29397 | Values: 78.0 87.0 77.0 77.0 80.0 80.0 86.0 80.0 79.0 80.0 05:12:18 INFO - PROCESS | 29397 | 05:12:18 INFO - PROCESS | 29397 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:137.00 stddev:10.68 (7.8%) stddev-sans-first:11.29 05:12:18 INFO - PROCESS | 29397 | Values: 137.0 134.0 137.0 133.0 143.0 137.0 130.0 135.0 168.0 140.0 05:12:18 INFO - PROCESS | 29397 | 05:12:18 INFO - PROCESS | 29397 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:217.90 Median:218.50 stddev:2.23 (1.0%) stddev-sans-first:2.24 05:12:18 INFO - PROCESS | 29397 | Values: 220.0 221.0 216.0 214.0 220.0 220.0 217.0 217.0 217.0 217.0 05:12:18 INFO - PROCESS | 29397 | 05:12:18 INFO - PROCESS | 29397 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:74.00 stddev:1.79 (2.4%) stddev-sans-first:1.90 05:12:18 INFO - PROCESS | 29397 | Values: 74.0 76.0 74.0 77.0 76.0 74.0 72.0 72.0 72.0 74.0 05:12:18 INFO - PROCESS | 29397 | -------- Summary: end -------- 05:12:18 INFO - PROCESS | 29397 | 05:12:19 INFO - TEST-INFO | 29397: exit 0 05:12:19 INFO - TEST-OK | kraken | took 64189ms 05:12:19 INFO - SUITE-END | took 1182s 05:12:20 INFO - Completed test suite (00:19:43) 05:12:20 INFO - javascript benchmark 05:12:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2627.080521817364, 2696.042904768807, 2700.081972129478, 2715.6876959149704, 2734.1797460761773, 4571.06293209892, 4619.74591397473, 4636.466806317275, 4645.070985802836, 4701.153792317382, 4581.954180458194, 4675.509071547481, 4780.0917825613105, 4786.760661966905, 4805.471398146201, 4231.915361692764, 4290.0, 4290.892727681801, 4301.946023224315, 4370.4755429348525, 4340.283853164224, 4363.672724545656, 4369.847055353063, 4417.138657961698, 4421.911561768763, 4160.084781348099, 4257.254980378421, 4315.762633055181, 4319.352097185416, 4398.692091553577, 4218.388333691628, 4248.192843359751, 4258.5528519505315, 4263.147370525907, 4275.615194632467, 4244.172386384656, 4249.532551419341, 4262.339337402707, 4263.381809637616, 4265.104328091104, 4557.270836666151, 4607.746573938432, 4612.861614151548, 4614.953850461519, 4662.580367766917, 5013.548780609726, 5032.119379108642, 5032.597392208614, 5033.697978121288, 5081.568066714333, 4904.5831104356175, 5049.873753156164, 5056.595472362203, 5069.391672999227, 5119.744012799345, 4636.652251081183, 4647.442306923191, 4684.648651351163, 4688.156131896291, 4696.319033740157, 5100.974495127501, 5112.590992720573, 5114.3095682083185, 5140.948590514047, 5174.508421699932, 4823.324734537167, 4885.6335774817035, 4921.483244259372, 4927.482614325444, 4987.9525299687475, 5033.924491132636, 5050.873728156826, 5051.217061355423, 5054.16606259963, 5072.797088116507, 5012.423571289275, 5016.698998060128, 5017.82437614689, 5018.774155163026, 5043.142665746832, 4874.46380898101, 4972.925406118911, 4974.950250497449, 4975.477574854661, 5003.24951257307, 3844.2695887781233, 3865.284922289329, 3917.0990672144994, 3943.8028098594955, 3958.267720471722, 3495.0, 3495.038864312334, 3495.1611613213154, 3516.4197907345515, 3528.1885166411357, 4196.601322874322, 4313.9137217255475, 4317.093410383792, 4339.674524410681, 4357.128574285156, 4973.179425394842, 5020.949790502122, 5038.823641172615, 5075.111855425286, 5084.669496482717, 4298.20483210607, 4315.09383029561, 4315.633171180485, 4347.217500849814, 4351.6518678505645, 4438.0, 4564.132814765184, 4572.542745725467, 4581.862544123682, 4587.564181402761, 4826.372571565674, 4840.878978025507, 4850.296706977398, 4860.586850117638, 4905.55849973497, 5079.644424890223, 5082.4409314976065, 5085.0338435697095, 5085.364329458817, 5119.564836988898, 4704.247320428715, 4827.565519103297, 4838.927416088691, 4902.093112774148, 4906.484819094087, 4968.950310496994, 4984.601231901512, 4986.526280003394, 4991.201407774739, 5019.0463811875625, 5028.1200789860895, 5063.746812659426, 5064.898702026013, 5071.771770270273, 5092.210707340369, 4765.142274390643, 4806.327114204084, 4860.198067318995, 4893.461719210813, 4954.455009948975, 4818.277258411266, 4826.131296366688, 4845.370101886732, 4851.51484851512, 4894.779734911866, 4808.447028591757, 4820.0, 4828.927566086441, 4829.0, 4864.0, 4686.27362758773, 4823.204171311834, 4905.3623029006, 4911.582515486224, 4989.55094041538, 4675.6259499239295, 4765.499622539722, 4772.427308722976, 4790.209615413418, 4808.230683090689], "value": 4590.816430303593, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.4571157400468, 609.44236024038, 610.3438803286468, 614.0482252508612, 629.6348118091507, 26506.734932650666, 34807.65192348076, 35399.82300088499, 35409.822950885275, 35411.645883541154, 36289.09277268063, 36632.81683591585, 36979.0, 37045.07387315318, 37067.0, 7416.221296763816, 7622.123455802571, 7631.54210747357, 7636.969009183773, 7858.332041776427, 7424.294692004251, 9340.57967391469, 9604.711858644252, 9613.951930240339, 9619.759506012371, 9607.0, 9736.26977976651, 9737.805243895118, 9744.269179811507, 9745.269104817131, 7248.0939882514685, 9463.621455141785, 9595.568199431007, 9667.90332096677, 9729.513524323791, 9260.073992600754, 9400.106989835955, 9401.952990235006, 9404.200642945358, 9406.529673516297, 33202.50196247058, 33994.15014624629, 34021.659783402094, 34065.0, 34068.659313406795, 2843.2241803564466, 2928.677845437, 2975.181824998121, 2985.358147998191, 2986.5818785370066, 26118.34704132393, 27763.444731105265, 27837.721622783716, 28051.57922631162, 28205.0, 3140.1835522764018, 3177.491601343797, 3179.443597370474, 3227.2738633807207, 3266.4283750343593, 193892.0, 194162.02918985314, 194359.0, 194466.02766986075, 194704.0, 50350.49649503458, 50716.0, 50733.0, 50822.745886270335, 50854.23718644223, 50191.74904125456, 51344.74327628338, 53173.93652126936, 53586.73206633942, 53692.463075368745, 13107.868921310856, 13265.336733163496, 13290.0, 13295.135816171918, 13298.800517992238, 9330.860037099448, 10043.748906277255, 10348.793024139475, 10375.481225938673, 10418.166546676248, 16972.15139243033, 17044.0, 17091.230894609773, 17133.31466741341, 17160.742588861176, 6472.870542589122, 6547.312532184147, 6739.123913891162, 6768.9508126239525, 6858.931410685929, 835.302522393808, 943.2124176312856, 965.6620182935916, 976.3653625143571, 1002.5789168549227, 27415.314617134733, 27453.0, 27913.0, 28167.43665126727, 28219.57670634942, 1020.4642562654666, 1025.8974102589682, 1028.3675539543126, 1035.0425856083093, 1052.4106500359824, 14344.713105737826, 14810.925945370203, 14895.851041489663, 14917.552473425814, 14956.850431495546, 205220.0, 210068.0, 210494.0, 210625.0, 269613.0, 43462.34806477906, 44419.555804441545, 44592.77703611526, 44604.330935036, 44636.0, 1107.4905543450104, 1137.533611219396, 1144.7596004839077, 1204.0848954794244, 1206.4209179593845, 26131.0, 28333.57499637466, 28785.136445906657, 28828.135155945354, 28882.566761499016, 40202.195956080126, 40815.795921021396, 41055.0, 41060.58939410687, 41146.38280425856, 226041.0, 227927.0, 228176.0, 228308.0, 228720.0, 20803.479913002295, 23303.0, 24002.639960400957, 24005.639915400934, 24857.1300004499, 36224.818875905454, 36299.81850090733, 36391.45412818863, 36996.630033699315, 37318.25363492661, 31511.527327089654, 31667.683323167395, 31910.361792764477, 32163.35673286568, 32453.837730811196, 31588.526172106976, 31671.366572668878, 32198.517022245152, 32478.512822307213, 32608.51087233646, 33222.16944576405, 33829.83085084559, 34036.82981585076, 34102.65897340995, 34132.65867341394, 29026.27434314159, 30193.245168870955, 30859.84570077135, 30990.845045774626, 31042.534361984137, 24080.0, 24222.51554968926, 24286.63570046486, 24651.0, 24707.382315442257], "value": 16578.06839394898, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.1759426031163, 392.48388369294395, 394.24560704863364, 396.3302019586899, 396.6985091330588, 15208.315625796839, 15468.767968480453, 15749.527514174579, 15755.212239388013, 15766.842331576681, 15367.846321536781, 15898.0, 16136.435224767136, 16188.27152778125, 16249.675006499863, 4736.076465089301, 4874.536918992708, 4877.487863774288, 4888.071266459379, 4888.73111978841, 4951.727654978975, 5046.924296135561, 5074.0, 5079.187330027196, 5084.618653600976, 4918.827841025565, 5024.271480635306, 5032.169692000815, 5045.470225626312, 5061.1143049966295, 5013.874653133665, 5053.545180933734, 5058.772355244023, 5060.2409638554145, 5353.839384818461, 5157.845264642029, 5185.870353241162, 5199.168133098686, 5202.817901373433, 5208.348956380452, 12117.515299388015, 13757.518486852912, 19625.705614415794, 19639.607207855763, 19643.508912277164, 1719.4755599542134, 1889.8677092603523, 1932.5361913140885, 1940.7477027986413, 2465.9753402465926, 8779.385443018991, 8780.956095219482, 9033.638654453815, 9204.539773011322, 9445.433274003582, 1696.6012986948058, 1769.4160926894094, 1854.2768320355071, 1856.3873921605973, 1904.1621686457913, 50032.74983625095, 55636.0, 57585.712071439375, 59328.0, 61056.694716527025, 9649.93850676425, 9662.806743865083, 10029.949850250849, 10165.52599873029, 10258.640947566799, 13739.862601373858, 13979.860201397856, 14027.0, 14066.0, 14097.647558810906, 6934.965325173443, 6963.79108626742, 7207.71169153228, 7275.454340924452, 7365.742199023009, 6729.69716362755, 6764.695588698521, 6770.187577490634, 6807.18313802337, 6946.51374403797, 4328.134373125387, 4374.4094547236355, 4404.361367601744, 4409.691321607456, 4433.401490798701, 1801.5316017835457, 1877.11775465531, 1881.560606136307, 1886.1983656945742, 1899.6485650154766, 814.2997022560593, 894.9776255593662, 918.3047754839567, 924.4499522783933, 942.2273735536932, 15573.844261557466, 15840.920795395949, 15935.760963585555, 16298.348066077462, 16578.83421165797, 796.9481983671043, 812.5206128384282, 817.5094943034132, 829.5561874397168, 867.4318321499428, 9086.591103400362, 9188.770280743034, 9350.205232555309, 9364.484953327632, 9576.76058098553, 366363.0, 370784.0, 372803.0, 373913.0, 379826.0, 61418.38581614216, 63197.368026320066, 64519.35480645134, 66653.0, 67217.66391168111, 891.5943245823264, 892.7857314244665, 893.1247377569888, 898.0301274623391, 907.3331101640289, 14091.788623170865, 14153.363098660378, 14340.641483962985, 14521.564353069425, 14811.555653330417, 30763.53854692226, 31081.37837243288, 31116.377672446877, 31198.68801311958, 31519.527207091454, 42046.36930446107, 42503.0, 43319.13361732685, 43414.0, 43591.782041089595, 7539.886901696588, 7554.773356799305, 7569.886451703119, 7603.20166382544, 7658.885116723142, 10057.899421005697, 11068.5572577096, 11224.326540407601, 11281.435928203393, 11417.200795944203, 9611.471369074769, 9659.71020869375, 9700.126988571063, 9714.465704386326, 9845.064718851698, 9799.706008819747, 9914.454704991007, 9920.801583968425, 9926.851097233402, 10010.799784004425, 9796.21630269591, 9925.305228634215, 9936.801263974536, 9996.700098997042, 10053.296269261082, 7475.327220550176, 7530.0, 7620.69517219305, 7661.463697541119, 7710.074791025113, 8166.346692264486, 9158.221551168226, 9831.508424578886, 9886.209103271578, 10081.899181008095], "value": 7826.707828578316, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1221.6884694402927, 1412.5479846449136, 1444.3716983112345, 1531.9540413787583, 1746.0658547676996, 6657.600543967359, 7295.124585049794, 7425.665845036973, 7469.178390377054, 7493.138289096755, 7232.710691572331, 7393.556386616807, 7400.444966627498, 7403.629818509066, 7404.2225566315565, 2250.8199344052477, 2279.418748219202, 2283.303592404316, 2283.851549649276, 2288.0733303012225, 2228.4317499037725, 2259.6949411829355, 2260.0959616153505, 2265.0713207584895, 2281.863088214712, 2228.832837537191, 2242.1255710272926, 2249.1116009176367, 2267.4784799496124, 2273.056681477185, 2197.9450513737124, 2222.555488902226, 2222.84440089193, 2230.197129033547, 2231.4867580456503, 2162.48100455891, 2169.40341406113, 2170.6092903277404, 2171.5982543229397, 2176.1404245323165, 7356.926430735678, 7425.220351863085, 7470.850582988364, 7496.662650180755, 7506.474546781727, 4526.23054080807, 4671.556202160789, 4674.69614475058, 4679.344891715163, 4689.366935463737, 2982.776291778125, 2987.2382542451537, 3004.2789730464533, 3009.277773334406, 3067.4018566379564, 900.8963969143567, 904.674317245791, 908.7728067983004, 910.2854259406334, 913.3560839608127, 9559.235261179088, 9622.037796220391, 9896.95051524745, 9907.801843963152, 9910.653127140587, 4146.937795933063, 4194.937075943863, 4306.20335237982, 4307.267764480046, 4311.33174357975, 8026.678932842738, 8030.558319292378, 8032.959835200903, 8062.234087761653, 8085.312748416332, 4670.416197975253, 4689.179393606105, 4725.763711814464, 4735.95264047362, 4738.47876733559, 3681.4845921571, 4142.565030671796, 4182.163567286555, 4326.459192600925, 4327.783610819446, 3361.478970759536, 3397.320535892782, 3431.987563668724, 3470.149813295708, 3522.1018640246575, 1074.5164675895721, 1075.370908018802, 1083.3716444462193, 1084.9186311026704, 1089.5042755546208, 583.3959577581734, 683.2040672616446, 828.1552816127517, 859.5573279760928, 863.6847550644095, 5162.586993040548, 5423.972880135653, 5453.836384908459, 5510.228568000483, 5616.2698849150165, 862.6980556805194, 870.6430363550913, 898.3397203055749, 903.5437104262305, 927.0729270729271, 3478.32172726321, 3761.6238376162714, 3774.3772277573894, 3806.3719486284454, 3819.4461803038957, 9019.368644194974, 9221.400608960395, 9403.34176607631, 9426.481543515036, 9434.103760142776, 9107.908920910839, 9275.489848058287, 9303.674371396968, 9321.347505674537, 9323.813523729488, 7029.89455158173, 7249.311315425026, 7296.12446506412, 7307.26927307265, 7347.412207023425, 5217.399999000164, 5260.658057226268, 5281.55106815925, 5374.4088150304215, 5375.784968601212, 8605.483670979762, 8719.433236839584, 8750.82498350042, 8751.737447876574, 8829.911700882909, 8716.956415218137, 9055.864162037706, 9174.633014679339, 9208.815823683355, 9296.907030929875, 6405.231372235362, 6513.348665133449, 6533.346665333429, 6538.1500404947055, 6542.34576542342, 7267.164276108315, 7339.302766237199, 7364.742234021784, 7411.777646670608, 7418.072740907387, 6388.265349484683, 6544.345565443417, 6574.737010519526, 6595.1096601958125, 6678.3989440950545, 6734.461243100638, 6782.525223234326, 6818.352256535622, 6826.385625293748, 6855.862882742417, 6182.258129024546, 6297.937020629918, 6392.808215753535, 6393.712282947372, 6451.032345148077, 4527.094581083862, 4541.72749635023, 4590.0590378971565, 4661.277501987197, 4743.928841067456, 4539.409876716006, 4575.771211439348, 4601.240795268744, 4659.953400466087, 4711.458182309078], "value": 4090.756984935555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.3238884371524, 307.8368464713701, 308.87644942023195, 314.84100529232734, 315.11767052253686, 4497.2354699701045, 4680.180968330541, 4717.150912835688, 4751.311059896313, 4791.808327666889, 4523.45718513778, 4746.501617330183, 4750.691205071668, 4764.90470190596, 4784.66507344486, 3769.0954170998966, 3789.5263092113487, 3791.2986097571898, 3803.410471376927, 3829.5404551453726, 3536.9292614147703, 3585.8027808470524, 3771.0949372150762, 3780.3384407728677, 3787.9810600946957, 3715.8885233442907, 3726.919193433901, 3729.4219395993664, 3750.474933509311, 3751.4747935288947, 3707.6663100320966, 3716.4239542870628, 3722.3299806034765, 3726.5155529781227, 3753.9676588937987, 3270.4440245158144, 3315.3037862049, 3324.5678061851804, 3331.3170799985946, 3335.5497007903864, 4330.523642399334, 4562.88592785183, 4613.83851565197, 4625.283081122431, 4638.605718513931, 4308.3537469379535, 4310.676699247538, 4322.438083049184, 4328.264195086843, 4339.5443478434945, 5004.674696144775, 5006.499350064964, 5011.223260394645, 5025.447200807908, 5039.72281524516, 3592.586852511942, 3640.6177351377987, 3701.444783282502, 3703.092742278159, 3710.443433484972, 5097.821576244851, 5153.149730294497, 5195.844124676266, 5200.6879587224885, 5211.661242019294, 3754.8310326035394, 3761.5486141663177, 3770.377887648562, 3777.9244415112094, 3781.5084039074745, 3759.8793001808435, 3816.542014958223, 3817.751846129993, 3836.3094642963974, 3842.1547259602844, 4124.649404800565, 4274.358846173037, 4274.572542745763, 4275.0, 4294.570542945743, 4911.238757992517, 4926.802927882916, 4939.357883475125, 4949.7873021109335, 4987.900241995212, 1296.2999980010877, 1320.2078752748275, 1379.200063962899, 1388.999920057557, 1398.8461269260374, 949.8052899155656, 962.5957098018708, 968.5447839515416, 968.7529679931572, 976.3653625143713, 4580.862574122782, 4585.472670642852, 4592.173408786383, 4604.861854144381, 4608.654350923627, 5383.730813459311, 5385.838424847261, 5391.867707781332, 5400.567954563704, 5412.188171774265, 4483.21543729846, 4579.931301030487, 4588.128255631419, 4593.954060459353, 4595.448546174413, 2852.0873320537644, 2890.248535380816, 2898.174020404175, 2899.2027192522223, 2905.8111222770876, 5110.540051395318, 5170.1469257572835, 5170.71561064145, 5171.97414012935, 5185.662931909414, 5409.945900541023, 5511.118221084607, 5531.3915469298345, 5544.528715059265, 5554.6944918029085, 5135.050015747024, 5143.5113664201845, 5145.922811157836, 5149.510796474329, 5174.120399532088, 5397.406285308692, 5406.486383793534, 5406.864828379322, 5416.322959630046, 5423.728813559385, 5105.2342148678, 5271.525562699376, 5291.285676433632, 5300.893982120413, 5303.071962406486, 5101.668391554537, 5105.897882042413, 5128.897422051613, 5130.948690513047, 5135.229715542699, 3906.2968665640456, 3924.9215015700097, 3929.565708516428, 3937.27160475313, 3942.4086387042175, 4904.5340692634145, 5247.55395791362, 5379.973100134474, 5399.109146990702, 5402.108652072364, 4851.805927762991, 4934.827281045146, 4963.429205641398, 4964.8758781030765, 4998.376177271449, 4900.5099490052135, 4945.109880221451, 4954.702717836942, 4974.353334066548, 4982.2775697524385, 4793.0, 4868.537488938545, 4896.36347274852, 4906.92639610399, 4926.482719314564, 4961.875953101057, 4984.975075124601, 4989.25161225819, 4993.475685053162, 5015.548600625962, 4855.975720121377, 4871.123197824426, 4876.634252431011, 4882.975585122052, 4886.804527818847], "value": 3864.899492406898, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.3509771702269, 653.7450394346206, 660.8149718078938, 682.0894106367998, 701.0815831261046, 12138.635840924764, 12520.186187897792, 12546.498140074398, 13038.674033149153, 13514.054016218868, 12660.240385576872, 12755.04337174711, 12770.16993895396, 12790.360481975911, 12804.871951280484, 626.3392121312014, 792.7978365516785, 810.7648781853255, 814.8899898513714, 814.914433984432, 826.7313123234943, 832.0556168748484, 832.1096426823301, 832.3590835057033, 832.81261716114, 858.4076986879064, 868.8479516084692, 868.9826203475926, 870.1602953150209, 871.1593312453481, 655.573876979962, 827.5655280977475, 859.2352806002663, 865.519636601689, 866.8873046503945, 625.7497001199556, 627.1345543150469, 627.3663599764226, 627.5513008199114, 627.7614506487505, 11992.400379981053, 12081.87918120825, 12081.93959030208, 12097.274163550215, 12135.029197664255, 10924.508397122148, 11246.831297530543, 11466.426678666034, 11523.790002049831, 11627.476763545661, 9694.687746561898, 9891.060349266809, 9959.75100622483, 9981.850272245922, 10269.486525673687, 3266.70599646033, 3293.2425542125447, 3302.058913209724, 3342.097633638904, 3399.031276086328, 43511.78244108791, 43937.0, 44381.0, 46755.29867051997, 47206.291905621445, 9315.72052838416, 9364.391314564531, 9396.530173491297, 9522.0954009369, 9567.186789122863, 16205.756913646304, 16228.432004879773, 16236.59408514773, 16246.350145994264, 16255.349786008428, 6326.873462530723, 6364.745410183634, 6407.583507072025, 6408.935910640927, 6496.545241833026, 3552.786832789989, 3673.797941113211, 3674.5590529136675, 3679.77921324716, 3822.6559609635265, 2763.3367991681853, 2832.8017038807084, 3046.1166261783833, 3135.106494649014, 3158.7630927680516, 553.9639923404966, 563.374654133911, 564.6442741073098, 565.9886802263932, 566.9603127781098, 563.5435297409111, 573.1374281706006, 579.1573260905373, 581.4505292498549, 608.1111293279453, 7593.696252149963, 8254.752357429286, 8532.829343413097, 8739.169778870997, 8840.292776577859, 580.3239226301312, 581.1254062635707, 585.280105470274, 593.1676245925653, 600.0459269761101, 3717.8141092945243, 3795.2409518096492, 3832.5017747693178, 3839.251345987506, 4028.939565906514, 46434.767826160656, 51280.48719512832, 51320.74339628278, 51397.48602513927, 61051.0, 44077.33883991743, 44306.33540496895, 48076.27885581719, 48674.51325486771, 50254.24618630723, 44337.556624433986, 45097.32354014692, 45626.0, 45668.54331456643, 47051.76474117676, 8263.95868020656, 8315.459495132796, 8327.875081873655, 8349.332053435832, 8473.804100227937, 29125.417491649623, 29134.0, 29758.55362169526, 30802.229944251572, 30895.382092358475, 34090.14774630654, 36838.0, 38796.2240755189, 39060.414093789186, 40325.39511907382, 9351.766205844908, 10065.798684026426, 10193.541290641791, 10303.896961030294, 10699.411532365795, 10863.456827158452, 11522.366269855238, 11796.29222246668, 11830.349330786888, 11890.643280701594, 11063.557457701601, 11113.944430277797, 11242.55029798799, 11258.268212566158, 11393.202475826612, 9859.950700246452, 9996.650117246152, 10048.598056077675, 10194.796104078025, 10430.0, 10286.177105831664, 10742.355458672504, 10929.507174048658, 11125.944370278097, 11221.382823944761, 9371.437713737198, 9471.905280947103, 9671.516424178622, 9701.417914925127, 10069.647562335284, 8910.732678019669, 9683.564239609093, 9767.511624418608, 9775.608975641178, 9877.308588398742], "value": 5909.486647562846, "unit": "score"}], "name": "dromaeo_css", "value": 6179.075963128099, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 107.0, 113.0, 114.0, 113.0, 101.0, 113.0, 113.0, 115.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 133.0, 155.0, 200.0, 133.0, 155.0, 162.0, 139.0, 192.0, 136.0], "value": 157.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 159.0, 162.0, 163.0, 162.0, 161.0, 162.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 127.0, 109.0, 78.0, 74.0, 73.0, 114.0, 102.0, 74.0], "value": 90.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 155.0, 93.0, 95.0, 94.0, 150.0, 94.0, 93.0, 143.0], "value": 110.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 65.0, 63.0, 65.0, 80.0, 63.0, 62.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 87.0, 77.0, 77.0, 80.0, 80.0, 86.0, 80.0, 79.0, 80.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 134.0, 137.0, 133.0, 143.0, 137.0, 130.0, 135.0, 168.0, 140.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [220.0, 221.0, 216.0, 214.0, 220.0, 220.0, 217.0, 217.0, 217.0, 217.0], "value": 217.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 77.0, 76.0, 74.0, 72.0, 72.0, 72.0, 74.0], "value": 74.1, "unit": "score"}], "name": "kraken", "value": 1630.6, "alertThreshold": 2.0}]} 05:12:20 INFO - Return code: 0 05:12:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:12:20 ERROR - # TBPL SUCCESS # 05:12:20 INFO - Running post-action listener: _resource_record_post_action 05:12:20 INFO - Running post-run listener: _resource_record_post_run 05:12:21 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 529661952; Read time: 0; Write time: 667672 05:12:21 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 201183232; Read time: 0; Write time: 347488 05:12:21 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 295280640; Read time: 0; Write time: 311412 05:12:21 INFO - Running post-run listener: _upload_blobber_files 05:12:21 INFO - Blob upload gear active. 05:12:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:12:21 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 05:12:21 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'] 05:12:21 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 05:12:22 INFO - (blobuploader) - INFO - Open directory for files ... 05:12:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:12:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:12:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:22 INFO - (blobuploader) - INFO - Done attempting. 05:12:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:12:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:12:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:23 INFO - (blobuploader) - INFO - Done attempting. 05:12:23 INFO - (blobuploader) - INFO - Iteration through files over. 05:12:23 INFO - Return code: 0 05:12:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:12:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:12:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37e4e0b41d13dd6cc4cd78f631281e707dbdbb2e7a4c2b2c25dad4247cefd3837b3a664bc2e9beb80bc6739957f5c8b7d018b6bc911d5a83345f08472cec5fb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c4b1763ab66fb25c816cbee5b91889202c395e657927c643b45f05e9af2000973f8b5081c86af5719cdbd994d56766e1e36633837c37ebfe2361aec780f3bd0d"} 05:12:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:12:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:12:23 INFO - Contents: 05:12:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37e4e0b41d13dd6cc4cd78f631281e707dbdbb2e7a4c2b2c25dad4247cefd3837b3a664bc2e9beb80bc6739957f5c8b7d018b6bc911d5a83345f08472cec5fb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c4b1763ab66fb25c816cbee5b91889202c395e657927c643b45f05e9af2000973f8b5081c86af5719cdbd994d56766e1e36633837c37ebfe2361aec780f3bd0d"} 05:12:23 INFO - Running post-run listener: copy_logs_to_upload_dir 05:12:23 INFO - Copying logs to upload dir... 05:12:23 INFO - mkdir: /builds/slave/test/build/upload/logs 05:12:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.083277 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-28 05:12:22.830441) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:22.838111) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350 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/37e4e0b41d13dd6cc4cd78f631281e707dbdbb2e7a4c2b2c25dad4247cefd3837b3a664bc2e9beb80bc6739957f5c8b7d018b6bc911d5a83345f08472cec5fb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c4b1763ab66fb25c816cbee5b91889202c395e657927c643b45f05e9af2000973f8b5081c86af5719cdbd994d56766e1e36633837c37ebfe2361aec780f3bd0d"} build_url:https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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/37e4e0b41d13dd6cc4cd78f631281e707dbdbb2e7a4c2b2c25dad4247cefd3837b3a664bc2e9beb80bc6739957f5c8b7d018b6bc911d5a83345f08472cec5fb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c4b1763ab66fb25c816cbee5b91889202c395e657927c643b45f05e9af2000973f8b5081c86af5719cdbd994d56766e1e36633837c37ebfe2361aec780f3bd0d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:22.865146) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:22.865463) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461843521.769647-1814834350 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:22.948356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 05:12:22.948660) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 05:12:22.951967) ========= ========= Total master_lag: 0.20 =========