builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1461128130.33 results: success (0) buildid: 20160419211331 builduid: 3b917d3ba8a04cb5a3589a514138e6b8 revision: bf3a35b355f0b48ac1020c47198053af9944a493 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 21:55:30.330336) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 21:55:30.330851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 21:55:30.331158) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 21:55:30.348666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 21:55:30.349008) ========= 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=0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 21:55: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-04-19 21:55:31 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111918 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 21:55:30.474398) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 21:55:30.474730) ========= 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=0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018859 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 21:55:30.524483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 21:55:30.524846) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bf3a35b355f0b48ac1020c47198053af9944a493 --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 bf3a35b355f0b48ac1020c47198053af9944a493 --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=0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 21:55:31,145 truncating revision to first 12 chars 2016-04-19 21:55:31,145 Setting DEBUG logging. 2016-04-19 21:55:31,145 attempt 1/10 2016-04-19 21:55:31,145 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bf3a35b355f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 21:55:31,475 unpacking tar archive at: fx-team-bf3a35b355f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.576844 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 21:55:31.115357) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 21:55:31.115671) ========= script_repo_revision: bf3a35b355f0b48ac1020c47198053af9944a493 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 21:55:31.116113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 21:55:31.116393) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 21:55:31.130677) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 32 mins, 3 secs) (at 2016-04-19 21:55:31.131112) ========= /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=0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:55:31 INFO - MultiFileLogger online at 20160419 21:55:31 in /builds/slave/test 21:55: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 21:55:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:55:31 INFO - {'append_to_log': False, 21:55:31 INFO - 'base_work_dir': '/builds/slave/test', 21:55:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:55:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:55:31 INFO - 'branch': 'Fx-Team-Non-PGO', 21:55:31 INFO - 'buildbot_json_path': 'buildprops.json', 21:55:31 INFO - 'config_files': ('talos/linux_config.py',), 21:55:31 INFO - 'default_actions': ('clobber', 21:55:31 INFO - 'read-buildbot-config', 21:55:31 INFO - 'download-and-extract', 21:55:31 INFO - 'populate-webroot', 21:55:31 INFO - 'create-virtualenv', 21:55:31 INFO - 'install', 21:55:31 INFO - 'run-tests'), 21:55:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:55:31 INFO - 'download_minidump_stackwalk': True, 21:55:31 INFO - 'download_symbols': 'ondemand', 21:55:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:55:31 INFO - 'tooltool.py': '/tools/tooltool.py', 21:55:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:55:31 INFO - '/tools/misc-python/virtualenv.py')}, 21:55:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:55:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:55:31 INFO - 'installer_path': 'installer.exe', 21:55:31 INFO - 'log_level': 'info', 21:55:31 INFO - 'log_name': 'talos', 21:55:31 INFO - 'log_to_console': True, 21:55:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:55:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:55:31 INFO - 'opt_config_files': (), 21:55:31 INFO - 'pip_index': False, 21:55:31 INFO - 'sps_profile': False, 21:55:31 INFO - 'sps_profile_interval': 0, 21:55:31 INFO - 'suite': 'dromaeojs', 21:55:31 INFO - 'system_bits': '32', 21:55:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:55:31 INFO - 'title': 'talos-linux64-ix-017', 21:55:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:55:31 INFO - 'use_talos_json': True, 21:55:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:55:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:55:31 INFO - 'work_dir': 'build'} 21:55:31 INFO - ##### 21:55:31 INFO - ##### Running clobber step. 21:55:31 INFO - ##### 21:55:31 INFO - Running pre-action listener: _resource_record_pre_action 21:55:31 INFO - Running main action method: clobber 21:55:31 INFO - rmtree: /builds/slave/test/build 21:55:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:55:32 INFO - Running post-action listener: _resource_record_post_action 21:55:32 INFO - ##### 21:55:32 INFO - ##### Running read-buildbot-config step. 21:55:32 INFO - ##### 21:55:32 INFO - Running pre-action listener: _resource_record_pre_action 21:55:32 INFO - Running main action method: read_buildbot_config 21:55:32 INFO - Using buildbot properties: 21:55:32 INFO - { 21:55:32 INFO - "project": "", 21:55:32 INFO - "product": "firefox", 21:55:32 INFO - "script_repo_revision": "production", 21:55:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:55:32 INFO - "repository": "", 21:55:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:55:32 INFO - "buildid": "20160419211331", 21:55:32 INFO - "pgo_build": "False", 21:55:32 INFO - "basedir": "/builds/slave/test", 21:55:32 INFO - "buildnumber": 1677, 21:55:32 INFO - "slavename": "talos-linux64-ix-017", 21:55:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:55:32 INFO - "platform": "ubuntu64_hw", 21:55:32 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:55:32 INFO - "branch": "fx-team", 21:55:32 INFO - "repo_path": "integration/fx-team", 21:55:32 INFO - "revision": "bf3a35b355f0b48ac1020c47198053af9944a493", 21:55:32 INFO - "stage_platform": "linux64", 21:55:32 INFO - "builduid": "3b917d3ba8a04cb5a3589a514138e6b8", 21:55:32 INFO - "slavebuilddir": "test" 21:55:32 INFO - } 21:55:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 21:55:32 INFO - Running post-action listener: _resource_record_post_action 21:55:32 INFO - ##### 21:55:32 INFO - ##### Running download-and-extract step. 21:55:32 INFO - ##### 21:55:32 INFO - Running pre-action listener: _resource_record_pre_action 21:55:32 INFO - Running main action method: download_and_extract 21:55:32 INFO - mkdir: /builds/slave/test/build/tests 21:55: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')]} 21:55:32 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:55:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:55:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:55:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:55:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:55:33 INFO - Downloaded 1361 bytes. 21:55:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:55:33 INFO - Using the following test package requirements: 21:55:33 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:55:33 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:55:33 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:55:33 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:33 INFO - u'jsshell-linux-x86_64.zip'], 21:55:33 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:55:33 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:55:33 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:55:33 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:55:33 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:55:33 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:55:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:55:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:33 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:55:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:55:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:55:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:55:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:55:35 INFO - Downloaded 22267191 bytes. 21:55:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:55:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:55:36 INFO - Return code: 0 21:55:36 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:55: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')]} 21:55:36 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:55:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:55:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:55:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:55:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:55:38 INFO - Downloaded 22267191 bytes. 21:55:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:55:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:55:40 INFO - Return code: 0 21:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:40 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:55:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:55:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:55:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:55:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:55:41 INFO - Downloaded 10845952 bytes. 21:55:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:55:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:55:41 INFO - Return code: 0 21:55:41 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')]} 21:55:41 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:55:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:55:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:55:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:55:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:55:47 INFO - Downloaded 54508588 bytes. 21:55:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:55:47 INFO - mkdir: /builds/slave/test/properties 21:55:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:55:47 INFO - Writing to file /builds/slave/test/properties/build_url 21:55:47 INFO - Contents: 21:55:47 INFO - build_url:https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:55:48 INFO - Running post-action listener: _resource_record_post_action 21:55:48 INFO - Running post-action listener: set_extra_try_arguments 21:55:48 INFO - ##### 21:55:48 INFO - ##### Running populate-webroot step. 21:55:48 INFO - ##### 21:55:48 INFO - Running pre-action listener: _resource_record_pre_action 21:55:48 INFO - Running main action method: populate_webroot 21:55:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:55:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:55:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:55:48 INFO - '--tppagecycles', 21:55:48 INFO - '7'], 21:55:48 INFO - 'tests': ['tsvgm']}}, 21:55:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:55:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:55:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:55:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:55:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:55:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:55:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:48 INFO - 'talos_options': ['--disable-e10s'], 21:55:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:55:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:55:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:48 INFO - 'talos_options': ['--disable-e10s'], 21:55:48 INFO - 'tests': ['damp', 'tps']}, 21:55:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:48 INFO - 'tests': ['damp', 'tps']}, 21:55:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:55:48 INFO - 'tests': ['dromaeo_dom']}, 21:55:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:55:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:55:48 INFO - 'tests': ['a11yr', 21:55:48 INFO - 'ts_paint', 21:55:48 INFO - 'tpaint', 21:55:48 INFO - 'sessionrestore', 21:55:48 INFO - 'sessionrestore_no_auto_restore', 21:55:48 INFO - 'tabpaint']}, 21:55:48 INFO - 'other-e10s': {'tests': ['a11yr', 21:55:48 INFO - 'ts_paint', 21:55:48 INFO - 'tpaint', 21:55:48 INFO - 'sessionrestore', 21:55:48 INFO - 'sessionrestore_no_auto_restore', 21:55:48 INFO - 'tabpaint']}, 21:55:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:55:48 INFO - 'ts_paint', 21:55:48 INFO - 'tpaint', 21:55:48 INFO - 'sessionrestore', 21:55:48 INFO - 'sessionrestore_no_auto_restore', 21:55:48 INFO - 'tabpaint']}, 21:55:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:55:48 INFO - 'ts_paint', 21:55:48 INFO - 'tpaint', 21:55:48 INFO - 'sessionrestore', 21:55:48 INFO - 'sessionrestore_no_auto_restore', 21:55:48 INFO - 'tabpaint']}, 21:55:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:55:48 INFO - 'tests': ['a11yr', 21:55:48 INFO - 'ts_paint', 21:55:48 INFO - 'tpaint', 21:55:48 INFO - 'sessionrestore', 21:55:48 INFO - 'sessionrestore_no_auto_restore', 21:55:48 INFO - 'tabpaint']}, 21:55:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:55:48 INFO - 'tests': ['a11yr', 21:55:48 INFO - 'ts_paint', 21:55:48 INFO - 'tpaint', 21:55:48 INFO - 'sessionrestore', 21:55:48 INFO - 'sessionrestore_no_auto_restore', 21:55:48 INFO - 'tabpaint']}, 21:55:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:55:48 INFO - 'tests': ['tsvgx', 21:55:48 INFO - 'tsvgr_opacity', 21:55:48 INFO - 'tart', 21:55:48 INFO - 'tscrollx', 21:55:48 INFO - 'cart']}, 21:55:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:55:48 INFO - 'tsvgr_opacity', 21:55:48 INFO - 'tart', 21:55:48 INFO - 'tscrollx', 21:55:48 INFO - 'cart']}, 21:55:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:48 INFO - 'talos_options': ['--disable-e10s'], 21:55:48 INFO - 'tests': ['tp5o']}, 21:55:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:48 INFO - 'tests': ['tp5o']}, 21:55:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:48 INFO - 'talos_options': ['--disable-e10s', 21:55:48 INFO - '--xperf_path', 21:55:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:55:48 INFO - 'tests': ['tp5n']}, 21:55:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:48 INFO - 'talos_options': ['--xperf_path', 21:55:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:55:48 INFO - 'tests': ['tp5n']}}, 21:55:48 INFO - 'talos.zip': {'path': '', 21:55:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:55:48 INFO - Running post-action listener: _resource_record_post_action 21:55:48 INFO - ##### 21:55:48 INFO - ##### Running create-virtualenv step. 21:55:48 INFO - ##### 21:55:48 INFO - Running pre-action listener: _resource_record_pre_action 21:55:48 INFO - Running main action method: create_virtualenv 21:55:48 INFO - Creating virtualenv /builds/slave/test/build/venv 21:55:48 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 21:55:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:55:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:55:48 INFO - Using real prefix '/usr' 21:55:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:55:49 INFO - Installing distribute.............................................................................................................................................................................................done. 21:55:51 INFO - Installing pip.................done. 21:55:51 INFO - Return code: 0 21:55:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:55:51 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')]} 21:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:51 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')]} 21:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:51 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 0x7f0a3297ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd98410>, '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 0xd99310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd997a0>, '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': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', '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 21:55:51 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 21:55:51 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 21:55:51 INFO - Using env: {'DISPLAY': ':0', 21:55:51 INFO - 'HOME': '/home/cltbld', 21:55:51 INFO - 'LANG': 'en_US.UTF-8', 21:55:51 INFO - 'LANGUAGE': 'en_US:en', 21:55:51 INFO - 'LOGNAME': 'cltbld', 21:55:51 INFO - 'MAIL': '/var/mail/cltbld', 21:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:51 INFO - 'MOZ_NO_REMOTE': '1', 21:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:51 INFO - 'NO_EM_RESTART': '1', 21:55:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:51 INFO - 'PWD': '/builds/slave/test', 21:55:51 INFO - 'SHELL': '/bin/bash', 21:55:51 INFO - 'SHLVL': '1', 21:55:51 INFO - 'TERM': 'linux', 21:55:51 INFO - 'TMOUT': '86400', 21:55:51 INFO - 'USER': 'cltbld', 21:55:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', 21:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:51 INFO - '_': '/tools/buildbot/bin/python'} 21:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:51 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 21:55:51 INFO - Cleaning up... 21:55:51 INFO - Return code: 0 21:55:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:55:51 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')]} 21:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:51 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')]} 21:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:51 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 0x7f0a3297ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd98410>, '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 0xd99310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd997a0>, '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': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', '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 21:55:51 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 21:55:51 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 21:55:51 INFO - Using env: {'DISPLAY': ':0', 21:55:51 INFO - 'HOME': '/home/cltbld', 21:55:51 INFO - 'LANG': 'en_US.UTF-8', 21:55:51 INFO - 'LANGUAGE': 'en_US:en', 21:55:51 INFO - 'LOGNAME': 'cltbld', 21:55:51 INFO - 'MAIL': '/var/mail/cltbld', 21:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:51 INFO - 'MOZ_NO_REMOTE': '1', 21:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:51 INFO - 'NO_EM_RESTART': '1', 21:55:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:51 INFO - 'PWD': '/builds/slave/test', 21:55:51 INFO - 'SHELL': '/bin/bash', 21:55:51 INFO - 'SHLVL': '1', 21:55:51 INFO - 'TERM': 'linux', 21:55:51 INFO - 'TMOUT': '86400', 21:55:51 INFO - 'USER': 'cltbld', 21:55:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', 21:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:51 INFO - '_': '/tools/buildbot/bin/python'} 21:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:51 INFO - Downloading/unpacking psutil>=0.7.1 21:55:51 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 21:55:51 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 21:55:51 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 21:55:51 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 21:55:51 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 21:55:51 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 21:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:55:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:55:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:55:53 INFO - Installing collected packages: psutil 21:55:53 INFO - Running setup.py install for psutil 21:55:53 INFO - building 'psutil._psutil_linux' extension 21:55:53 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 21:55:53 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 21:55:53 INFO - building 'psutil._psutil_posix' extension 21:55:53 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 21:55:54 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 21:55:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:55:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:55:54 INFO - Successfully installed psutil 21:55:54 INFO - Cleaning up... 21:55:54 INFO - Return code: 0 21:55:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0a3297ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd98410>, '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 0xd99310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd997a0>, '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': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', '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 21:55:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:55:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:55:54 INFO - Using env: {'DISPLAY': ':0', 21:55:54 INFO - 'HOME': '/home/cltbld', 21:55:54 INFO - 'LANG': 'en_US.UTF-8', 21:55:54 INFO - 'LANGUAGE': 'en_US:en', 21:55:54 INFO - 'LOGNAME': 'cltbld', 21:55:54 INFO - 'MAIL': '/var/mail/cltbld', 21:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:54 INFO - 'MOZ_NO_REMOTE': '1', 21:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:54 INFO - 'NO_EM_RESTART': '1', 21:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:54 INFO - 'PWD': '/builds/slave/test', 21:55:54 INFO - 'SHELL': '/bin/bash', 21:55:54 INFO - 'SHLVL': '1', 21:55:54 INFO - 'TERM': 'linux', 21:55:54 INFO - 'TMOUT': '86400', 21:55:54 INFO - 'USER': 'cltbld', 21:55:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', 21:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:54 INFO - '_': '/tools/buildbot/bin/python'} 21:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:55:56 INFO - Installing collected packages: mozsystemmonitor 21:55:56 INFO - Running setup.py install for mozsystemmonitor 21:55:56 INFO - Successfully installed mozsystemmonitor 21:55:56 INFO - Cleaning up... 21:55:56 INFO - Return code: 0 21:55:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0a3297ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd98410>, '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 0xd99310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd997a0>, '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': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', '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 21:55:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:55:56 INFO - Using env: {'DISPLAY': ':0', 21:55:56 INFO - 'HOME': '/home/cltbld', 21:55:56 INFO - 'LANG': 'en_US.UTF-8', 21:55:56 INFO - 'LANGUAGE': 'en_US:en', 21:55:56 INFO - 'LOGNAME': 'cltbld', 21:55:56 INFO - 'MAIL': '/var/mail/cltbld', 21:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:56 INFO - 'MOZ_NO_REMOTE': '1', 21:55:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:56 INFO - 'NO_EM_RESTART': '1', 21:55:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:56 INFO - 'PWD': '/builds/slave/test', 21:55:56 INFO - 'SHELL': '/bin/bash', 21:55:56 INFO - 'SHLVL': '1', 21:55:56 INFO - 'TERM': 'linux', 21:55:56 INFO - 'TMOUT': '86400', 21:55:56 INFO - 'USER': 'cltbld', 21:55:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', 21:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:56 INFO - '_': '/tools/buildbot/bin/python'} 21:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:56 INFO - Downloading/unpacking blobuploader==1.2.4 21:55:56 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 21:55:56 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 21:55:56 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 21:55:56 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 21:55:56 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 21:55:56 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 21:55:58 INFO - Downloading blobuploader-1.2.4.tar.gz 21:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:55:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:55:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:55:59 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 21:55:59 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 21:55:59 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 21:55:59 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 21:55:59 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 21:55:59 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 21:55:59 INFO - Downloading docopt-0.6.1.tar.gz 21:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:55:59 INFO - Installing collected packages: blobuploader, requests, docopt 21:55:59 INFO - Running setup.py install for blobuploader 21:55:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:55:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:55:59 INFO - Running setup.py install for requests 21:55:59 INFO - Running setup.py install for docopt 21:55:59 INFO - Successfully installed blobuploader requests docopt 21:55:59 INFO - Cleaning up... 21:55:59 INFO - Return code: 0 21:55:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:59 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 0x7f0a3297ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd98410>, '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 0xd99310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd997a0>, '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': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', '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 21:55:59 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 21:55:59 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 21:55:59 INFO - Using env: {'DISPLAY': ':0', 21:55:59 INFO - 'HOME': '/home/cltbld', 21:55:59 INFO - 'LANG': 'en_US.UTF-8', 21:55:59 INFO - 'LANGUAGE': 'en_US:en', 21:55:59 INFO - 'LOGNAME': 'cltbld', 21:55:59 INFO - 'MAIL': '/var/mail/cltbld', 21:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:59 INFO - 'MOZ_NO_REMOTE': '1', 21:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:59 INFO - 'NO_EM_RESTART': '1', 21:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:59 INFO - 'PWD': '/builds/slave/test', 21:55:59 INFO - 'SHELL': '/bin/bash', 21:55:59 INFO - 'SHLVL': '1', 21:55:59 INFO - 'TERM': 'linux', 21:55:59 INFO - 'TMOUT': '86400', 21:55:59 INFO - 'USER': 'cltbld', 21:55:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', 21:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:59 INFO - '_': '/tools/buildbot/bin/python'} 21:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:56:00 INFO - Running setup.py (path:/tmp/pip-C9Vg6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:56:00 INFO - Running setup.py (path:/tmp/pip-aCowIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:56:00 INFO - Running setup.py (path:/tmp/pip-cy6m88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:56:00 INFO - Running setup.py (path:/tmp/pip-0zFzhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:56:00 INFO - Running setup.py (path:/tmp/pip-_QAadE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:56:00 INFO - Running setup.py (path:/tmp/pip-VfnNPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:56:00 INFO - Running setup.py (path:/tmp/pip-x2o93u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:56:00 INFO - Running setup.py (path:/tmp/pip-rkFSCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:56:00 INFO - Running setup.py (path:/tmp/pip-JuncIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:56:00 INFO - Running setup.py (path:/tmp/pip-xrsi5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:56:00 INFO - Running setup.py (path:/tmp/pip-l0bowF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:56:00 INFO - Running setup.py (path:/tmp/pip-BqG_nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:56:00 INFO - Running setup.py (path:/tmp/pip-KgUHtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:56:01 INFO - Running setup.py (path:/tmp/pip-xvPvVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:01 INFO - Running setup.py (path:/tmp/pip-Zp6SjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:56:01 INFO - Running setup.py (path:/tmp/pip-tH1rnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:56:01 INFO - Running setup.py (path:/tmp/pip-365nOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:56:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:56:01 INFO - Running setup.py install for manifestparser 21:56:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:56:01 INFO - Running setup.py install for mozcrash 21:56:01 INFO - Running setup.py install for mozdebug 21:56:01 INFO - Running setup.py install for mozdevice 21:56:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:56:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:56:01 INFO - Running setup.py install for mozfile 21:56:01 INFO - Running setup.py install for mozhttpd 21:56:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:56:01 INFO - Running setup.py install for mozinfo 21:56:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:56:02 INFO - Running setup.py install for mozInstall 21:56:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:56:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:56:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:56:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:56:02 INFO - Running setup.py install for mozleak 21:56:02 INFO - Running setup.py install for mozlog 21:56:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:56:02 INFO - Running setup.py install for moznetwork 21:56:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:56:02 INFO - Running setup.py install for mozprocess 21:56:02 INFO - Running setup.py install for mozprofile 21:56:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:56:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:56:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:56:02 INFO - Running setup.py install for mozrunner 21:56:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:56:02 INFO - Running setup.py install for mozscreenshot 21:56:02 INFO - Running setup.py install for moztest 21:56:03 INFO - Running setup.py install for mozversion 21:56:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:56:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:56:03 INFO - Cleaning up... 21:56:03 INFO - Return code: 0 21:56:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56: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')]} 21:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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')]} 21:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:03 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 0x7f0a3297ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd98410>, '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 0xd99310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd997a0>, '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': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', '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 21:56:03 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 21:56:03 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 21:56:03 INFO - Using env: {'DISPLAY': ':0', 21:56:03 INFO - 'HOME': '/home/cltbld', 21:56:03 INFO - 'LANG': 'en_US.UTF-8', 21:56:03 INFO - 'LANGUAGE': 'en_US:en', 21:56:03 INFO - 'LOGNAME': 'cltbld', 21:56:03 INFO - 'MAIL': '/var/mail/cltbld', 21:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:03 INFO - 'MOZ_NO_REMOTE': '1', 21:56:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:03 INFO - 'NO_EM_RESTART': '1', 21:56:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:03 INFO - 'PWD': '/builds/slave/test', 21:56:03 INFO - 'SHELL': '/bin/bash', 21:56:03 INFO - 'SHLVL': '1', 21:56:03 INFO - 'TERM': 'linux', 21:56:03 INFO - 'TMOUT': '86400', 21:56:03 INFO - 'USER': 'cltbld', 21:56:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', 21:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:03 INFO - '_': '/tools/buildbot/bin/python'} 21:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:56:03 INFO - Running setup.py (path:/tmp/pip-wRPV60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:56:03 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)) 21:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:56:03 INFO - Running setup.py (path:/tmp/pip-I4ABDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:56:03 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)) 21:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:56:03 INFO - Running setup.py (path:/tmp/pip-PoBmFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:56:03 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)) 21:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:56:03 INFO - Running setup.py (path:/tmp/pip-bLiS6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:56:03 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)) 21:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:56:03 INFO - Running setup.py (path:/tmp/pip-5uDS6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:56:03 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)) 21:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:56:03 INFO - Running setup.py (path:/tmp/pip-vlwsuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:56:03 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)) 21:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:56:03 INFO - Running setup.py (path:/tmp/pip-GQC2t2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:56:03 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)) 21:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:56:03 INFO - Running setup.py (path:/tmp/pip-ubLAGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:56:03 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)) 21:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:56:03 INFO - Running setup.py (path:/tmp/pip-0k0b65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:56:04 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)) 21:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:56:04 INFO - Running setup.py (path:/tmp/pip-DzrmC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:56:04 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)) 21:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:56:04 INFO - Running setup.py (path:/tmp/pip-6_Xpec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:56:04 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)) 21:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:56:04 INFO - Running setup.py (path:/tmp/pip-96hxzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:56:04 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)) 21:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:56:04 INFO - Running setup.py (path:/tmp/pip-NHogAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:56:04 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)) 21:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:56:04 INFO - Running setup.py (path:/tmp/pip-a_c6TF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:56:04 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)) 21:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:04 INFO - Running setup.py (path:/tmp/pip-h4g9T_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:04 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)) 21:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:56:04 INFO - Running setup.py (path:/tmp/pip-GVutml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:56:04 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)) 21:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:56:04 INFO - Running setup.py (path:/tmp/pip-ylYFFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:56:04 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)) 21:56:04 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)) 21:56:04 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)) 21:56:04 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)) 21:56:04 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)) 21:56:04 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)) 21:56:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:56: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 21:56: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 21:56: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 21:56: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 21:56: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 21:56: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 21:56:06 INFO - Downloading blessings-1.6.tar.gz 21:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:56:06 INFO - Installing collected packages: blessings 21:56:06 INFO - Running setup.py install for blessings 21:56:06 INFO - Successfully installed blessings 21:56:06 INFO - Cleaning up... 21:56:06 INFO - Return code: 0 21:56:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:56:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:56:06 INFO - Reading from file tmpfile_stdout 21:56:06 INFO - Current package versions: 21:56:06 INFO - argparse == 1.2.1 21:56:06 INFO - blessings == 1.6 21:56:06 INFO - blobuploader == 1.2.4 21:56:06 INFO - docopt == 0.6.1 21:56:06 INFO - manifestparser == 1.1 21:56:06 INFO - mozInstall == 1.12 21:56:06 INFO - mozcrash == 0.17 21:56:06 INFO - mozdebug == 0.1 21:56:06 INFO - mozdevice == 0.48 21:56:06 INFO - mozfile == 1.2 21:56:06 INFO - mozhttpd == 0.7 21:56:06 INFO - mozinfo == 0.9 21:56:06 INFO - mozleak == 0.1 21:56:06 INFO - mozlog == 3.1 21:56:06 INFO - moznetwork == 0.27 21:56:06 INFO - mozprocess == 0.22 21:56:06 INFO - mozprofile == 0.28 21:56:06 INFO - mozrunner == 6.11 21:56:06 INFO - mozscreenshot == 0.1 21:56:06 INFO - mozsystemmonitor == 0.0 21:56:06 INFO - moztest == 0.7 21:56:06 INFO - mozversion == 1.4 21:56:06 INFO - psutil == 3.1.1 21:56:06 INFO - requests == 1.2.3 21:56:06 INFO - wsgiref == 0.1.2 21:56:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56:06 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')]} 21:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:06 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')]} 21:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:06 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 0x7f0a3297ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd98410>, '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 0xd99310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd997a0>, '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': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', '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 21:56:06 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 21:56:06 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 21:56:06 INFO - Using env: {'DISPLAY': ':0', 21:56:06 INFO - 'HOME': '/home/cltbld', 21:56:06 INFO - 'LANG': 'en_US.UTF-8', 21:56:06 INFO - 'LANGUAGE': 'en_US:en', 21:56:06 INFO - 'LOGNAME': 'cltbld', 21:56:06 INFO - 'MAIL': '/var/mail/cltbld', 21:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:06 INFO - 'MOZ_NO_REMOTE': '1', 21:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:06 INFO - 'NO_EM_RESTART': '1', 21:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:06 INFO - 'PWD': '/builds/slave/test', 21:56:06 INFO - 'SHELL': '/bin/bash', 21:56:06 INFO - 'SHLVL': '1', 21:56:06 INFO - 'TERM': 'linux', 21:56:06 INFO - 'TMOUT': '86400', 21:56:06 INFO - 'USER': 'cltbld', 21:56:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', 21:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:06 INFO - '_': '/tools/buildbot/bin/python'} 21:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:07 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)) 21:56:07 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)) 21:56:07 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)) 21:56:07 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)) 21:56:07 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)) 21:56:07 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)) 21:56:07 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)) 21:56:07 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)) 21:56:07 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)) 21:56:07 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)) 21:56:07 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)) 21:56:07 INFO - Cleaning up... 21:56:07 INFO - Return code: 0 21:56:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:56: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')]} 21:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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')]} 21:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0a3297ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd98410>, '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 0xd99310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd997a0>, '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': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', '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 21:56:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:56:07 INFO - Using env: {'DISPLAY': ':0', 21:56:07 INFO - 'HOME': '/home/cltbld', 21:56:07 INFO - 'LANG': 'en_US.UTF-8', 21:56:07 INFO - 'LANGUAGE': 'en_US:en', 21:56:07 INFO - 'LOGNAME': 'cltbld', 21:56:07 INFO - 'MAIL': '/var/mail/cltbld', 21:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:07 INFO - 'MOZ_NO_REMOTE': '1', 21:56:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:07 INFO - 'NO_EM_RESTART': '1', 21:56:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:07 INFO - 'PWD': '/builds/slave/test', 21:56:07 INFO - 'SHELL': '/bin/bash', 21:56:07 INFO - 'SHLVL': '1', 21:56:07 INFO - 'TERM': 'linux', 21:56:07 INFO - 'TMOUT': '86400', 21:56:07 INFO - 'USER': 'cltbld', 21:56:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', 21:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:07 INFO - '_': '/tools/buildbot/bin/python'} 21:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:07 INFO - Downloading/unpacking jsonschema 21:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:56:09 INFO - Downloading/unpacking functools32 (from jsonschema) 21:56:09 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 21:56:09 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 21:56:09 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 21:56:09 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 21:56:09 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 21:56:09 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 21:56:09 INFO - Downloading functools32-3.2.3-2.tar.gz 21:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:56:09 INFO - warning: no files found matching '*.txt' 21:56:09 INFO - no previously-included directories found matching 'build' 21:56:09 INFO - no previously-included directories found matching 'dist' 21:56:09 INFO - no previously-included directories found matching '.git*' 21:56:09 INFO - Installing collected packages: jsonschema, functools32 21:56:09 INFO - Running setup.py install for functools32 21:56:09 INFO - warning: no files found matching '*.txt' 21:56:09 INFO - no previously-included directories found matching 'build' 21:56:09 INFO - no previously-included directories found matching 'dist' 21:56:09 INFO - no previously-included directories found matching '.git*' 21:56:09 INFO - Successfully installed jsonschema functools32 21:56:09 INFO - Cleaning up... 21:56:09 INFO - Return code: 0 21:56:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:09 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 0x7f0a3297ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd98410>, '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 0xd99310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd997a0>, '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': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', '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 21:56:09 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 21:56:09 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 21:56:09 INFO - Using env: {'DISPLAY': ':0', 21:56:09 INFO - 'HOME': '/home/cltbld', 21:56:09 INFO - 'LANG': 'en_US.UTF-8', 21:56:09 INFO - 'LANGUAGE': 'en_US:en', 21:56:09 INFO - 'LOGNAME': 'cltbld', 21:56:09 INFO - 'MAIL': '/var/mail/cltbld', 21:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:09 INFO - 'MOZ_NO_REMOTE': '1', 21:56:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:09 INFO - 'NO_EM_RESTART': '1', 21:56:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:09 INFO - 'PWD': '/builds/slave/test', 21:56:09 INFO - 'SHELL': '/bin/bash', 21:56:09 INFO - 'SHLVL': '1', 21:56:09 INFO - 'TERM': 'linux', 21:56:09 INFO - 'TMOUT': '86400', 21:56:09 INFO - 'USER': 'cltbld', 21:56:09 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', 21:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:09 INFO - '_': '/tools/buildbot/bin/python'} 21:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:09 INFO - Downloading/unpacking flake8 21:56:09 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 21:56:09 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 21:56:09 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 21:56:09 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 21:56:09 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 21:56:09 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 21:56:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:56:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:56:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:56:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:56:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:56:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:56:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:56:12 INFO - no previously-included directories found matching 'docs/_build' 21:56:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:56:13 INFO - Running setup.py install for pep8 21:56:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:56:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:56:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:56:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:56:13 INFO - no previously-included directories found matching 'docs/_build' 21:56:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:56:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:56:13 INFO - Cleaning up... 21:56:13 INFO - Return code: 0 21:56:13 INFO - Running post-action listener: _resource_record_post_action 21:56:13 INFO - Running post-action listener: _start_resource_monitoring 21:56:13 INFO - Starting resource monitoring. 21:56:13 INFO - ##### 21:56:13 INFO - ##### Running install step. 21:56:13 INFO - ##### 21:56:13 INFO - Running pre-action listener: _resource_record_pre_action 21:56:13 INFO - Running main action method: install 21:56:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:56:13 INFO - Reading from file tmpfile_stdout 21:56:13 INFO - Detecting whether we're running mozinstall >=1.0... 21:56:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:56:13 INFO - Reading from file tmpfile_stdout 21:56:13 INFO - Output received: 21:56:13 INFO - Usage: mozinstall [options] installer 21:56:13 INFO - Options: 21:56:13 INFO - -h, --help show this help message and exit 21:56:13 INFO - -d DEST, --destination=DEST 21:56:13 INFO - Directory to install application into. [default: 21:56:13 INFO - "/builds/slave/test"] 21:56:13 INFO - --app=APP Application being installed. [default: firefox] 21:56:13 INFO - mkdir: /builds/slave/test/build/application 21:56:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:56:29 INFO - Reading from file tmpfile_stdout 21:56:29 INFO - Output received: 21:56:29 INFO - /builds/slave/test/build/application/firefox/firefox 21:56:29 INFO - Running post-action listener: _resource_record_post_action 21:56:29 INFO - ##### 21:56:29 INFO - ##### Running run-tests step. 21:56:29 INFO - ##### 21:56:29 INFO - Running pre-action listener: _resource_record_pre_action 21:56:29 INFO - Running main action method: run_tests 21:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:56:29 INFO - Python 2.7.3 21:56:29 INFO - Return code: 0 21:56:29 INFO - grabbing minidump binary from tooltool 21:56:29 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')]} 21:56:29 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 0xd98410>, '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 0xd99310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd997a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:56:29 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 21:56:29 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 21:56:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:56:29 INFO - Return code: 0 21:56:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:56:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:56:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:56:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:56:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:56:30 INFO - Return code: 0 21:56:30 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/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 21:56:30 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/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 21:56:30 INFO - Using env: {'DISPLAY': ':0', 21:56:30 INFO - 'HOME': '/home/cltbld', 21:56:30 INFO - 'LANG': 'en_US.UTF-8', 21:56:30 INFO - 'LANGUAGE': 'en_US:en', 21:56:30 INFO - 'LOGNAME': 'cltbld', 21:56:30 INFO - 'MAIL': '/var/mail/cltbld', 21:56:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:56:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:30 INFO - 'MOZ_NO_REMOTE': '1', 21:56:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:56:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:30 INFO - 'NO_EM_RESTART': '1', 21:56:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:30 INFO - 'PWD': '/builds/slave/test', 21:56:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:56:30 INFO - 'SHELL': '/bin/bash', 21:56:30 INFO - 'SHLVL': '1', 21:56:30 INFO - 'TERM': 'linux', 21:56:30 INFO - 'TMOUT': '86400', 21:56:30 INFO - 'USER': 'cltbld', 21:56:30 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480', 21:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:30 INFO - '_': '/tools/buildbot/bin/python'} 21:56:30 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/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 21:56:30 INFO - mozversion application_buildid: 20160419211331 21:56:30 INFO - mozversion application_changeset: bf3a35b355f0b48ac1020c47198053af9944a493 21:56:30 INFO - mozversion application_display_name: Nightly 21:56:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:56:30 INFO - mozversion application_name: Firefox 21:56:30 INFO - mozversion application_remotingname: firefox 21:56:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:56:30 INFO - mozversion application_vendor: Mozilla 21:56:30 INFO - mozversion application_version: 48.0a1 21:56:30 INFO - mozversion platform_buildid: 20160419211331 21:56:30 INFO - mozversion platform_changeset: bf3a35b355f0b48ac1020c47198053af9944a493 21:56:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:56:30 INFO - mozversion platform_version: 48.0a1 21:56:30 INFO - using testdate: 1461128190 21:56:30 INFO - actual date: 1461128190 21:56:30 INFO - starting webserver on 'localhost:40315' 21:56:30 INFO - SUITE-START | Running 2 tests 21:56:30 INFO - TEST-START | dromaeo_css 21:56:30 INFO - operating with platform_type : linux_ 21:56:30 INFO - Initialising browser for dromaeo_css test... 21:56:30 INFO - TEST-INFO | started process 25018 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzVtZch/profile http://localhost:40315/getInfo.html) 21:56:34 INFO - PROCESS | 25018 | __metrics Screen width/height:1600/1200 21:56:34 INFO - PROCESS | 25018 | colorDepth:24 21:56:34 INFO - PROCESS | 25018 | Browser inner width/height: 1024/697 21:56:34 INFO - PROCESS | 25018 | __metrics 21:56:35 ERROR - PROCESS | 25018 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:56:36 INFO - TEST-INFO | 25018: exit 0 21:56:36 INFO - Browser initialized. 21:56:36 INFO - Running cycle 1/1 for dromaeo_css test... 21:56:36 INFO - TEST-INFO | started process 25102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzVtZch/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:56:48 INFO - PROCESS | 25102 | RSS: Main: 155176960 21:56:48 INFO - PROCESS | 25102 | 21:57:39 INFO - PROCESS | 25102 | 1461128259612 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] 21:59:50 INFO - PROCESS | 25102 | Cycle 1(1): loaded http://localhost:40315/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40315/tests/dromaeo/cssquery-ext.html) 21:59:52 INFO - PROCESS | 25102 | RSS: Main: 263393280 21:59:52 INFO - PROCESS | 25102 | 22:02:54 INFO - PROCESS | 25102 | Cycle 1(1): loaded http://localhost:40315/tests/dromaeo/cssquery-ext.html (next: http://localhost:40315/tests/dromaeo/cssquery-jquery.html) 22:02:55 INFO - PROCESS | 25102 | RSS: Main: 234954752 22:02:55 INFO - PROCESS | 25102 | 22:05:57 INFO - PROCESS | 25102 | Cycle 1(1): loaded http://localhost:40315/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40315/tests/dromaeo/cssquery-mootools.html) 22:05:58 INFO - PROCESS | 25102 | RSS: Main: 240476160 22:05:58 INFO - PROCESS | 25102 | 22:09:00 INFO - PROCESS | 25102 | Cycle 1(1): loaded http://localhost:40315/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40315/tests/dromaeo/cssquery-prototype.html) 22:09:00 INFO - PROCESS | 25102 | RSS: Main: 236888064 22:09:00 INFO - PROCESS | 25102 | 22:12:03 INFO - PROCESS | 25102 | Cycle 1(1): loaded http://localhost:40315/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40315/tests/dromaeo/cssquery-yui.html) 22:12:04 INFO - PROCESS | 25102 | RSS: Main: 210616320 22:12:04 INFO - PROCESS | 25102 | 22:15:06 INFO - PROCESS | 25102 | Cycle 1(1): loaded http://localhost:40315/tests/dromaeo/cssquery-yui.html (next: http://localhost:40315/tests/dromaeo/cssquery-dojo.html) 22:15:06 INFO - PROCESS | 25102 | RSS: Main: 271712256 22:15:06 INFO - PROCESS | 25102 | 22:15:06 INFO - PROCESS | 25102 | __start_tp_report 22:15:06 INFO - PROCESS | 25102 | _x_x_mozilla_page_load 22:15:06 INFO - PROCESS | 25102 | _x_x_mozilla_page_load_details 22:15:06 INFO - PROCESS | 25102 | |i|pagename|runs| 22:15:06 INFO - PROCESS | 25102 | |0;dojo.html;2553.9784086365453;2624.186502184322;2637.683477982642;2653.6550248467697;2653.9601905971404;4430.623397011258;4509.819607215707;4550.135474259889;4556.316552517124;4585.4038974933255;4466.620337271328;4527.977360113203;4556.339330797033;4608.032313214229;4612.884677883055;4071.409645601401;4103.548609652936;4109.28087584673;4121.814518346674;4335.9566404335865;4268.530461649216;4292.6351260142765;4307.203167414038;4337.219300525904;4350.825966961318;4099.467069281004;4182.498100227992;4207.26372884744;4233.8306467741095;4300.526942036374;4225.492940847087;4276.059266961263;4278.42241297424;4279.636230920375;4318.2227199104145;4220.78896055196;4257.084726783756;4264.019275566606;4287.721298115613;4306.935395969032;4366.432363792718;4499.527549607277;4519.593236608721;4599.126166028444;4615.538446155391;4868.488808675109;4891.804327826882;4896.094222568836;4902.961189453395;4923.212286034217;4894.804207831682;4914.262860570907;4916.631252656065;4921.458639549646;4924.729139897304;4438.289873620205;4575.062112266977;4613.5847773700525;4647.34937108805;4660.277656963176;4948.233023881304;4950.8267210647455;4963.057019166346;4963.528464795839;4997.125503036954;4612.446506419184;4779.259214821708;4780.521947805191;4781.760911954458;4783.115123702126;4798.640101992364;4897.632677549127;4898.975505122452;4910.90178196434;4911.238757992517;4730.59789917854;4730.59789917854;4731.148393289241;4732.148213321635;4772.0694464579765;4723.267893476516;4730.030343779517;4732.219183834629;4738.8341408050555;4765.833195838199;4014.397840323975;4076.5515793262716;4077.4903137107863;4080.8571699990357;4112.568180341081;3649.616790236987;3686.4838922550866;3688.0964163780045;3725.2735716535017;3742.6631603155847;4226.070264541796;4226.4716910386205;4236.385724069993;4242.172776308652;4274.529801721808;4724.858254252378;4796.472388037313;4897.3878265216845;4915.778789954461;4975.278584605285;4227.281362168439;4253.936190957138;4260.573942605714;4282.807273672693;4286.849960251377;4418.403515525363;4439.311906654474;4448.7108337957925;4456.554344565518;4482.170798402306;4444.977775111233;4640.211164102178;4665.300204969214;4674.76626168697;4733.029728905566;4913.361263035782;4930.975345123252;4935.777889995031;4946.307516947558;4952.603791696583;4669.369635099218;4670.369500117441;4680.344751734828;4695.060987802385;4700.083483720641;4646.024334889711;4734.4081989751285;4816.831410900601;4819.831305904277;4847.491013443679;4874.293227482066;4879.609631229564;4899.828506002273;4907.77914993819;4952.47998960104;4756.262779269219;4776.188048031773;4780.784864681167;4785.9760701197665;4833.130036593447;4596.149712303235;4685.812567497262;4727.834525791581;4771.045790841776;4776;4658.534146585314;4667.346571480063;4683.203855344667;4686.484486706528;4725.362076119817;4648.767561621973;4785.114753770564;4792.065547218259;4798.712077275374;4847.806087756591;4674.672772906;4723.220668589782;4754.524547545356;4766.594839438687;4768.546988036131 22:15:06 INFO - PROCESS | 25102 | |1;ext.html;566.6203643558817;599.2269971736457;603.8037637767725;611.4466407900851;617.9969100154499;32481.51277730836;33063.1734206645;33085.17287067819;33269;34523;35634.82182589083;36261.0934726632;36363.818180909126;36384.63615363846;36461.817690911506;7235.131784185905;7529.962350188269;7717.18969508202;7726.227377262257;9514.143727064562;9633.325667203299;9787.804243915118;9788.951055244714;9789.706308810712;9795.559199836025;9739.610415583367;9856.35933664313;9860.60557577696;9861.161801246903;9861.359011664255;9746.122848943594;9819.90180098197;9849.704508864674;9850.21198304134;9851.359661621971;9648.421094734338;9750.46372449515;9755.463449510275;9759.170470510015;10037.197024238043;36210.81894590537;36661;36688.44967325492;36743.4488482673;36746;3199.3121478882153;3248.123006788154;3299.1092405050504;3428.0915557377066;3460.3598334308235;28359.85820070907;28765.856170719013;29440.70559294401;29572;29630.70369296301;3278.426275401819;3385.289089291252;3414.231797845465;3438.1748380388776;3450.1202193440763;219825;219966;220945;221097;222311;50828;51135.48864511307;51358;51461.48538514642;51528;53488.19767703488;53805.73097134568;53813.192802108;54027.72986135044;54098.72950635222;13605.863941360658;13985;14007.299635018413;14012.929935350461;14013;9471.76320591977;10492.947535262427;10526.736831579272;10626.309289896131;10670.199735019905;15328.386864525517;15342.539723808304;15360;15421.9228903857;15424.614384640474;5804.796832110856;6012.759489620366;6163.414475624809;6185.597936134137;6235.688215589203;894.6421431427351;952.4570994533188;958.1472489484364;986.363795351994;990.9653162139434;26493.33766655849;27883.16350509488;28386.290342741595;28428.147155585364;28480;977.9070988256104;984.5175863826817;1009.8232809258351;1029.2229366827996;1061.7611037516497;15049.473268435771;15099.622509437133;15117.848821511863;15387.769183462256;15407.537773866801;340717;348134;348259;349198;350276;48727;49300.75349623229;49499;49503.25745113826;49504;1071.9571217151383;1221.5602383142061;1223.8592561855323;1257.2016769351344;1275.8213850061;25329.49341013206;26797.464050719267;27947.720522795324;28937.65954052316;29283.707162928098;42069.57930420656;42786.78606606947;43115.99999999875;43126.78436607797;43162;311710;325936;326060;326172;326246;32276.515852261764;37900.81049594845;38008.61991380051;38652.613473866026;38689.22621547497;42627.360589590564;42747;42752.14495710006;43071.56928430801;43206.56793432026;35562.64437355593;35927.461088083175;36437.817810910776;36589.45115823318;36695.81652091722;35004.47493287654;35453.64546354607;35948.64051359557;36287.637123628425;40508.79745601253;34024.319513609094;34157.14607134841;35910.64089359073;36151.27697446089;36604.26791464209;29510.55734164032;31336;31403.84298078495;31513.21216969594;31586.210344741565;24400;24662.630060549465;24732.752672473045;24770.10604342624;24824.503509930062 22:15:06 INFO - PROCESS | 25102 | |2;jquery.html;378.6119227791513;382.60400485497513;383.9481669974554;387.9146587750695;396.2748170847346;15657.3737050518;16131;16259.105749183791;16270.593235169112;16275.348986040573;15222.162781047038;15351.846481535182;15876.682466350667;15917.920410397961;15926.203689815491;5048.8990220195665;5170.844874653748;5228.738563071831;5230.686158830483;5234.37187537496;3689.6863766579872;5595.132754423071;5964.105384192362;5966.075258334965;5976.252968378953;5855.151003104547;5915.349311575723;5916.497097746696;5940;5944.078667806475;5766.077427611583;5903.852403689943;5933.673647949361;5936.762529498815;5950.583459157882;3317.402867483852;3540.929181416383;3541.9291614167573;3543.787372757617;4807.158747219258;17870.55323616907;18548.90725546377;18592.62814743711;18601.627967440712;18706.251749929987;1911.4838993471685;2124.5538436928264;2489.5020995800915;2493.30187547487;2529.152733834168;12349.93825030869;12543.498260069586;12834.16577922432;13002.609921702364;13116.344182790823;1736.8957862528289;1768.4606195110487;1820.9726854097198;1873.2226126157627;1882.9529261768566;63210.68394658043;63220.36779632191;64127.3587264126;64278;65629.3437065628;9341.34610577253;9358.4384936904;9512.714618561316;9611.183049440875;9750.561224744904;13139.211647301192;13205.33973301331;13247.668808279677;13265.270410127343;13291.268980205989;6945.513814032969;7045.189803172599;7067.6112813795735;7260.2739726026975;7267.9124612771275;6703.731850726014;6719.126513553207;6858.6570671467225;6859.794206173723;6871.828204294932;5941.55438342126;5954.821355359346;5996.13056106862;5997.820065398045;6085.4523092921845;1644.8601868841283;1718.6562687462558;1751.3782607174523;1753.509017475109;1809.9411993730816;879.5865943006777;879.8064425826308;899.9865002024975;947.9810403791886;992.8560358748085;15606.907516473964;16553.586160346087;16553.586160346087;16600.50198494047;16702.331906723837;888.2405543260548;904.6064961741663;910.6539514984264;942.4486675295029;977.9315447918719;9137.725868223964;9605.663801766905;9615.471149086727;9616.711498655051;9742.9025709742;388039;398651;399788;405178;410482;68336.31663683399;68569.3143068563;69043;70231.2976870235;70910.29089709037;919.4115765909823;938.3525367496405;939.8684184214216;1003.9899601004042;1011.261778901406;13837.137846790221;13920;13964.2319672419;14193.29033548339;14301.070430421989;34691.30617387588;35065.29869402649;35162.824185878904;35347.82326088353;35489.64510354863;45411.318830216915;47088.764556177;50096.49903500918;50482.49517504778;51116.74441627768;7503.887441688488;7542.849143016999;7624.390048796194;7691.50005249657;7745.612719363897;10291;10579.735506612396;11024.283421577571;11703.590374336858;11756.647300580997;9310.882694076754;9330.860037099314;9415.482148481899;9512.714618561455;9576.856347154659;9520.52397380142;9625.614975400906;9740.220782337254;9971.60113595477;10021.749456263651;9955.402675839472;10380.636677716244;10475.580976760844;10739;10742.785144297226;7337;7406.4074874008875;7564.546127232384;7579.583122928292;7746.070471543451;7595.88606170919;9540.379875308361;9960.103590676874;10130.645427410005;10161.745956351151 22:15:06 INFO - PROCESS | 25102 | |3;mootools.html;1295.546558704453;1428.6785473268512;1469.926503674816;1606.4698649445677;1787.9284828606849;6854.999999999994;7559.281868222517;7787.766367008985;7794.532328060313;7809.765707028798;7538.321551060403;7687.077550693924;7692.9230707692905;7697.076350837908;7705.807354816133;1888.8583356248337;1967.655660259456;1968.7046942958527;2241.5853067182625;2276.1919518570835;2228.4206106412366;2312.629979203328;2312.6415405612074;2313.178821518362;2317.2353123469215;2215.7562668106493;2226.1763147635397;2230.620794464937;2231.4086767006756;2266.8526545774553;1785.1788177438393;2157.946051348729;2249.3589327041796;2255.650374192003;2257.3002369265496;2261.31030035839;2294.300238427279;2295.4605667668084;2296.402935236834;2297.218945558501;7641.3504852087635;7685.538867667902;7696.769096927102;7701.268379503938;7703.730369437043;4561.885952851205;4726.361941137937;4755.50067242938;4763.904721905543;4766.6901651392545;2889.2199106241196;3076.8461576921063;3090.3201295714907;3094.5977022986867;3098.411301852663;946.8153710026547;966.2077096780642;970.1656575345197;990.9108180263739;999.400359784131;10486.632967846164;10640.148788096934;10689.091427228695;10694.358338499715;10698.62554810578;4184.748915065105;4286.785660717014;4412.24991751403;4417.514073451917;4422.911541769146;9216.170544651013;9254;9261.861072083924;9272.860907086399;9276.443413395218;4737.28940658897;4763.4522029967;4789.592884604847;4793.23308270675;4793.808247670054;3705.370087085202;4053.6554392876346;4211.663066954637;4354.673399495051;4369.956300436955;3746.9063273417837;3787.62123787619;3830.6935445164877;3866.207427477417;3876.127871228951;1222.1506053292876;1263.4730538922156;1264.0961712375695;1276.310792172235;1276.7701813673627;796.5778137587088;898.9503931037245;902.0979020979021;907.2877790934085;919.9034101419388;5207.921881171786;5332.413434522199;5465.562754979592;5538.169274608841;5561.414996725995;403.2781321434599;424.70907428411635;431.0710419046959;434.1707338982528;435.5296280017573;3813.694904407641;3888.533375994842;3902.0635047588376;3930.9606903930594;3974.6621537169663;9021.503817290111;9377.29670274732;9463.053694630482;9476.905230947741;9482.715518534455;9118.316126290554;9160.587773550073;9186.908130918606;9355.766105847271;9363.204127649089;7080.327368899946;7101.786946391617;7167.319104684942;7181.389581885598;7210;5095.082885080721;5115.18157094863;5227;5238.371395432572;5276.9472305278;8596.871046934177;8604.569771511524;8632.438891472035;8729.563521823757;8732.825343493221;8632.266257367943;8905.332100092648;8993.820123597623;9008.81982360336;9016;6030.396960303934;6777.254502004677;6944.375006249462;7291.963540182477;7482.70069197226;7571.129320128035;7574.166841647525;7641.350485208597;7661;7661.808454788675;6654.134962455044;6840.965795170992;6867.553609015597;6983.895241571279;7065.82335441618;6658.5671931324305;6753.054572359775;6791.762288319885;6835.248122706597;6851.314868513109;6428.935710642833;6446.484281257394;6546.967265163644;6577;6580.967095164494;4595.724256544618;4634.026854360487;4636.884077898079;4647.65142614312;4822.397200349957;4688.109259240733;4741.691790033637;4743.051389722001;4773.997460533188;4787.664863459524 22:15:06 INFO - PROCESS | 25102 | |4;prototype.html;309.46926021872486;312.81700205379855;317.1532009534543;326;327.09231881528757;4624.7456389898625;4954.52931971463;4966.304717339575;5007.799688012484;5029.094762942669;4926.704397736138;4944.752762361885;4952.678075925062;4961.305417241589;4964.379452568429;3930.5872883347265;3939.1333906540517;3946.072672921861;3955.1101002274404;3963.900902477447;3937.6652984496354;3949.308870947587;3949.98025009876;3960.980195099035;3975.52293724752;3734.9253014939686;3882.223555288939;3914.1193231522966;3920.4511368408444;3925.234579257046;3873.78694171819;3885.6389223321908;3909.179072394786;3912.902177445558;3942.56631770505;3481.425564781808;3483.285926385085;3488.110531814371;3489.354469423165;3493.3013397320638;4648.651351148644;4733.219018861918;4765.904681906342;4772.76136193189;4825;4441.622462090726;4464.575865292792;4470.687051906368;4472;4472.575105365017;5215;5216.66091704038;5218.347706536683;5221.530062294411;5228.37259528859;3721.4268962661126;3781.111438811877;3781.262653782486;3781.3382658034734;3793.848246070154;5051.318072060261;5219.895602087975;5279.44565820591;5427.972860135714;5453.972730136364;3697.741158118906;3736.572161988053;3748.5126933499014;3756.192418629953;3862;3917.275304068756;3922.4508568800393;3934.213157368538;3936.9212615748097;3937.409388591677;4097.627294856256;4399.296112622029;4401.867943961686;4408.823647054146;4426.667999900021;4849.75751212438;5087.745612719349;5141.460146684619;5174.844754657366;5195.688258704414;1343.8723321284463;1368.50733735855;1377.2149874571599;1382.9170249785045;1385.8683425074603;913.1462082952461;944.8677185194078;957.3681370295571;973.4354074636693;974.4835237324229;4543.432070991126;4581.564751348683;4583.289590113538;4591.127685739699;4593.127305811885;5289.259503669489;5298.364196296392;5301.575873930076;5324;5349;4388.802503887333;4577.885552861138;4585.738921796533;4587.17430862448;4590.97704511482;2848.458792829356;2868.3546202104776;2871.5118429866975;2877.5971364009056;2885.192146199068;5100.872478188075;5112.463191364853;5123.001014802077;5131.56381707559;5145.897082058338;5364.570834333244;5474.288342515527;5481.205225242317;5491.890162196813;5515.972420137954;5082.415522214993;5082.669626474268;5098.872528186751;5118.744062796845;5121.20621303691;5374.731263436891;5375.59683023767;5378.977994181093;5379.327584051994;5399.4060653327315;5063.7468126592785;5213.478652134756;5220.9477905220465;5226.11156103471;5241.213817927342;4871.95128048715;4961.1070007397575;5075.2387141929;5097.719625420637;5138.3833939927445;3778.3576791945984;3784.6404591563755;3786.6024067473622;3787.753796003251;3814.0464883779055;5328.147496400712;5328.547073498641;5352.464753524617;5353.089974704231;5363.678179309254;4980.775865086152;5175.508326709108;5184.559312458483;5208.609354298518;5218.399884013387;5144.254083157996;5157.277981082577;5170.844874653766;5189.584833213409;5200.6879587224885;5094.465081166424;5104.795808167632;5110.182370820651;5123.948760512347;5127.1540195867265;5054.16606259963;5227.215917612237;5259.39516955555;5263.684178949122;5265.183896496049;5111.744412779421;5122.871928201825;5123.846284611468;5140.12617854973;5143.485651434976 22:15:06 INFO - PROCESS | 25102 | |5;yui.html;639.6961443314425;641.4451499452969;641.6503005861805;659.825146336221;664.8769977554151;11235.101191904649;11515.251508651942;11601.709957251072;11697.473613687383;11699.590514332;11268.380239086848;11400.087992960563;11416.086713062956;11419.657410277685;11426.657200283984;646.7897933171714;795.1094773853292;813.0852790610563;825.3933358981144;830.9626066826977;816.346922462031;817.9856977348076;820.6758330459465;820.6922404098464;821.0885916632562;843.3548335523329;844.8394804987064;844.957752112395;845.3279642684081;845.5349557743217;672.4049216443434;830.7258604660448;838.7525679924406;853.6628031927416;854.2311919272643;627.2159800249688;627.8650090230623;628.2178687534004;628.2492421556196;628.2837565175703;11965.581204657883;12005.159638825198;12009.459574319177;12013.219140755822;12027.158098933078;11476.598319058792;11823.231489953125;12068.818967715491;12147.696307592292;12334.568290109803;8967.282617390592;9234;9255.768605784842;9263.953680231623;9310.162085412345;3233.886813961524;3258.5600943872746;3260.7065364117107;3260.7228385587255;3341.3484370547753;45130.548694513294;45400.77299613481;46827.29759053617;46882.29676554854;46938.76530617325;9164.175224229852;9538.570764315622;9852.80294394108;9963.452010139366;9964.20286377088;17468.126593670266;17664.470065898044;17750.37873674415;17804.397604215683;17820.55448613795;6238;6243.875122497525;6296.370362963667;6301;6330.240371155491;3269.1500209945584;3301.7028467437567;3313.287643156733;3399.2521645238007;3402.7447941404494;2758.241483591988;2841.6732075811547;2861.856907154634;2862.298736809453;2872.8994485192916;471.30717844768134;472.8723244723974;519.7790938851049;526.3236740788145;534.2947309551355;514.1490832671934;533.8291746641115;542.1758926431802;547.5099785691863;547.5236544206566;7295.270472952662;7304.036231523459;7484.251574842581;7626.42801789868;7803.765887023398;511.70065511676086;537.857467771041;546.0214529740257;553.8255449533384;560.6991779072513;3662.8168591570316;3698.167912219783;3748.850045998184;3751.4935483709896;3861.5559210690567;50521;51597.48402516002;52409.73795131;52476;52580;45439.091218175454;45845.5415445848;47069.76465117653;47192.764036180284;47779.28331075037;42521.787391063466;42606.36090458646;42851.78574107109;43568.564314357085;43665.78167109144;7212.170600381023;7346.742863999734;7414.147373051952;7558.58427786455;7622.961885190539;29903.401931960805;30104.548431773102;30546.389072218877;30723.385532289674;30849.383012340077;36718.531258750416;39191.216175675756;39329;39473.80263098666;40405;9458.858117128111;9493.522378373036;9697.369670971364;9745.707628771148;9754.609815607297;10454.864167325299;10466.693732856753;10552.261341706315;10553.788924221626;10620.893791062299;7975.521468711896;8014.599270036591;8138.186181381814;8515.27620152294;8613.48319100856;8895;9078.137576930181;9101.726948191565;9115.863262050942;9211.355205135576;8641.524716140673;8799.47203167812;8959.104089590988;8973.730788076367;8984.730458086267;8864.160781532364;9026.819463610822;9071.637134514809;9106.544672766468;9127.817443651222;8070.112287648237;8206.876896846432;8269.131741167092;8269.751907442786;8467.95766021166 22:15:06 INFO - PROCESS | 25102 | __end_tp_report 22:15:06 INFO - PROCESS | 25102 | __start_cc_report 22:15:06 INFO - PROCESS | 25102 | _x_x_mozilla_cycle_collect,1052 22:15:06 INFO - PROCESS | 25102 | __end_cc_report 22:15:06 INFO - PROCESS | 25102 | __startTimestamp1461129306915__endTimestamp 22:15:06 INFO - PROCESS | 25102 | 22:15:06 INFO - PROCESS | 25102 | ------- Summary: start ------- 22:15:06 INFO - PROCESS | 25102 | Number of tests: 6 22:15:06 INFO - PROCESS | 25102 | 22:15:06 INFO - PROCESS | 25102 | [#0] dojo.html Cycles:165 Average:4518.45 Median:4665.30 stddev:450.99 (9.7%) stddev-sans-first:425.23 22:15:06 INFO - PROCESS | 25102 | Values: 2554.0 2624.2 2637.7 2653.7 2654.0 4430.6 4509.8 4550.1 4556.3 4585.4 4466.6 4528.0 4556.3 4608.0 4612.9 4071.4 4103.5 4109.3 4121.8 4336.0 4268.5 4292.6 4307.2 4337.2 4350.8 4099.5 4182.5 4207.3 4233.8 4300.5 4225.5 4276.1 4278.4 4279.6 4318.2 4220.8 4257.1 4264.0 4287.7 4306.9 4366.4 4499.5 4519.6 4599.1 4615.5 4868.5 4891.8 4896.1 4903.0 4923.2 4894.8 4914.3 4916.6 4921.5 4924.7 4438.3 4575.1 4613.6 4647.3 4660.3 4948.2 4950.8 4963.1 4963.5 4997.1 4612.4 4779.3 4780.5 4781.8 4783.1 4798.6 4897.6 4899.0 4910.9 4911.2 4730.6 4730.6 4731.1 4732.1 4772.1 4723.3 4730.0 4732.2 4738.8 4765.8 4014.4 4076.6 4077.5 4080.9 4112.6 3649.6 3686.5 3688.1 3725.3 3742.7 4226.1 4226.5 4236.4 4242.2 4274.5 4724.9 4796.5 4897.4 4915.8 4975.3 4227.3 4253.9 4260.6 4282.8 4286.8 4418.4 4439.3 4448.7 4456.6 4482.2 4445.0 4640.2 4665.3 4674.8 4733.0 4913.4 4931.0 4935.8 4946.3 4952.6 4669.4 4670.4 4680.3 4695.1 4700.1 4646.0 4734.4 4816.8 4819.8 4847.5 4874.3 4879.6 4899.8 4907.8 4952.5 4756.3 4776.2 4780.8 4786.0 4833.1 4596.1 4685.8 4727.8 4771.0 4776.0 4658.5 4667.3 4683.2 4686.5 4725.4 4648.8 4785.1 4792.1 4798.7 4847.8 4674.7 4723.2 4754.5 4766.6 4768.5 22:15:06 INFO - PROCESS | 25102 | 22:15:06 INFO - PROCESS | 25102 | [#1] ext.html Cycles:180 Average:45613.65 Median:35919.05 stddev:79269.70 (220.7%) stddev-sans-first:79419.91 22:15:06 INFO - PROCESS | 25102 | Values: 566.6 599.2 603.8 611.4 618.0 32481.5 33063.2 33085.2 33269.0 34523.0 35634.8 36261.1 36363.8 36384.6 36461.8 7235.1 7530.0 7717.2 7726.2 9514.1 9633.3 9787.8 9789.0 9789.7 9795.6 9739.6 9856.4 9860.6 9861.2 9861.4 9746.1 9819.9 9849.7 9850.2 9851.4 9648.4 9750.5 9755.5 9759.2 10037.2 36210.8 36661.0 36688.4 36743.4 36746.0 3199.3 3248.1 3299.1 3428.1 3460.4 28359.9 28765.9 29440.7 29572.0 29630.7 3278.4 3385.3 3414.2 3438.2 3450.1 219825.0 219966.0 220945.0 221097.0 222311.0 50828.0 51135.5 51358.0 51461.5 51528.0 53488.2 53805.7 53813.2 54027.7 54098.7 13605.9 13985.0 14007.3 14012.9 14013.0 9471.8 10492.9 10526.7 10626.3 10670.2 15328.4 15342.5 15360.0 15421.9 15424.6 5804.8 6012.8 6163.4 6185.6 6235.7 894.6 952.5 958.1 986.4 991.0 26493.3 27883.2 28386.3 28428.1 28480.0 977.9 984.5 1009.8 1029.2 1061.8 15049.5 15099.6 15117.8 15387.8 15407.5 340717.0 348134.0 348259.0 349198.0 350276.0 48727.0 49300.8 49499.0 49503.3 49504.0 1072.0 1221.6 1223.9 1257.2 1275.8 25329.5 26797.5 27947.7 28937.7 29283.7 42069.6 42786.8 43116.0 43126.8 43162.0 311710.0 325936.0 326060.0 326172.0 326246.0 32276.5 37900.8 38008.6 38652.6 38689.2 42627.4 42747.0 42752.1 43071.6 43206.6 35562.6 35927.5 36437.8 36589.5 36695.8 35004.5 35453.6 35948.6 36287.6 40508.8 34024.3 34157.1 35910.6 36151.3 36604.3 29510.6 31336.0 31403.8 31513.2 31586.2 24400.0 24662.6 24732.8 24770.1 24824.5 22:15:06 INFO - PROCESS | 25102 | 22:15:06 INFO - PROCESS | 25102 | [#2] jquery.html Cycles:180 Average:24005.28 Median:28143.79 stddev:65789.44 (233.8%) stddev-sans-first:65950.07 22:15:06 INFO - PROCESS | 25102 | Values: 378.6 382.6 383.9 387.9 396.3 15657.4 16131.0 16259.1 16270.6 16275.3 15222.2 15351.8 15876.7 15917.9 15926.2 5048.9 5170.8 5228.7 5230.7 5234.4 3689.7 5595.1 5964.1 5966.1 5976.3 5855.2 5915.3 5916.5 5940.0 5944.1 5766.1 5903.9 5933.7 5936.8 5950.6 3317.4 3540.9 3541.9 3543.8 4807.2 17870.6 18548.9 18592.6 18601.6 18706.3 1911.5 2124.6 2489.5 2493.3 2529.2 12349.9 12543.5 12834.2 13002.6 13116.3 1736.9 1768.5 1821.0 1873.2 1883.0 63210.7 63220.4 64127.4 64278.0 65629.3 9341.3 9358.4 9512.7 9611.2 9750.6 13139.2 13205.3 13247.7 13265.3 13291.3 6945.5 7045.2 7067.6 7260.3 7267.9 6703.7 6719.1 6858.7 6859.8 6871.8 5941.6 5954.8 5996.1 5997.8 6085.5 1644.9 1718.7 1751.4 1753.5 1809.9 879.6 879.8 900.0 948.0 992.9 15606.9 16553.6 16553.6 16600.5 16702.3 888.2 904.6 910.7 942.4 977.9 9137.7 9605.7 9615.5 9616.7 9742.9 388039.0 398651.0 399788.0 405178.0 410482.0 68336.3 68569.3 69043.0 70231.3 70910.3 919.4 938.4 939.9 1004.0 1011.3 13837.1 13920.0 13964.2 14193.3 14301.1 34691.3 35065.3 35162.8 35347.8 35489.6 45411.3 47088.8 50096.5 50482.5 51116.7 7503.9 7542.8 7624.4 7691.5 7745.6 10291.0 10579.7 11024.3 11703.6 11756.6 9310.9 9330.9 9415.5 9512.7 9576.9 9520.5 9625.6 9740.2 9971.6 10021.7 9955.4 10380.6 10475.6 10739.0 10742.8 7337.0 7406.4 7564.5 7579.6 7746.1 7595.9 9540.4 9960.1 10130.6 10161.7 22:15:06 INFO - PROCESS | 25102 | 22:15:06 INFO - PROCESS | 25102 | [#3] mootools.html Cycles:180 Average:5158.33 Median:5105.13 stddev:2835.14 (55.5%) stddev-sans-first:2828.23 22:15:06 INFO - PROCESS | 25102 | Values: 1295.5 1428.7 1469.9 1606.5 1787.9 6855.0 7559.3 7787.8 7794.5 7809.8 7538.3 7687.1 7692.9 7697.1 7705.8 1888.9 1967.7 1968.7 2241.6 2276.2 2228.4 2312.6 2312.6 2313.2 2317.2 2215.8 2226.2 2230.6 2231.4 2266.9 1785.2 2157.9 2249.4 2255.7 2257.3 2261.3 2294.3 2295.5 2296.4 2297.2 7641.4 7685.5 7696.8 7701.3 7703.7 4561.9 4726.4 4755.5 4763.9 4766.7 2889.2 3076.8 3090.3 3094.6 3098.4 946.8 966.2 970.2 990.9 999.4 10486.6 10640.1 10689.1 10694.4 10698.6 4184.7 4286.8 4412.2 4417.5 4422.9 9216.2 9254.0 9261.9 9272.9 9276.4 4737.3 4763.5 4789.6 4793.2 4793.8 3705.4 4053.7 4211.7 4354.7 4370.0 3746.9 3787.6 3830.7 3866.2 3876.1 1222.2 1263.5 1264.1 1276.3 1276.8 796.6 899.0 902.1 907.3 919.9 5207.9 5332.4 5465.6 5538.2 5561.4 403.3 424.7 431.1 434.2 435.5 3813.7 3888.5 3902.1 3931.0 3974.7 9021.5 9377.3 9463.1 9476.9 9482.7 9118.3 9160.6 9186.9 9355.8 9363.2 7080.3 7101.8 7167.3 7181.4 7210.0 5095.1 5115.2 5227.0 5238.4 5276.9 8596.9 8604.6 8632.4 8729.6 8732.8 8632.3 8905.3 8993.8 9008.8 9016.0 6030.4 6777.3 6944.4 7292.0 7482.7 7571.1 7574.2 7641.4 7661.0 7661.8 6654.1 6841.0 6867.6 6983.9 7065.8 6658.6 6753.1 6791.8 6835.2 6851.3 6428.9 6446.5 6547.0 6577.0 6581.0 4595.7 4634.0 4636.9 4647.7 4822.4 4688.1 4741.7 4743.1 4774.0 4787.7 22:15:06 INFO - PROCESS | 25102 | 22:15:06 INFO - PROCESS | 25102 | [#4] prototype.html Cycles:180 Average:4328.13 Median:4953.60 stddev:1234.56 (24.9%) stddev-sans-first:1200.61 22:15:06 INFO - PROCESS | 25102 | Values: 309.5 312.8 317.2 326.0 327.1 4624.7 4954.5 4966.3 5007.8 5029.1 4926.7 4944.8 4952.7 4961.3 4964.4 3930.6 3939.1 3946.1 3955.1 3963.9 3937.7 3949.3 3950.0 3961.0 3975.5 3734.9 3882.2 3914.1 3920.5 3925.2 3873.8 3885.6 3909.2 3912.9 3942.6 3481.4 3483.3 3488.1 3489.4 3493.3 4648.7 4733.2 4765.9 4772.8 4825.0 4441.6 4464.6 4470.7 4472.0 4472.6 5215.0 5216.7 5218.3 5221.5 5228.4 3721.4 3781.1 3781.3 3781.3 3793.8 5051.3 5219.9 5279.4 5428.0 5454.0 3697.7 3736.6 3748.5 3756.2 3862.0 3917.3 3922.5 3934.2 3936.9 3937.4 4097.6 4399.3 4401.9 4408.8 4426.7 4849.8 5087.7 5141.5 5174.8 5195.7 1343.9 1368.5 1377.2 1382.9 1385.9 913.1 944.9 957.4 973.4 974.5 4543.4 4581.6 4583.3 4591.1 4593.1 5289.3 5298.4 5301.6 5324.0 5349.0 4388.8 4577.9 4585.7 4587.2 4591.0 2848.5 2868.4 2871.5 2877.6 2885.2 5100.9 5112.5 5123.0 5131.6 5145.9 5364.6 5474.3 5481.2 5491.9 5516.0 5082.4 5082.7 5098.9 5118.7 5121.2 5374.7 5375.6 5379.0 5379.3 5399.4 5063.7 5213.5 5220.9 5226.1 5241.2 4872.0 4961.1 5075.2 5097.7 5138.4 3778.4 3784.6 3786.6 3787.8 3814.0 5328.1 5328.5 5352.5 5353.1 5363.7 4980.8 5175.5 5184.6 5208.6 5218.4 5144.3 5157.3 5170.8 5189.6 5200.7 5094.5 5104.8 5110.2 5123.9 5127.2 5054.2 5227.2 5259.4 5263.7 5265.2 5111.7 5122.9 5123.8 5140.1 5143.5 22:15:06 INFO - PROCESS | 25102 | 22:15:06 INFO - PROCESS | 25102 | [#5] yui.html Cycles:180 Average:12361.38 Median:546.77 stddev:14608.41 (2671.8%) stddev-sans-first:14622.87 22:15:06 INFO - PROCESS | 25102 | Values: 639.7 641.4 641.7 659.8 664.9 11235.1 11515.3 11601.7 11697.5 11699.6 11268.4 11400.1 11416.1 11419.7 11426.7 646.8 795.1 813.1 825.4 831.0 816.3 818.0 820.7 820.7 821.1 843.4 844.8 845.0 845.3 845.5 672.4 830.7 838.8 853.7 854.2 627.2 627.9 628.2 628.2 628.3 11965.6 12005.2 12009.5 12013.2 12027.2 11476.6 11823.2 12068.8 12147.7 12334.6 8967.3 9234.0 9255.8 9264.0 9310.2 3233.9 3258.6 3260.7 3260.7 3341.3 45130.5 45400.8 46827.3 46882.3 46938.8 9164.2 9538.6 9852.8 9963.5 9964.2 17468.1 17664.5 17750.4 17804.4 17820.6 6238.0 6243.9 6296.4 6301.0 6330.2 3269.2 3301.7 3313.3 3399.3 3402.7 2758.2 2841.7 2861.9 2862.3 2872.9 471.3 472.9 519.8 526.3 534.3 514.1 533.8 542.2 547.5 547.5 7295.3 7304.0 7484.3 7626.4 7803.8 511.7 537.9 546.0 553.8 560.7 3662.8 3698.2 3748.9 3751.5 3861.6 50521.0 51597.5 52409.7 52476.0 52580.0 45439.1 45845.5 47069.8 47192.8 47779.3 42521.8 42606.4 42851.8 43568.6 43665.8 7212.2 7346.7 7414.1 7558.6 7623.0 29903.4 30104.5 30546.4 30723.4 30849.4 36718.5 39191.2 39329.0 39473.8 40405.0 9458.9 9493.5 9697.4 9745.7 9754.6 10454.9 10466.7 10552.3 10553.8 10620.9 7975.5 8014.6 8138.2 8515.3 8613.5 8895.0 9078.1 9101.7 9115.9 9211.4 8641.5 8799.5 8959.1 8973.7 8984.7 8864.2 9026.8 9071.6 9106.5 9127.8 8070.1 8206.9 8269.1 8269.8 8468.0 22:15:06 INFO - PROCESS | 25102 | -------- Summary: end -------- 22:15:06 INFO - PROCESS | 25102 | 22:15:07 INFO - TEST-INFO | 25102: exit 0 22:15:07 INFO - TEST-OK | dromaeo_css | took 1117240ms 22:15:07 INFO - TEST-START | kraken 22:15:07 INFO - operating with platform_type : linux_ 22:15:07 INFO - Initialising browser for kraken test... 22:15:07 INFO - TEST-INFO | started process 25278 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp04b9fU/profile http://localhost:40315/getInfo.html) 22:15:11 INFO - PROCESS | 25278 | __metrics Screen width/height:1600/1200 22:15:11 INFO - PROCESS | 25278 | colorDepth:24 22:15:11 INFO - PROCESS | 25278 | Browser inner width/height: 1024/697 22:15:11 INFO - PROCESS | 25278 | __metrics 22:15:12 ERROR - PROCESS | 25278 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:15:13 INFO - TEST-INFO | 25278: exit 0 22:15:13 INFO - Browser initialized. 22:15:13 INFO - Running cycle 1/1 for kraken test... 22:15:13 INFO - TEST-INFO | started process 25357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp04b9fU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:15:25 INFO - PROCESS | 25357 | RSS: Main: 155045888 22:15:25 INFO - PROCESS | 25357 | 22:15:28 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40315/tests/kraken/driver.html?testName=audio-beat-detection) 22:15:29 INFO - PROCESS | 25357 | RSS: Main: 209727488 22:15:29 INFO - PROCESS | 25357 | 22:15:31 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40315/tests/kraken/driver.html?testName=audio-dft) 22:15:32 INFO - PROCESS | 25357 | RSS: Main: 194768896 22:15:32 INFO - PROCESS | 25357 | 22:15:35 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40315/tests/kraken/driver.html?testName=audio-fft) 22:15:36 INFO - PROCESS | 25357 | RSS: Main: 265781248 22:15:36 INFO - PROCESS | 25357 | 22:15:38 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40315/tests/kraken/driver.html?testName=audio-oscillator) 22:15:38 INFO - PROCESS | 25357 | RSS: Main: 174047232 22:15:38 INFO - PROCESS | 25357 | 22:15:41 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40315/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:15:41 INFO - PROCESS | 25357 | RSS: Main: 178589696 22:15:41 INFO - PROCESS | 25357 | 22:15:44 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40315/tests/kraken/driver.html?testName=imaging-darkroom) 22:15:45 INFO - PROCESS | 25357 | RSS: Main: 214704128 22:15:45 INFO - PROCESS | 25357 | 22:15:48 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40315/tests/kraken/driver.html?testName=imaging-desaturate) 22:15:49 INFO - PROCESS | 25357 | RSS: Main: 215191552 22:15:49 INFO - PROCESS | 25357 | 22:15:52 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40315/tests/kraken/driver.html?testName=json-parse-financial) 22:15:53 INFO - PROCESS | 25357 | RSS: Main: 215658496 22:15:53 INFO - PROCESS | 25357 | 22:15:54 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40315/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:15:55 INFO - PROCESS | 25357 | RSS: Main: 204615680 22:15:55 INFO - PROCESS | 25357 | 22:15:57 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40315/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:15:57 INFO - PROCESS | 25357 | RSS: Main: 207056896 22:15:57 INFO - PROCESS | 25357 | 22:15:59 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40315/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:16:00 INFO - PROCESS | 25357 | RSS: Main: 220438528 22:16:00 INFO - PROCESS | 25357 | 22:16:03 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:16:04 INFO - PROCESS | 25357 | RSS: Main: 223907840 22:16:04 INFO - PROCESS | 25357 | 22:16:06 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:16:07 INFO - PROCESS | 25357 | RSS: Main: 220565504 22:16:07 INFO - PROCESS | 25357 | 22:16:09 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40315/tests/kraken/driver.html?testName=ai-astar) 22:16:09 INFO - PROCESS | 25357 | RSS: Main: 283217920 22:16:09 INFO - PROCESS | 25357 | 22:16:09 INFO - PROCESS | 25357 | __start_tp_report 22:16:09 INFO - PROCESS | 25357 | _x_x_mozilla_page_load 22:16:09 INFO - PROCESS | 25357 | _x_x_mozilla_page_load_details 22:16:09 INFO - PROCESS | 25357 | |i|pagename|runs| 22:16:09 INFO - PROCESS | 25357 | |0;ai-astar;110;115;108;113;113;112;101;112;112;112 22:16:09 INFO - PROCESS | 25357 | |1;audio-beat-detection;161;140;153;186;132;153;162;138;195;136 22:16:09 INFO - PROCESS | 25357 | |2;audio-dft;162;160;161;162;162;163;162;162;161;162 22:16:09 INFO - PROCESS | 25357 | |3;audio-fft;77;73;99;109;74;74;73;110;103;75 22:16:09 INFO - PROCESS | 25357 | |4;audio-oscillator;94;94;145;95;94;93;140;93;95;139 22:16:09 INFO - PROCESS | 25357 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;118;117;117 22:16:09 INFO - PROCESS | 25357 | |6;imaging-darkroom;146;146;146;147;146;146;146;146;146;146 22:16:09 INFO - PROCESS | 25357 | |7;imaging-desaturate;94;95;95;95;95;95;94;95;95;94 22:16:09 INFO - PROCESS | 25357 | |8;json-parse-financial;65;64;65;65;66;65;65;84;62;64 22:16:09 INFO - PROCESS | 25357 | |9;json-stringify-tinderbox;64;65;64;64;66;65;64;65;65;65 22:16:09 INFO - PROCESS | 25357 | |10;stanford-crypto-aes;78;78;78;77;79;79;79;88;80;80 22:16:09 INFO - PROCESS | 25357 | |11;stanford-crypto-ccm;144;131;135;139;130;131;131;130;163;139 22:16:09 INFO - PROCESS | 25357 | |12;stanford-crypto-pbkdf2;174;178;172;174;172;181;176;172;177;169 22:16:09 INFO - PROCESS | 25357 | |13;stanford-crypto-sha256-iterative;72;73;73;72;71;71;72;71;71;82 22:16:09 INFO - PROCESS | 25357 | __end_tp_report 22:16:09 INFO - PROCESS | 25357 | __start_cc_report 22:16:09 INFO - PROCESS | 25357 | _x_x_mozilla_cycle_collect,1892 22:16:09 INFO - PROCESS | 25357 | __end_cc_report 22:16:09 INFO - PROCESS | 25357 | __startTimestamp1461129369617__endTimestamp 22:16:09 INFO - PROCESS | 25357 | 22:16:09 INFO - PROCESS | 25357 | ------- Summary: start ------- 22:16:09 INFO - PROCESS | 25357 | Number of tests: 14 22:16:09 INFO - PROCESS | 25357 | 22:16:09 INFO - PROCESS | 25357 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.91 (3.5%) stddev-sans-first:4.14 22:16:09 INFO - PROCESS | 25357 | Values: 110.0 115.0 108.0 113.0 113.0 112.0 101.0 112.0 112.0 112.0 22:16:09 INFO - PROCESS | 25357 | 22:16:09 INFO - PROCESS | 25357 | [#1] audio-beat-detection Cycles:10 Average:155.60 Median:157.00 stddev:21.22 (13.5%) stddev-sans-first:22.42 22:16:09 INFO - PROCESS | 25357 | Values: 161.0 140.0 153.0 186.0 132.0 153.0 162.0 138.0 195.0 136.0 22:16:09 INFO - PROCESS | 25357 | 22:16:09 INFO - PROCESS | 25357 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 22:16:09 INFO - PROCESS | 25357 | Values: 162.0 160.0 161.0 162.0 162.0 163.0 162.0 162.0 161.0 162.0 22:16:09 INFO - PROCESS | 25357 | 22:16:09 INFO - PROCESS | 25357 | [#3] audio-fft Cycles:10 Average:86.70 Median:74.00 stddev:16.28 (22.0%) stddev-sans-first:16.89 22:16:09 INFO - PROCESS | 25357 | Values: 77.0 73.0 99.0 109.0 74.0 74.0 73.0 110.0 103.0 75.0 22:16:09 INFO - PROCESS | 25357 | 22:16:09 INFO - PROCESS | 25357 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:94.00 stddev:22.92 (24.4%) stddev-sans-first:23.73 22:16:09 INFO - PROCESS | 25357 | Values: 94.0 94.0 145.0 95.0 94.0 93.0 140.0 93.0 95.0 139.0 22:16:09 INFO - PROCESS | 25357 | 22:16:09 INFO - PROCESS | 25357 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 22:16:09 INFO - PROCESS | 25357 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 117.0 117.0 22:16:09 INFO - PROCESS | 25357 | 22:16:09 INFO - PROCESS | 25357 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 22:16:09 INFO - PROCESS | 25357 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 22:16:09 INFO - PROCESS | 25357 | 22:16:09 INFO - PROCESS | 25357 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 22:16:09 INFO - PROCESS | 25357 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 22:16:09 INFO - PROCESS | 25357 | 22:16:09 INFO - PROCESS | 25357 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:65.00 stddev:6.24 (9.6%) stddev-sans-first:6.60 22:16:09 INFO - PROCESS | 25357 | Values: 65.0 64.0 65.0 65.0 66.0 65.0 65.0 84.0 62.0 64.0 22:16:09 INFO - PROCESS | 25357 | 22:16:09 INFO - PROCESS | 25357 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 22:16:09 INFO - PROCESS | 25357 | Values: 64.0 65.0 64.0 64.0 66.0 65.0 64.0 65.0 65.0 65.0 22:16:09 INFO - PROCESS | 25357 | 22:16:09 INFO - PROCESS | 25357 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:3.10 (3.9%) stddev-sans-first:3.23 22:16:09 INFO - PROCESS | 25357 | Values: 78.0 78.0 78.0 77.0 79.0 79.0 79.0 88.0 80.0 80.0 22:16:09 INFO - PROCESS | 25357 | 22:16:09 INFO - PROCESS | 25357 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:137.00 stddev:10.23 (7.5%) stddev-sans-first:10.56 22:16:09 INFO - PROCESS | 25357 | Values: 144.0 131.0 135.0 139.0 130.0 131.0 131.0 130.0 163.0 139.0 22:16:09 INFO - PROCESS | 25357 | 22:16:09 INFO - PROCESS | 25357 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:175.00 stddev:3.54 (2.0%) stddev-sans-first:3.75 22:16:09 INFO - PROCESS | 25357 | Values: 174.0 178.0 172.0 174.0 172.0 181.0 176.0 172.0 177.0 169.0 22:16:09 INFO - PROCESS | 25357 | 22:16:09 INFO - PROCESS | 25357 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:72.00 stddev:3.33 (4.6%) stddev-sans-first:3.52 22:16:09 INFO - PROCESS | 25357 | Values: 72.0 73.0 73.0 72.0 71.0 71.0 72.0 71.0 71.0 82.0 22:16:09 INFO - PROCESS | 25357 | -------- Summary: end -------- 22:16:09 INFO - PROCESS | 25357 | 22:16:10 INFO - TEST-INFO | 25357: exit 0 22:16:10 INFO - TEST-OK | kraken | took 62891ms 22:16:10 INFO - SUITE-END | took 1180s 22:16:10 INFO - Completed test suite (00:19:40) 22:16:10 INFO - javascript benchmark 22:16:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2553.9784086365453, 2624.186502184322, 2637.683477982642, 2653.6550248467697, 2653.9601905971404, 4430.623397011258, 4509.819607215707, 4550.135474259889, 4556.316552517124, 4585.4038974933255, 4466.620337271328, 4527.977360113203, 4556.339330797033, 4608.032313214229, 4612.884677883055, 4071.409645601401, 4103.548609652936, 4109.28087584673, 4121.814518346674, 4335.9566404335865, 4268.530461649216, 4292.6351260142765, 4307.203167414038, 4337.219300525904, 4350.825966961318, 4099.467069281004, 4182.498100227992, 4207.26372884744, 4233.8306467741095, 4300.526942036374, 4225.492940847087, 4276.059266961263, 4278.42241297424, 4279.636230920375, 4318.2227199104145, 4220.78896055196, 4257.084726783756, 4264.019275566606, 4287.721298115613, 4306.935395969032, 4366.432363792718, 4499.527549607277, 4519.593236608721, 4599.126166028444, 4615.538446155391, 4868.488808675109, 4891.804327826882, 4896.094222568836, 4902.961189453395, 4923.212286034217, 4894.804207831682, 4914.262860570907, 4916.631252656065, 4921.458639549646, 4924.729139897304, 4438.289873620205, 4575.062112266977, 4613.5847773700525, 4647.34937108805, 4660.277656963176, 4948.233023881304, 4950.8267210647455, 4963.057019166346, 4963.528464795839, 4997.125503036954, 4612.446506419184, 4779.259214821708, 4780.521947805191, 4781.760911954458, 4783.115123702126, 4798.640101992364, 4897.632677549127, 4898.975505122452, 4910.90178196434, 4911.238757992517, 4730.59789917854, 4730.59789917854, 4731.148393289241, 4732.148213321635, 4772.0694464579765, 4723.267893476516, 4730.030343779517, 4732.219183834629, 4738.8341408050555, 4765.833195838199, 4014.397840323975, 4076.5515793262716, 4077.4903137107863, 4080.8571699990357, 4112.568180341081, 3649.616790236987, 3686.4838922550866, 3688.0964163780045, 3725.2735716535017, 3742.6631603155847, 4226.070264541796, 4226.4716910386205, 4236.385724069993, 4242.172776308652, 4274.529801721808, 4724.858254252378, 4796.472388037313, 4897.3878265216845, 4915.778789954461, 4975.278584605285, 4227.281362168439, 4253.936190957138, 4260.573942605714, 4282.807273672693, 4286.849960251377, 4418.403515525363, 4439.311906654474, 4448.7108337957925, 4456.554344565518, 4482.170798402306, 4444.977775111233, 4640.211164102178, 4665.300204969214, 4674.76626168697, 4733.029728905566, 4913.361263035782, 4930.975345123252, 4935.777889995031, 4946.307516947558, 4952.603791696583, 4669.369635099218, 4670.369500117441, 4680.344751734828, 4695.060987802385, 4700.083483720641, 4646.024334889711, 4734.4081989751285, 4816.831410900601, 4819.831305904277, 4847.491013443679, 4874.293227482066, 4879.609631229564, 4899.828506002273, 4907.77914993819, 4952.47998960104, 4756.262779269219, 4776.188048031773, 4780.784864681167, 4785.9760701197665, 4833.130036593447, 4596.149712303235, 4685.812567497262, 4727.834525791581, 4771.045790841776, 4776.0, 4658.534146585314, 4667.346571480063, 4683.203855344667, 4686.484486706528, 4725.362076119817, 4648.767561621973, 4785.114753770564, 4792.065547218259, 4798.712077275374, 4847.806087756591, 4674.672772906, 4723.220668589782, 4754.524547545356, 4766.594839438687, 4768.546988036131], "value": 4491.291545576138, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.6203643558817, 599.2269971736457, 603.8037637767725, 611.4466407900851, 617.9969100154499, 32481.51277730836, 33063.1734206645, 33085.17287067819, 33269.0, 34523.0, 35634.82182589083, 36261.0934726632, 36363.818180909126, 36384.63615363846, 36461.817690911506, 7235.131784185905, 7529.962350188269, 7717.18969508202, 7726.227377262257, 9514.143727064562, 9633.325667203299, 9787.804243915118, 9788.951055244714, 9789.706308810712, 9795.559199836025, 9739.610415583367, 9856.35933664313, 9860.60557577696, 9861.161801246903, 9861.359011664255, 9746.122848943594, 9819.90180098197, 9849.704508864674, 9850.21198304134, 9851.359661621971, 9648.421094734338, 9750.46372449515, 9755.463449510275, 9759.170470510015, 10037.197024238043, 36210.81894590537, 36661.0, 36688.44967325492, 36743.4488482673, 36746.0, 3199.3121478882153, 3248.123006788154, 3299.1092405050504, 3428.0915557377066, 3460.3598334308235, 28359.85820070907, 28765.856170719013, 29440.70559294401, 29572.0, 29630.70369296301, 3278.426275401819, 3385.289089291252, 3414.231797845465, 3438.1748380388776, 3450.1202193440763, 219825.0, 219966.0, 220945.0, 221097.0, 222311.0, 50828.0, 51135.48864511307, 51358.0, 51461.48538514642, 51528.0, 53488.19767703488, 53805.73097134568, 53813.192802108, 54027.72986135044, 54098.72950635222, 13605.863941360658, 13985.0, 14007.299635018413, 14012.929935350461, 14013.0, 9471.76320591977, 10492.947535262427, 10526.736831579272, 10626.309289896131, 10670.199735019905, 15328.386864525517, 15342.539723808304, 15360.0, 15421.9228903857, 15424.614384640474, 5804.796832110856, 6012.759489620366, 6163.414475624809, 6185.597936134137, 6235.688215589203, 894.6421431427351, 952.4570994533188, 958.1472489484364, 986.363795351994, 990.9653162139434, 26493.33766655849, 27883.16350509488, 28386.290342741595, 28428.147155585364, 28480.0, 977.9070988256104, 984.5175863826817, 1009.8232809258351, 1029.2229366827996, 1061.7611037516497, 15049.473268435771, 15099.622509437133, 15117.848821511863, 15387.769183462256, 15407.537773866801, 340717.0, 348134.0, 348259.0, 349198.0, 350276.0, 48727.0, 49300.75349623229, 49499.0, 49503.25745113826, 49504.0, 1071.9571217151383, 1221.5602383142061, 1223.8592561855323, 1257.2016769351344, 1275.8213850061, 25329.49341013206, 26797.464050719267, 27947.720522795324, 28937.65954052316, 29283.707162928098, 42069.57930420656, 42786.78606606947, 43115.99999999875, 43126.78436607797, 43162.0, 311710.0, 325936.0, 326060.0, 326172.0, 326246.0, 32276.515852261764, 37900.81049594845, 38008.61991380051, 38652.613473866026, 38689.22621547497, 42627.360589590564, 42747.0, 42752.14495710006, 43071.56928430801, 43206.56793432026, 35562.64437355593, 35927.461088083175, 36437.817810910776, 36589.45115823318, 36695.81652091722, 35004.47493287654, 35453.64546354607, 35948.64051359557, 36287.637123628425, 40508.79745601253, 34024.319513609094, 34157.14607134841, 35910.64089359073, 36151.27697446089, 36604.26791464209, 29510.55734164032, 31336.0, 31403.84298078495, 31513.21216969594, 31586.210344741565, 24400.0, 24662.630060549465, 24732.752672473045, 24770.10604342624, 24824.503509930062], "value": 17776.832498506083, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.6119227791513, 382.60400485497513, 383.9481669974554, 387.9146587750695, 396.2748170847346, 15657.3737050518, 16131.0, 16259.105749183791, 16270.593235169112, 16275.348986040573, 15222.162781047038, 15351.846481535182, 15876.682466350667, 15917.920410397961, 15926.203689815491, 5048.8990220195665, 5170.844874653748, 5228.738563071831, 5230.686158830483, 5234.37187537496, 3689.6863766579872, 5595.132754423071, 5964.105384192362, 5966.075258334965, 5976.252968378953, 5855.151003104547, 5915.349311575723, 5916.497097746696, 5940.0, 5944.078667806475, 5766.077427611583, 5903.852403689943, 5933.673647949361, 5936.762529498815, 5950.583459157882, 3317.402867483852, 3540.929181416383, 3541.9291614167573, 3543.787372757617, 4807.158747219258, 17870.55323616907, 18548.90725546377, 18592.62814743711, 18601.627967440712, 18706.251749929987, 1911.4838993471685, 2124.5538436928264, 2489.5020995800915, 2493.30187547487, 2529.152733834168, 12349.93825030869, 12543.498260069586, 12834.16577922432, 13002.609921702364, 13116.344182790823, 1736.8957862528289, 1768.4606195110487, 1820.9726854097198, 1873.2226126157627, 1882.9529261768566, 63210.68394658043, 63220.36779632191, 64127.3587264126, 64278.0, 65629.3437065628, 9341.34610577253, 9358.4384936904, 9512.714618561316, 9611.183049440875, 9750.561224744904, 13139.211647301192, 13205.33973301331, 13247.668808279677, 13265.270410127343, 13291.268980205989, 6945.513814032969, 7045.189803172599, 7067.6112813795735, 7260.2739726026975, 7267.9124612771275, 6703.731850726014, 6719.126513553207, 6858.6570671467225, 6859.794206173723, 6871.828204294932, 5941.55438342126, 5954.821355359346, 5996.13056106862, 5997.820065398045, 6085.4523092921845, 1644.8601868841283, 1718.6562687462558, 1751.3782607174523, 1753.509017475109, 1809.9411993730816, 879.5865943006777, 879.8064425826308, 899.9865002024975, 947.9810403791886, 992.8560358748085, 15606.907516473964, 16553.586160346087, 16553.586160346087, 16600.50198494047, 16702.331906723837, 888.2405543260548, 904.6064961741663, 910.6539514984264, 942.4486675295029, 977.9315447918719, 9137.725868223964, 9605.663801766905, 9615.471149086727, 9616.711498655051, 9742.9025709742, 388039.0, 398651.0, 399788.0, 405178.0, 410482.0, 68336.31663683399, 68569.3143068563, 69043.0, 70231.2976870235, 70910.29089709037, 919.4115765909823, 938.3525367496405, 939.8684184214216, 1003.9899601004042, 1011.261778901406, 13837.137846790221, 13920.0, 13964.2319672419, 14193.29033548339, 14301.070430421989, 34691.30617387588, 35065.29869402649, 35162.824185878904, 35347.82326088353, 35489.64510354863, 45411.318830216915, 47088.764556177, 50096.49903500918, 50482.49517504778, 51116.74441627768, 7503.887441688488, 7542.849143016999, 7624.390048796194, 7691.50005249657, 7745.612719363897, 10291.0, 10579.735506612396, 11024.283421577571, 11703.590374336858, 11756.647300580997, 9310.882694076754, 9330.860037099314, 9415.482148481899, 9512.714618561455, 9576.856347154659, 9520.52397380142, 9625.614975400906, 9740.220782337254, 9971.60113595477, 10021.749456263651, 9955.402675839472, 10380.636677716244, 10475.580976760844, 10739.0, 10742.785144297226, 7337.0, 7406.4074874008875, 7564.546127232384, 7579.583122928292, 7746.070471543451, 7595.88606170919, 9540.379875308361, 9960.103590676874, 10130.645427410005, 10161.745956351151], "value": 8180.382671524748, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.546558704453, 1428.6785473268512, 1469.926503674816, 1606.4698649445677, 1787.9284828606849, 6854.999999999994, 7559.281868222517, 7787.766367008985, 7794.532328060313, 7809.765707028798, 7538.321551060403, 7687.077550693924, 7692.9230707692905, 7697.076350837908, 7705.807354816133, 1888.8583356248337, 1967.655660259456, 1968.7046942958527, 2241.5853067182625, 2276.1919518570835, 2228.4206106412366, 2312.629979203328, 2312.6415405612074, 2313.178821518362, 2317.2353123469215, 2215.7562668106493, 2226.1763147635397, 2230.620794464937, 2231.4086767006756, 2266.8526545774553, 1785.1788177438393, 2157.946051348729, 2249.3589327041796, 2255.650374192003, 2257.3002369265496, 2261.31030035839, 2294.300238427279, 2295.4605667668084, 2296.402935236834, 2297.218945558501, 7641.3504852087635, 7685.538867667902, 7696.769096927102, 7701.268379503938, 7703.730369437043, 4561.885952851205, 4726.361941137937, 4755.50067242938, 4763.904721905543, 4766.6901651392545, 2889.2199106241196, 3076.8461576921063, 3090.3201295714907, 3094.5977022986867, 3098.411301852663, 946.8153710026547, 966.2077096780642, 970.1656575345197, 990.9108180263739, 999.400359784131, 10486.632967846164, 10640.148788096934, 10689.091427228695, 10694.358338499715, 10698.62554810578, 4184.748915065105, 4286.785660717014, 4412.24991751403, 4417.514073451917, 4422.911541769146, 9216.170544651013, 9254.0, 9261.861072083924, 9272.860907086399, 9276.443413395218, 4737.28940658897, 4763.4522029967, 4789.592884604847, 4793.23308270675, 4793.808247670054, 3705.370087085202, 4053.6554392876346, 4211.663066954637, 4354.673399495051, 4369.956300436955, 3746.9063273417837, 3787.62123787619, 3830.6935445164877, 3866.207427477417, 3876.127871228951, 1222.1506053292876, 1263.4730538922156, 1264.0961712375695, 1276.310792172235, 1276.7701813673627, 796.5778137587088, 898.9503931037245, 902.0979020979021, 907.2877790934085, 919.9034101419388, 5207.921881171786, 5332.413434522199, 5465.562754979592, 5538.169274608841, 5561.414996725995, 403.2781321434599, 424.70907428411635, 431.0710419046959, 434.1707338982528, 435.5296280017573, 3813.694904407641, 3888.533375994842, 3902.0635047588376, 3930.9606903930594, 3974.6621537169663, 9021.503817290111, 9377.29670274732, 9463.053694630482, 9476.905230947741, 9482.715518534455, 9118.316126290554, 9160.587773550073, 9186.908130918606, 9355.766105847271, 9363.204127649089, 7080.327368899946, 7101.786946391617, 7167.319104684942, 7181.389581885598, 7210.0, 5095.082885080721, 5115.18157094863, 5227.0, 5238.371395432572, 5276.9472305278, 8596.871046934177, 8604.569771511524, 8632.438891472035, 8729.563521823757, 8732.825343493221, 8632.266257367943, 8905.332100092648, 8993.820123597623, 9008.81982360336, 9016.0, 6030.396960303934, 6777.254502004677, 6944.375006249462, 7291.963540182477, 7482.70069197226, 7571.129320128035, 7574.166841647525, 7641.350485208597, 7661.0, 7661.808454788675, 6654.134962455044, 6840.965795170992, 6867.553609015597, 6983.895241571279, 7065.82335441618, 6658.5671931324305, 6753.054572359775, 6791.762288319885, 6835.248122706597, 6851.314868513109, 6428.935710642833, 6446.484281257394, 6546.967265163644, 6577.0, 6580.967095164494, 4595.724256544618, 4634.026854360487, 4636.884077898079, 4647.65142614312, 4822.397200349957, 4688.109259240733, 4741.691790033637, 4743.051389722001, 4773.997460533188, 4787.664863459524], "value": 4123.463649522588, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.46926021872486, 312.81700205379855, 317.1532009534543, 326.0, 327.09231881528757, 4624.7456389898625, 4954.52931971463, 4966.304717339575, 5007.799688012484, 5029.094762942669, 4926.704397736138, 4944.752762361885, 4952.678075925062, 4961.305417241589, 4964.379452568429, 3930.5872883347265, 3939.1333906540517, 3946.072672921861, 3955.1101002274404, 3963.900902477447, 3937.6652984496354, 3949.308870947587, 3949.98025009876, 3960.980195099035, 3975.52293724752, 3734.9253014939686, 3882.223555288939, 3914.1193231522966, 3920.4511368408444, 3925.234579257046, 3873.78694171819, 3885.6389223321908, 3909.179072394786, 3912.902177445558, 3942.56631770505, 3481.425564781808, 3483.285926385085, 3488.110531814371, 3489.354469423165, 3493.3013397320638, 4648.651351148644, 4733.219018861918, 4765.904681906342, 4772.76136193189, 4825.0, 4441.622462090726, 4464.575865292792, 4470.687051906368, 4472.0, 4472.575105365017, 5215.0, 5216.66091704038, 5218.347706536683, 5221.530062294411, 5228.37259528859, 3721.4268962661126, 3781.111438811877, 3781.262653782486, 3781.3382658034734, 3793.848246070154, 5051.318072060261, 5219.895602087975, 5279.44565820591, 5427.972860135714, 5453.972730136364, 3697.741158118906, 3736.572161988053, 3748.5126933499014, 3756.192418629953, 3862.0, 3917.275304068756, 3922.4508568800393, 3934.213157368538, 3936.9212615748097, 3937.409388591677, 4097.627294856256, 4399.296112622029, 4401.867943961686, 4408.823647054146, 4426.667999900021, 4849.75751212438, 5087.745612719349, 5141.460146684619, 5174.844754657366, 5195.688258704414, 1343.8723321284463, 1368.50733735855, 1377.2149874571599, 1382.9170249785045, 1385.8683425074603, 913.1462082952461, 944.8677185194078, 957.3681370295571, 973.4354074636693, 974.4835237324229, 4543.432070991126, 4581.564751348683, 4583.289590113538, 4591.127685739699, 4593.127305811885, 5289.259503669489, 5298.364196296392, 5301.575873930076, 5324.0, 5349.0, 4388.802503887333, 4577.885552861138, 4585.738921796533, 4587.17430862448, 4590.97704511482, 2848.458792829356, 2868.3546202104776, 2871.5118429866975, 2877.5971364009056, 2885.192146199068, 5100.872478188075, 5112.463191364853, 5123.001014802077, 5131.56381707559, 5145.897082058338, 5364.570834333244, 5474.288342515527, 5481.205225242317, 5491.890162196813, 5515.972420137954, 5082.415522214993, 5082.669626474268, 5098.872528186751, 5118.744062796845, 5121.20621303691, 5374.731263436891, 5375.59683023767, 5378.977994181093, 5379.327584051994, 5399.4060653327315, 5063.7468126592785, 5213.478652134756, 5220.9477905220465, 5226.11156103471, 5241.213817927342, 4871.95128048715, 4961.1070007397575, 5075.2387141929, 5097.719625420637, 5138.3833939927445, 3778.3576791945984, 3784.6404591563755, 3786.6024067473622, 3787.753796003251, 3814.0464883779055, 5328.147496400712, 5328.547073498641, 5352.464753524617, 5353.089974704231, 5363.678179309254, 4980.775865086152, 5175.508326709108, 5184.559312458483, 5208.609354298518, 5218.399884013387, 5144.254083157996, 5157.277981082577, 5170.844874653766, 5189.584833213409, 5200.6879587224885, 5094.465081166424, 5104.795808167632, 5110.182370820651, 5123.948760512347, 5127.1540195867265, 5054.16606259963, 5227.215917612237, 5259.39516955555, 5263.684178949122, 5265.183896496049, 5111.744412779421, 5122.871928201825, 5123.846284611468, 5140.12617854973, 5143.485651434976], "value": 3943.8696781052845, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.6961443314425, 641.4451499452969, 641.6503005861805, 659.825146336221, 664.8769977554151, 11235.101191904649, 11515.251508651942, 11601.709957251072, 11697.473613687383, 11699.590514332, 11268.380239086848, 11400.087992960563, 11416.086713062956, 11419.657410277685, 11426.657200283984, 646.7897933171714, 795.1094773853292, 813.0852790610563, 825.3933358981144, 830.9626066826977, 816.346922462031, 817.9856977348076, 820.6758330459465, 820.6922404098464, 821.0885916632562, 843.3548335523329, 844.8394804987064, 844.957752112395, 845.3279642684081, 845.5349557743217, 672.4049216443434, 830.7258604660448, 838.7525679924406, 853.6628031927416, 854.2311919272643, 627.2159800249688, 627.8650090230623, 628.2178687534004, 628.2492421556196, 628.2837565175703, 11965.581204657883, 12005.159638825198, 12009.459574319177, 12013.219140755822, 12027.158098933078, 11476.598319058792, 11823.231489953125, 12068.818967715491, 12147.696307592292, 12334.568290109803, 8967.282617390592, 9234.0, 9255.768605784842, 9263.953680231623, 9310.162085412345, 3233.886813961524, 3258.5600943872746, 3260.7065364117107, 3260.7228385587255, 3341.3484370547753, 45130.548694513294, 45400.77299613481, 46827.29759053617, 46882.29676554854, 46938.76530617325, 9164.175224229852, 9538.570764315622, 9852.80294394108, 9963.452010139366, 9964.20286377088, 17468.126593670266, 17664.470065898044, 17750.37873674415, 17804.397604215683, 17820.55448613795, 6238.0, 6243.875122497525, 6296.370362963667, 6301.0, 6330.240371155491, 3269.1500209945584, 3301.7028467437567, 3313.287643156733, 3399.2521645238007, 3402.7447941404494, 2758.241483591988, 2841.6732075811547, 2861.856907154634, 2862.298736809453, 2872.8994485192916, 471.30717844768134, 472.8723244723974, 519.7790938851049, 526.3236740788145, 534.2947309551355, 514.1490832671934, 533.8291746641115, 542.1758926431802, 547.5099785691863, 547.5236544206566, 7295.270472952662, 7304.036231523459, 7484.251574842581, 7626.42801789868, 7803.765887023398, 511.70065511676086, 537.857467771041, 546.0214529740257, 553.8255449533384, 560.6991779072513, 3662.8168591570316, 3698.167912219783, 3748.850045998184, 3751.4935483709896, 3861.5559210690567, 50521.0, 51597.48402516002, 52409.73795131, 52476.0, 52580.0, 45439.091218175454, 45845.5415445848, 47069.76465117653, 47192.764036180284, 47779.28331075037, 42521.787391063466, 42606.36090458646, 42851.78574107109, 43568.564314357085, 43665.78167109144, 7212.170600381023, 7346.742863999734, 7414.147373051952, 7558.58427786455, 7622.961885190539, 29903.401931960805, 30104.548431773102, 30546.389072218877, 30723.385532289674, 30849.383012340077, 36718.531258750416, 39191.216175675756, 39329.0, 39473.80263098666, 40405.0, 9458.858117128111, 9493.522378373036, 9697.369670971364, 9745.707628771148, 9754.609815607297, 10454.864167325299, 10466.693732856753, 10552.261341706315, 10553.788924221626, 10620.893791062299, 7975.521468711896, 8014.599270036591, 8138.186181381814, 8515.27620152294, 8613.48319100856, 8895.0, 9078.137576930181, 9101.726948191565, 9115.863262050942, 9211.355205135576, 8641.524716140673, 8799.47203167812, 8959.104089590988, 8973.730788076367, 8984.730458086267, 8864.160781532364, 9026.819463610822, 9071.637134514809, 9106.544672766468, 9127.817443651222, 8070.112287648237, 8206.876896846432, 8269.131741167092, 8269.751907442786, 8467.95766021166], "value": 5611.875908832565, "unit": "score"}], "name": "dromaeo_css", "value": 6250.14882693497, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 108.0, 113.0, 113.0, 112.0, 101.0, 112.0, 112.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 140.0, 153.0, 186.0, 132.0, 153.0, 162.0, 138.0, 195.0, 136.0], "value": 155.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 162.0, 162.0, 163.0, 162.0, 162.0, 161.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 99.0, 109.0, 74.0, 74.0, 73.0, 110.0, 103.0, 75.0], "value": 86.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 145.0, 95.0, 94.0, 93.0, 140.0, 93.0, 95.0, 139.0], "value": 108.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 66.0, 65.0, 65.0, 84.0, 62.0, 64.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 66.0, 65.0, 64.0, 65.0, 65.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 77.0, 79.0, 79.0, 79.0, 88.0, 80.0, 80.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 131.0, 135.0, 139.0, 130.0, 131.0, 131.0, 130.0, 163.0, 139.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 178.0, 172.0, 174.0, 172.0, 181.0, 176.0, 172.0, 177.0, 169.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 72.0, 71.0, 71.0, 72.0, 71.0, 71.0, 82.0], "value": 72.8, "unit": "score"}], "name": "kraken", "value": 1576.2, "alertThreshold": 2.0}]} 22:16:10 INFO - Return code: 0 22:16:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:16:10 ERROR - # TBPL SUCCESS # 22:16:10 INFO - Running post-action listener: _resource_record_post_action 22:16:10 INFO - Running post-run listener: _resource_record_post_run 22:16:11 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 346636288; Read time: 20; Write time: 186892 22:16:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 68546560; Read time: 0; Write time: 30548 22:16:12 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278089728; Read time: 20; Write time: 156344 22:16:12 INFO - Running post-run listener: _upload_blobber_files 22:16:12 INFO - Blob upload gear active. 22:16:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:16:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:16:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:16:12 INFO - (blobuploader) - INFO - Open directory for files ... 22:16:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:16:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:16:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:13 INFO - (blobuploader) - INFO - Done attempting. 22:16:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:16:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:16:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:14 INFO - (blobuploader) - INFO - Done attempting. 22:16:14 INFO - (blobuploader) - INFO - Iteration through files over. 22:16:14 INFO - Return code: 0 22:16:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:16:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:16:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ebaec8a1c77f570cc77d58b0b337c42e928a34e99a1be86c15da9ad6740084ece8a8b7c573cac33f79f3e181c6857bd6b68e7ff9399128d5c579d84038a65ba6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26a60bb42537c2c8fb9edec29713a270388b88bc18fbb3afafda935e169608cdede50d13e0a2d4f12196485cb40885f3e25befccbc491cf422e9d007b1d2d1fb"} 22:16:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:16:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:16:14 INFO - Contents: 22:16:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ebaec8a1c77f570cc77d58b0b337c42e928a34e99a1be86c15da9ad6740084ece8a8b7c573cac33f79f3e181c6857bd6b68e7ff9399128d5c579d84038a65ba6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26a60bb42537c2c8fb9edec29713a270388b88bc18fbb3afafda935e169608cdede50d13e0a2d4f12196485cb40885f3e25befccbc491cf422e9d007b1d2d1fb"} 22:16:14 INFO - Running post-run listener: copy_logs_to_upload_dir 22:16:14 INFO - Copying logs to upload dir... 22:16:14 INFO - mkdir: /builds/slave/test/build/upload/logs 22:16:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.425390 ========= master_lag: 681.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 32 mins, 3 secs) (at 2016-04-19 22:27:34.884045) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 22:27:34.887530) ========= 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=0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480 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/ebaec8a1c77f570cc77d58b0b337c42e928a34e99a1be86c15da9ad6740084ece8a8b7c573cac33f79f3e181c6857bd6b68e7ff9399128d5c579d84038a65ba6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26a60bb42537c2c8fb9edec29713a270388b88bc18fbb3afafda935e169608cdede50d13e0a2d4f12196485cb40885f3e25befccbc491cf422e9d007b1d2d1fb"} build_url:https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ebaec8a1c77f570cc77d58b0b337c42e928a34e99a1be86c15da9ad6740084ece8a8b7c573cac33f79f3e181c6857bd6b68e7ff9399128d5c579d84038a65ba6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26a60bb42537c2c8fb9edec29713a270388b88bc18fbb3afafda935e169608cdede50d13e0a2d4f12196485cb40885f3e25befccbc491cf422e9d007b1d2d1fb"}' ========= master_lag: 0.84 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 22:27:35.742555) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 13 secs) (at 2016-04-19 22:27:35.742866) ========= 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=0333a256a5e4f052382dd180000001b1-1461127925.643184-1560546480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004251 ========= master_lag: 13.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 13 secs) (at 2016-04-19 22:27:48.805299) ========= ========= Started reboot skipped (results: 3, elapsed: 5 secs) (at 2016-04-19 22:27:48.805574) ========= ========= Finished reboot skipped (results: 3, elapsed: 5 secs) (at 2016-04-19 22:27:54.459240) ========= ========= Total master_lag: 695.29 =========