builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1461636100.85 results: success (0) buildid: 20160425172307 builduid: a2f4e19eb2c4428796762a49a639271d revision: 8171bad3ccc5629b4cd3a70b075117d711644982 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 19:01:40.855117) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 19:01:40.855557) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 19:01:40.855847) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 19:01:40.881020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 19:01:40.881280) ========= 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=8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 19:01:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.4M=0s 2016-04-25 19:01:41 (88.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.398656 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 19:01:41.293423) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 19:01:41.293750) ========= 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=8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014894 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 19:01:41.343437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 19:01:41.343805) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8171bad3ccc5629b4cd3a70b075117d711644982 --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 8171bad3ccc5629b4cd3a70b075117d711644982 --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=8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 19:01:41,742 truncating revision to first 12 chars 2016-04-25 19:01:41,742 Setting DEBUG logging. 2016-04-25 19:01:41,743 attempt 1/10 2016-04-25 19:01:41,743 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8171bad3ccc5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 19:01:42,680 unpacking tar archive at: fx-team-8171bad3ccc5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.248059 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 19:01:42.604713) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 19:01:42.605039) ========= script_repo_revision: 8171bad3ccc5629b4cd3a70b075117d711644982 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 19:01:42.605437) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 19:01:42.605713) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 19:01:42.613222) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-25 19:01:42.613524) ========= /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=8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:01:43 INFO - MultiFileLogger online at 20160425 19:01:43 in /builds/slave/test 19:01:43 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 19:01:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:01:43 INFO - {'append_to_log': False, 19:01:43 INFO - 'base_work_dir': '/builds/slave/test', 19:01:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:01:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:01:43 INFO - 'branch': 'Fx-Team-Non-PGO', 19:01:43 INFO - 'buildbot_json_path': 'buildprops.json', 19:01:43 INFO - 'config_files': ('talos/linux_config.py',), 19:01:43 INFO - 'default_actions': ('clobber', 19:01:43 INFO - 'read-buildbot-config', 19:01:43 INFO - 'download-and-extract', 19:01:43 INFO - 'populate-webroot', 19:01:43 INFO - 'create-virtualenv', 19:01:43 INFO - 'install', 19:01:43 INFO - 'run-tests'), 19:01:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:01:43 INFO - 'download_minidump_stackwalk': True, 19:01:43 INFO - 'download_symbols': 'ondemand', 19:01:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:01:43 INFO - 'tooltool.py': '/tools/tooltool.py', 19:01:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:01:43 INFO - '/tools/misc-python/virtualenv.py')}, 19:01:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:01:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:01:43 INFO - 'installer_path': 'installer.exe', 19:01:43 INFO - 'log_level': 'info', 19:01:43 INFO - 'log_name': 'talos', 19:01:43 INFO - 'log_to_console': True, 19:01:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:01:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:01:43 INFO - 'opt_config_files': (), 19:01:43 INFO - 'pip_index': False, 19:01:43 INFO - 'sps_profile': False, 19:01:43 INFO - 'sps_profile_interval': 0, 19:01:43 INFO - 'suite': 'dromaeojs', 19:01:43 INFO - 'system_bits': '32', 19:01:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:01:43 INFO - 'title': 'talos-linux64-ix-001', 19:01:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:01:43 INFO - 'use_talos_json': True, 19:01:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:01:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:01:43 INFO - 'work_dir': 'build'} 19:01:43 INFO - ##### 19:01:43 INFO - ##### Running clobber step. 19:01:43 INFO - ##### 19:01:43 INFO - Running pre-action listener: _resource_record_pre_action 19:01:43 INFO - Running main action method: clobber 19:01:43 INFO - rmtree: /builds/slave/test/build 19:01:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:01:43 INFO - Running post-action listener: _resource_record_post_action 19:01:43 INFO - ##### 19:01:43 INFO - ##### Running read-buildbot-config step. 19:01:43 INFO - ##### 19:01:43 INFO - Running pre-action listener: _resource_record_pre_action 19:01:43 INFO - Running main action method: read_buildbot_config 19:01:43 INFO - Using buildbot properties: 19:01:43 INFO - { 19:01:43 INFO - "project": "", 19:01:43 INFO - "product": "firefox", 19:01:43 INFO - "script_repo_revision": "production", 19:01:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:01:43 INFO - "repository": "", 19:01:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:01:43 INFO - "buildid": "20160425172307", 19:01:43 INFO - "pgo_build": "False", 19:01:43 INFO - "basedir": "/builds/slave/test", 19:01:43 INFO - "buildnumber": 2887, 19:01:43 INFO - "slavename": "talos-linux64-ix-001", 19:01:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:01:43 INFO - "platform": "ubuntu64_hw", 19:01:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:01:43 INFO - "branch": "fx-team", 19:01:43 INFO - "repo_path": "integration/fx-team", 19:01:43 INFO - "revision": "8171bad3ccc5629b4cd3a70b075117d711644982", 19:01:43 INFO - "stage_platform": "linux64", 19:01:43 INFO - "builduid": "a2f4e19eb2c4428796762a49a639271d", 19:01:43 INFO - "slavebuilddir": "test" 19:01:43 INFO - } 19:01:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:01:43 INFO - Running post-action listener: _resource_record_post_action 19:01:43 INFO - ##### 19:01:43 INFO - ##### Running download-and-extract step. 19:01:43 INFO - ##### 19:01:43 INFO - Running pre-action listener: _resource_record_pre_action 19:01:43 INFO - Running main action method: download_and_extract 19:01:43 INFO - mkdir: /builds/slave/test/build/tests 19:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:43 INFO - https://queue.taskcluster.net/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:01:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:01:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:01:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:01:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:01:44 INFO - Downloaded 1361 bytes. 19:01:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:01:44 INFO - Using the following test package requirements: 19:01:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:01:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:01:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:01:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:44 INFO - u'jsshell-linux-x86_64.zip'], 19:01:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:01:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:01:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:01:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:01:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:01:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:01:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:01:44 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')]} 19:01:44 INFO - https://queue.taskcluster.net/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:01:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:01:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:01:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:01:45 INFO - Downloaded 22290132 bytes. 19:01:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:01:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:01:47 INFO - Return code: 0 19:01:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:01:47 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')]} 19:01:47 INFO - https://queue.taskcluster.net/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:01:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:01:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:01:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:01:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:01:48 INFO - Downloaded 22290132 bytes. 19:01:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:01:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:01:50 INFO - Return code: 0 19:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:50 INFO - https://queue.taskcluster.net/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:01:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:01:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:01:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:01:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:01:51 INFO - Downloaded 10840145 bytes. 19:01:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:01:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:01:51 INFO - Return code: 0 19:01: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')]} 19:01:51 INFO - https://queue.taskcluster.net/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:01:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:01:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:01:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:01:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:01:52 INFO - Downloaded 54815891 bytes. 19:01:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:01:52 INFO - mkdir: /builds/slave/test/properties 19:01:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:01:52 INFO - Writing to file /builds/slave/test/properties/build_url 19:01:52 INFO - Contents: 19:01:52 INFO - build_url:https://queue.taskcluster.net/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:01:54 INFO - Running post-action listener: _resource_record_post_action 19:01:54 INFO - Running post-action listener: set_extra_try_arguments 19:01:54 INFO - ##### 19:01:54 INFO - ##### Running populate-webroot step. 19:01:54 INFO - ##### 19:01:54 INFO - Running pre-action listener: _resource_record_pre_action 19:01:54 INFO - Running main action method: populate_webroot 19:01:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:01:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:01:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:01:54 INFO - '--tppagecycles', 19:01:54 INFO - '7'], 19:01:54 INFO - 'tests': ['tsvgm']}}, 19:01:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:01:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:01:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:01:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:01:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:01:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:01:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:54 INFO - 'talos_options': ['--disable-e10s'], 19:01:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:01:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:01:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:54 INFO - 'talos_options': ['--disable-e10s'], 19:01:54 INFO - 'tests': ['damp', 'tps']}, 19:01:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:54 INFO - 'tests': ['damp', 'tps']}, 19:01:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:01:54 INFO - 'tests': ['dromaeo_dom']}, 19:01:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:01:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:01:54 INFO - 'tests': ['a11yr', 19:01:54 INFO - 'ts_paint', 19:01:54 INFO - 'tpaint', 19:01:54 INFO - 'sessionrestore', 19:01:54 INFO - 'sessionrestore_no_auto_restore', 19:01:54 INFO - 'tabpaint']}, 19:01:54 INFO - 'other-e10s': {'tests': ['a11yr', 19:01:54 INFO - 'ts_paint', 19:01:54 INFO - 'tpaint', 19:01:54 INFO - 'sessionrestore', 19:01:54 INFO - 'sessionrestore_no_auto_restore', 19:01:54 INFO - 'tabpaint']}, 19:01:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:01:54 INFO - 'ts_paint', 19:01:54 INFO - 'tpaint', 19:01:54 INFO - 'sessionrestore', 19:01:54 INFO - 'sessionrestore_no_auto_restore', 19:01:54 INFO - 'tabpaint']}, 19:01:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:01:54 INFO - 'ts_paint', 19:01:54 INFO - 'tpaint', 19:01:54 INFO - 'sessionrestore', 19:01:54 INFO - 'sessionrestore_no_auto_restore', 19:01:54 INFO - 'tabpaint']}, 19:01:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:01:54 INFO - 'tests': ['a11yr', 19:01:54 INFO - 'ts_paint', 19:01:54 INFO - 'tpaint', 19:01:54 INFO - 'sessionrestore', 19:01:54 INFO - 'sessionrestore_no_auto_restore', 19:01:54 INFO - 'tabpaint']}, 19:01:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:01:54 INFO - 'tests': ['a11yr', 19:01:54 INFO - 'ts_paint', 19:01:54 INFO - 'tpaint', 19:01:54 INFO - 'sessionrestore', 19:01:54 INFO - 'sessionrestore_no_auto_restore', 19:01:54 INFO - 'tabpaint']}, 19:01:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:01:54 INFO - 'tests': ['tsvgx', 19:01:54 INFO - 'tsvgr_opacity', 19:01:54 INFO - 'tart', 19:01:54 INFO - 'tscrollx', 19:01:54 INFO - 'cart']}, 19:01:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:01:54 INFO - 'tsvgr_opacity', 19:01:54 INFO - 'tart', 19:01:54 INFO - 'tscrollx', 19:01:54 INFO - 'cart']}, 19:01:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:54 INFO - 'talos_options': ['--disable-e10s'], 19:01:54 INFO - 'tests': ['tp5o']}, 19:01:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:54 INFO - 'tests': ['tp5o']}, 19:01:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:54 INFO - 'talos_options': ['--disable-e10s', 19:01:54 INFO - '--xperf_path', 19:01:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:01:54 INFO - 'tests': ['tp5n']}, 19:01:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:54 INFO - 'talos_options': ['--xperf_path', 19:01:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:01:54 INFO - 'tests': ['tp5n']}}, 19:01:54 INFO - 'talos.zip': {'path': '', 19:01:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:01:54 INFO - Running post-action listener: _resource_record_post_action 19:01:54 INFO - ##### 19:01:54 INFO - ##### Running create-virtualenv step. 19:01:54 INFO - ##### 19:01:54 INFO - Running pre-action listener: _resource_record_pre_action 19:01:54 INFO - Running main action method: create_virtualenv 19:01:54 INFO - Creating virtualenv /builds/slave/test/build/venv 19:01:54 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 19:01:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:01:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:01:54 INFO - Using real prefix '/usr' 19:01:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:01:54 INFO - Installing distribute.............................................................................................................................................................................................done. 19:01:56 INFO - Installing pip.................done. 19:01:56 INFO - Return code: 0 19:01:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:01: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')]} 19:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01: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')]} 19:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f792976df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90410>, '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 0x1e91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e917a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', '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 19:01: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', 'pip>=1.5'] in /builds/slave/test/build 19:01: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 pip>=1.5 19:01:56 INFO - Using env: {'DISPLAY': ':0', 19:01:56 INFO - 'HOME': '/home/cltbld', 19:01:56 INFO - 'LANG': 'en_US.UTF-8', 19:01:56 INFO - 'LANGUAGE': 'en_US:en', 19:01:56 INFO - 'LOGNAME': 'cltbld', 19:01:56 INFO - 'MAIL': '/var/mail/cltbld', 19:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:56 INFO - 'MOZ_NO_REMOTE': '1', 19:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:56 INFO - 'NO_EM_RESTART': '1', 19:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:56 INFO - 'PWD': '/builds/slave/test', 19:01:56 INFO - 'SHELL': '/bin/bash', 19:01:56 INFO - 'SHLVL': '1', 19:01:56 INFO - 'TERM': 'linux', 19:01:56 INFO - 'TMOUT': '86400', 19:01:56 INFO - 'USER': 'cltbld', 19:01:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', 19:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:56 INFO - '_': '/tools/buildbot/bin/python'} 19:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:56 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 19:01:56 INFO - Cleaning up... 19:01:56 INFO - Return code: 0 19:01:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:01: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')]} 19:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01: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')]} 19:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01: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', '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 0x7f792976df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90410>, '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 0x1e91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e917a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', '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 19:01: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', 'psutil>=0.7.1'] in /builds/slave/test/build 19:01: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 psutil>=0.7.1 19:01:56 INFO - Using env: {'DISPLAY': ':0', 19:01:56 INFO - 'HOME': '/home/cltbld', 19:01:56 INFO - 'LANG': 'en_US.UTF-8', 19:01:56 INFO - 'LANGUAGE': 'en_US:en', 19:01:56 INFO - 'LOGNAME': 'cltbld', 19:01:56 INFO - 'MAIL': '/var/mail/cltbld', 19:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:56 INFO - 'MOZ_NO_REMOTE': '1', 19:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:56 INFO - 'NO_EM_RESTART': '1', 19:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:56 INFO - 'PWD': '/builds/slave/test', 19:01:56 INFO - 'SHELL': '/bin/bash', 19:01:56 INFO - 'SHLVL': '1', 19:01:56 INFO - 'TERM': 'linux', 19:01:56 INFO - 'TMOUT': '86400', 19:01:56 INFO - 'USER': 'cltbld', 19:01:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', 19:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:56 INFO - '_': '/tools/buildbot/bin/python'} 19:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:57 INFO - Downloading/unpacking psutil>=0.7.1 19:01:57 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 19:01:57 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 19:01:57 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 19:01:57 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 19:01:57 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 19:01:57 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 19:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:01:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:01:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:01:59 INFO - Installing collected packages: psutil 19:01:59 INFO - Running setup.py install for psutil 19:01:59 INFO - building 'psutil._psutil_linux' extension 19:01:59 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 19:01:59 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 19:01:59 INFO - building 'psutil._psutil_posix' extension 19:01:59 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 19:01:59 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 19:01:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:01:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:01:59 INFO - Successfully installed psutil 19:01:59 INFO - Cleaning up... 19:01:59 INFO - Return code: 0 19:01:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:01: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')]} 19:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01: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')]} 19:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:59 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 0x7f792976df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90410>, '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 0x1e91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e917a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', '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 19:01:59 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 19:01:59 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 19:01:59 INFO - Using env: {'DISPLAY': ':0', 19:01:59 INFO - 'HOME': '/home/cltbld', 19:01:59 INFO - 'LANG': 'en_US.UTF-8', 19:01:59 INFO - 'LANGUAGE': 'en_US:en', 19:01:59 INFO - 'LOGNAME': 'cltbld', 19:01:59 INFO - 'MAIL': '/var/mail/cltbld', 19:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:59 INFO - 'MOZ_NO_REMOTE': '1', 19:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:59 INFO - 'NO_EM_RESTART': '1', 19:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:59 INFO - 'PWD': '/builds/slave/test', 19:01:59 INFO - 'SHELL': '/bin/bash', 19:01:59 INFO - 'SHLVL': '1', 19:01:59 INFO - 'TERM': 'linux', 19:01:59 INFO - 'TMOUT': '86400', 19:01:59 INFO - 'USER': 'cltbld', 19:01:59 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', 19:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:59 INFO - '_': '/tools/buildbot/bin/python'} 19:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:01: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 19:01: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 19:01: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 19:01: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 19:01: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 19:01: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 19:02:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:02:01 INFO - Installing collected packages: mozsystemmonitor 19:02:01 INFO - Running setup.py install for mozsystemmonitor 19:02:01 INFO - Successfully installed mozsystemmonitor 19:02:01 INFO - Cleaning up... 19:02:01 INFO - Return code: 0 19:02:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f792976df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90410>, '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 0x1e91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e917a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', '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 19:02:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:02:01 INFO - Using env: {'DISPLAY': ':0', 19:02:01 INFO - 'HOME': '/home/cltbld', 19:02:01 INFO - 'LANG': 'en_US.UTF-8', 19:02:01 INFO - 'LANGUAGE': 'en_US:en', 19:02:01 INFO - 'LOGNAME': 'cltbld', 19:02:01 INFO - 'MAIL': '/var/mail/cltbld', 19:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:01 INFO - 'MOZ_NO_REMOTE': '1', 19:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:01 INFO - 'NO_EM_RESTART': '1', 19:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:01 INFO - 'PWD': '/builds/slave/test', 19:02:01 INFO - 'SHELL': '/bin/bash', 19:02:01 INFO - 'SHLVL': '1', 19:02:01 INFO - 'TERM': 'linux', 19:02:01 INFO - 'TMOUT': '86400', 19:02:02 INFO - 'USER': 'cltbld', 19:02:02 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', 19:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:02 INFO - '_': '/tools/buildbot/bin/python'} 19:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:02 INFO - Downloading/unpacking blobuploader==1.2.4 19:02:02 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 19:02:02 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 19:02:02 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 19:02:02 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 19:02:02 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 19:02:02 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 19:02:04 INFO - Downloading blobuploader-1.2.4.tar.gz 19:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:02:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:02:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02:04 INFO - Downloading docopt-0.6.1.tar.gz 19:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:02:04 INFO - Installing collected packages: blobuploader, requests, docopt 19:02:04 INFO - Running setup.py install for blobuploader 19:02:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:02:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:02:04 INFO - Running setup.py install for requests 19:02:05 INFO - Running setup.py install for docopt 19:02:05 INFO - Successfully installed blobuploader requests docopt 19:02:05 INFO - Cleaning up... 19:02:05 INFO - Return code: 0 19:02:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:05 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 0x7f792976df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90410>, '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 0x1e91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e917a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', '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 19:02:05 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 19:02:05 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 19:02:05 INFO - Using env: {'DISPLAY': ':0', 19:02:05 INFO - 'HOME': '/home/cltbld', 19:02:05 INFO - 'LANG': 'en_US.UTF-8', 19:02:05 INFO - 'LANGUAGE': 'en_US:en', 19:02:05 INFO - 'LOGNAME': 'cltbld', 19:02:05 INFO - 'MAIL': '/var/mail/cltbld', 19:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:05 INFO - 'MOZ_NO_REMOTE': '1', 19:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:05 INFO - 'NO_EM_RESTART': '1', 19:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:05 INFO - 'PWD': '/builds/slave/test', 19:02:05 INFO - 'SHELL': '/bin/bash', 19:02:05 INFO - 'SHLVL': '1', 19:02:05 INFO - 'TERM': 'linux', 19:02:05 INFO - 'TMOUT': '86400', 19:02:05 INFO - 'USER': 'cltbld', 19:02:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', 19:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:05 INFO - '_': '/tools/buildbot/bin/python'} 19:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:02:05 INFO - Running setup.py (path:/tmp/pip-N4o8iP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:02:05 INFO - Running setup.py (path:/tmp/pip-k06gkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:02:05 INFO - Running setup.py (path:/tmp/pip-BWfQHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:02:05 INFO - Running setup.py (path:/tmp/pip-DHg6Iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:02:05 INFO - Running setup.py (path:/tmp/pip-DSVEI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:02:05 INFO - Running setup.py (path:/tmp/pip-jMsnhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:02:06 INFO - Running setup.py (path:/tmp/pip-nCvKqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:02:06 INFO - Running setup.py (path:/tmp/pip-q650oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:02:06 INFO - Running setup.py (path:/tmp/pip-HUPANn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:02:06 INFO - Running setup.py (path:/tmp/pip-4CjqZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:02:06 INFO - Running setup.py (path:/tmp/pip-BTsUzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:02:06 INFO - Running setup.py (path:/tmp/pip-AnQqTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:02:06 INFO - Running setup.py (path:/tmp/pip-PawgO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:02:06 INFO - Running setup.py (path:/tmp/pip-LxC8Kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:06 INFO - Running setup.py (path:/tmp/pip-HRcMSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:02:06 INFO - Running setup.py (path:/tmp/pip-NlD1z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:02:06 INFO - Running setup.py (path:/tmp/pip-P4L3A9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:02:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:02:06 INFO - Running setup.py install for manifestparser 19:02:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:02:06 INFO - Running setup.py install for mozcrash 19:02:07 INFO - Running setup.py install for mozdebug 19:02:07 INFO - Running setup.py install for mozdevice 19:02:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:02:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:02:07 INFO - Running setup.py install for mozfile 19:02:07 INFO - Running setup.py install for mozhttpd 19:02:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:02:07 INFO - Running setup.py install for mozinfo 19:02:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:02:07 INFO - Running setup.py install for mozInstall 19:02:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:02:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:02:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:02:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:02:07 INFO - Running setup.py install for mozleak 19:02:07 INFO - Running setup.py install for mozlog 19:02:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:02:07 INFO - Running setup.py install for moznetwork 19:02:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:02:07 INFO - Running setup.py install for mozprocess 19:02:08 INFO - Running setup.py install for mozprofile 19:02:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:02:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:02:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:02:08 INFO - Running setup.py install for mozrunner 19:02:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:02:08 INFO - Running setup.py install for mozscreenshot 19:02:08 INFO - Running setup.py install for moztest 19:02:08 INFO - Running setup.py install for mozversion 19:02:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:02:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:02:08 INFO - Cleaning up... 19:02:08 INFO - Return code: 0 19:02:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02:08 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')]} 19:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:08 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')]} 19:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:08 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 0x7f792976df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90410>, '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 0x1e91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e917a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', '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 19:02:08 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 19:02:08 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 19:02:08 INFO - Using env: {'DISPLAY': ':0', 19:02:08 INFO - 'HOME': '/home/cltbld', 19:02:08 INFO - 'LANG': 'en_US.UTF-8', 19:02:08 INFO - 'LANGUAGE': 'en_US:en', 19:02:08 INFO - 'LOGNAME': 'cltbld', 19:02:08 INFO - 'MAIL': '/var/mail/cltbld', 19:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:08 INFO - 'MOZ_NO_REMOTE': '1', 19:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:08 INFO - 'NO_EM_RESTART': '1', 19:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:08 INFO - 'PWD': '/builds/slave/test', 19:02:08 INFO - 'SHELL': '/bin/bash', 19:02:08 INFO - 'SHLVL': '1', 19:02:08 INFO - 'TERM': 'linux', 19:02:08 INFO - 'TMOUT': '86400', 19:02:08 INFO - 'USER': 'cltbld', 19:02:08 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', 19:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:08 INFO - '_': '/tools/buildbot/bin/python'} 19:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:02:08 INFO - Running setup.py (path:/tmp/pip-npPxaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:02:08 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)) 19:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:02:08 INFO - Running setup.py (path:/tmp/pip-MCNCNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:02:09 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)) 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:02:09 INFO - Running setup.py (path:/tmp/pip-b4Rn6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:02:09 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)) 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:02:09 INFO - Running setup.py (path:/tmp/pip-ssxhMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:02:09 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)) 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:02:09 INFO - Running setup.py (path:/tmp/pip-fGB3Xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:02:09 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)) 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:02:09 INFO - Running setup.py (path:/tmp/pip-9ZfcLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:02:09 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)) 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:02:09 INFO - Running setup.py (path:/tmp/pip-4tIkUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:02:09 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)) 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:02:09 INFO - Running setup.py (path:/tmp/pip-BnLBkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:02:09 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)) 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:02:09 INFO - Running setup.py (path:/tmp/pip-jfwz6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:02:09 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)) 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:02:09 INFO - Running setup.py (path:/tmp/pip-ynIteT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:02:09 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)) 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:02:09 INFO - Running setup.py (path:/tmp/pip-hXZXHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:02:09 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)) 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:02:09 INFO - Running setup.py (path:/tmp/pip-wKiRX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:02:09 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)) 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:02:09 INFO - Running setup.py (path:/tmp/pip-uCiRk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:02:09 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)) 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:02:09 INFO - Running setup.py (path:/tmp/pip-f1mY16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:02:09 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)) 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:09 INFO - Running setup.py (path:/tmp/pip-QDtGtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:09 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)) 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:02:09 INFO - Running setup.py (path:/tmp/pip-QMLdBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:02:10 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)) 19:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:02:10 INFO - Running setup.py (path:/tmp/pip-bpZB80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:02:10 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)) 19:02:10 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)) 19:02:10 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)) 19:02:10 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)) 19:02:10 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)) 19:02:10 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)) 19:02:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:11 INFO - Downloading blessings-1.6.tar.gz 19:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:02:12 INFO - Installing collected packages: blessings 19:02:12 INFO - Running setup.py install for blessings 19:02:12 INFO - Successfully installed blessings 19:02:12 INFO - Cleaning up... 19:02:12 INFO - Return code: 0 19:02:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:02:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:02:12 INFO - Reading from file tmpfile_stdout 19:02:12 INFO - Current package versions: 19:02:12 INFO - argparse == 1.2.1 19:02:12 INFO - blessings == 1.6 19:02:12 INFO - blobuploader == 1.2.4 19:02:12 INFO - docopt == 0.6.1 19:02:12 INFO - manifestparser == 1.1 19:02:12 INFO - mozInstall == 1.12 19:02:12 INFO - mozcrash == 0.17 19:02:12 INFO - mozdebug == 0.1 19:02:12 INFO - mozdevice == 0.48 19:02:12 INFO - mozfile == 1.2 19:02:12 INFO - mozhttpd == 0.7 19:02:12 INFO - mozinfo == 0.9 19:02:12 INFO - mozleak == 0.1 19:02:12 INFO - mozlog == 3.1 19:02:12 INFO - moznetwork == 0.27 19:02:12 INFO - mozprocess == 0.22 19:02:12 INFO - mozprofile == 0.28 19:02:12 INFO - mozrunner == 6.11 19:02:12 INFO - mozscreenshot == 0.1 19:02:12 INFO - mozsystemmonitor == 0.0 19:02:12 INFO - moztest == 0.7 19:02:12 INFO - mozversion == 1.4 19:02:12 INFO - psutil == 3.1.1 19:02:12 INFO - requests == 1.2.3 19:02:12 INFO - wsgiref == 0.1.2 19:02:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:12 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 0x7f792976df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90410>, '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 0x1e91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e917a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', '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 19:02:12 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 19:02:12 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 19:02:12 INFO - Using env: {'DISPLAY': ':0', 19:02:12 INFO - 'HOME': '/home/cltbld', 19:02:12 INFO - 'LANG': 'en_US.UTF-8', 19:02:12 INFO - 'LANGUAGE': 'en_US:en', 19:02:12 INFO - 'LOGNAME': 'cltbld', 19:02:12 INFO - 'MAIL': '/var/mail/cltbld', 19:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:12 INFO - 'MOZ_NO_REMOTE': '1', 19:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:12 INFO - 'NO_EM_RESTART': '1', 19:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:12 INFO - 'PWD': '/builds/slave/test', 19:02:12 INFO - 'SHELL': '/bin/bash', 19:02:12 INFO - 'SHLVL': '1', 19:02:12 INFO - 'TERM': 'linux', 19:02:12 INFO - 'TMOUT': '86400', 19:02:12 INFO - 'USER': 'cltbld', 19:02:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', 19:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:12 INFO - '_': '/tools/buildbot/bin/python'} 19:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:12 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)) 19:02:12 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)) 19:02:12 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)) 19:02:12 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)) 19:02:12 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)) 19:02:12 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)) 19:02:12 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)) 19:02:12 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)) 19:02:12 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)) 19:02:12 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)) 19:02:12 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)) 19:02:12 INFO - Cleaning up... 19:02:12 INFO - Return code: 0 19:02:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:12 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 0x7f792976df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90410>, '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 0x1e91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e917a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', '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 19:02:12 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 19:02:12 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 19:02:12 INFO - Using env: {'DISPLAY': ':0', 19:02:12 INFO - 'HOME': '/home/cltbld', 19:02:12 INFO - 'LANG': 'en_US.UTF-8', 19:02:12 INFO - 'LANGUAGE': 'en_US:en', 19:02:12 INFO - 'LOGNAME': 'cltbld', 19:02:12 INFO - 'MAIL': '/var/mail/cltbld', 19:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:12 INFO - 'MOZ_NO_REMOTE': '1', 19:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:12 INFO - 'NO_EM_RESTART': '1', 19:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:12 INFO - 'PWD': '/builds/slave/test', 19:02:12 INFO - 'SHELL': '/bin/bash', 19:02:12 INFO - 'SHLVL': '1', 19:02:12 INFO - 'TERM': 'linux', 19:02:12 INFO - 'TMOUT': '86400', 19:02:12 INFO - 'USER': 'cltbld', 19:02:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', 19:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:12 INFO - '_': '/tools/buildbot/bin/python'} 19:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:12 INFO - Downloading/unpacking jsonschema 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:02:14 INFO - Downloading/unpacking functools32 (from jsonschema) 19:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:14 INFO - Downloading functools32-3.2.3-2.tar.gz 19:02:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:02:15 INFO - warning: no files found matching '*.txt' 19:02:15 INFO - no previously-included directories found matching 'build' 19:02:15 INFO - no previously-included directories found matching 'dist' 19:02:15 INFO - no previously-included directories found matching '.git*' 19:02:15 INFO - Installing collected packages: jsonschema, functools32 19:02:15 INFO - Running setup.py install for functools32 19:02:15 INFO - warning: no files found matching '*.txt' 19:02:15 INFO - no previously-included directories found matching 'build' 19:02:15 INFO - no previously-included directories found matching 'dist' 19:02:15 INFO - no previously-included directories found matching '.git*' 19:02:15 INFO - Successfully installed jsonschema functools32 19:02:15 INFO - Cleaning up... 19:02:15 INFO - Return code: 0 19:02:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:15 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 0x7f792976df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90410>, '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 0x1e91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e917a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', '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 19:02:15 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 19:02:15 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 19:02:15 INFO - Using env: {'DISPLAY': ':0', 19:02:15 INFO - 'HOME': '/home/cltbld', 19:02:15 INFO - 'LANG': 'en_US.UTF-8', 19:02:15 INFO - 'LANGUAGE': 'en_US:en', 19:02:15 INFO - 'LOGNAME': 'cltbld', 19:02:15 INFO - 'MAIL': '/var/mail/cltbld', 19:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:15 INFO - 'MOZ_NO_REMOTE': '1', 19:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:15 INFO - 'NO_EM_RESTART': '1', 19:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:15 INFO - 'PWD': '/builds/slave/test', 19:02:15 INFO - 'SHELL': '/bin/bash', 19:02:15 INFO - 'SHLVL': '1', 19:02:15 INFO - 'TERM': 'linux', 19:02:15 INFO - 'TMOUT': '86400', 19:02:15 INFO - 'USER': 'cltbld', 19:02:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', 19:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:15 INFO - '_': '/tools/buildbot/bin/python'} 19:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:15 INFO - Downloading/unpacking flake8 19:02:15 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 19:02:15 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 19:02:15 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 19:02:15 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 19:02:15 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 19:02:15 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 19:02:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:02:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:02:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:02:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:02:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:02:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:02:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:02:18 INFO - no previously-included directories found matching 'docs/_build' 19:02:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:02:18 INFO - Running setup.py install for pep8 19:02:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:02:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:02:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:02:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:02:18 INFO - no previously-included directories found matching 'docs/_build' 19:02:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:02:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:02:18 INFO - Cleaning up... 19:02:18 INFO - Return code: 0 19:02:18 INFO - Running post-action listener: _resource_record_post_action 19:02:18 INFO - Running post-action listener: _start_resource_monitoring 19:02:18 INFO - Starting resource monitoring. 19:02:18 INFO - ##### 19:02:18 INFO - ##### Running install step. 19:02:18 INFO - ##### 19:02:18 INFO - Running pre-action listener: _resource_record_pre_action 19:02:18 INFO - Running main action method: install 19:02:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:02:18 INFO - Reading from file tmpfile_stdout 19:02:18 INFO - Detecting whether we're running mozinstall >=1.0... 19:02:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:02:18 INFO - Reading from file tmpfile_stdout 19:02:18 INFO - Output received: 19:02:18 INFO - Usage: mozinstall [options] installer 19:02:18 INFO - Options: 19:02:18 INFO - -h, --help show this help message and exit 19:02:18 INFO - -d DEST, --destination=DEST 19:02:18 INFO - Directory to install application into. [default: 19:02:18 INFO - "/builds/slave/test"] 19:02:18 INFO - --app=APP Application being installed. [default: firefox] 19:02:18 INFO - mkdir: /builds/slave/test/build/application 19:02:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:02:34 INFO - Reading from file tmpfile_stdout 19:02:34 INFO - Output received: 19:02:34 INFO - /builds/slave/test/build/application/firefox/firefox 19:02:34 INFO - Running post-action listener: _resource_record_post_action 19:02:34 INFO - ##### 19:02:34 INFO - ##### Running run-tests step. 19:02:34 INFO - ##### 19:02:34 INFO - Running pre-action listener: _resource_record_pre_action 19:02:34 INFO - Running main action method: run_tests 19:02:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:02:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:02:34 INFO - Python 2.7.3 19:02:34 INFO - Return code: 0 19:02:34 INFO - grabbing minidump binary from tooltool 19:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:34 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 0x1e90410>, '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 0x1e91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e917a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:02:34 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 19:02:34 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 19:02:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:02:34 INFO - Return code: 0 19:02:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:02:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:02:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:02:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:02:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:02:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:02:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:02:35 INFO - Return code: 0 19:02:35 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/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 19:02:35 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/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 19:02:35 INFO - Using env: {'DISPLAY': ':0', 19:02:35 INFO - 'HOME': '/home/cltbld', 19:02:35 INFO - 'LANG': 'en_US.UTF-8', 19:02:35 INFO - 'LANGUAGE': 'en_US:en', 19:02:35 INFO - 'LOGNAME': 'cltbld', 19:02:35 INFO - 'MAIL': '/var/mail/cltbld', 19:02:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:02:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:35 INFO - 'MOZ_NO_REMOTE': '1', 19:02:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:02:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:35 INFO - 'NO_EM_RESTART': '1', 19:02:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:35 INFO - 'PWD': '/builds/slave/test', 19:02:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:02:35 INFO - 'SHELL': '/bin/bash', 19:02:35 INFO - 'SHLVL': '1', 19:02:35 INFO - 'TERM': 'linux', 19:02:35 INFO - 'TMOUT': '86400', 19:02:35 INFO - 'USER': 'cltbld', 19:02:35 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864', 19:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:35 INFO - '_': '/tools/buildbot/bin/python'} 19:02:35 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/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 19:02:35 INFO - mozversion application_buildid: 20160425172307 19:02:35 INFO - mozversion application_changeset: 8171bad3ccc5629b4cd3a70b075117d711644982 19:02:35 INFO - mozversion application_display_name: Nightly 19:02:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:02:35 INFO - mozversion application_name: Firefox 19:02:35 INFO - mozversion application_remotingname: firefox 19:02:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:02:35 INFO - mozversion application_vendor: Mozilla 19:02:35 INFO - mozversion application_version: 49.0a1 19:02:35 INFO - mozversion platform_buildid: 20160425172307 19:02:35 INFO - mozversion platform_changeset: 8171bad3ccc5629b4cd3a70b075117d711644982 19:02:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:02:35 INFO - mozversion platform_version: 49.0a1 19:02:35 INFO - using testdate: 1461636155 19:02:35 INFO - actual date: 1461636155 19:02:35 INFO - starting webserver on 'localhost:49272' 19:02:35 INFO - SUITE-START | Running 2 tests 19:02:35 INFO - TEST-START | dromaeo_css 19:02:35 INFO - operating with platform_type : linux_ 19:02:35 INFO - Initialising browser for dromaeo_css test... 19:02:35 INFO - TEST-INFO | started process 21931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDFmvBy/profile http://localhost:49272/getInfo.html) 19:02:39 INFO - PROCESS | 21931 | __metrics Screen width/height:1600/1200 19:02:39 INFO - PROCESS | 21931 | colorDepth:24 19:02:39 INFO - PROCESS | 21931 | Browser inner width/height: 1024/697 19:02:39 INFO - PROCESS | 21931 | __metrics 19:02:40 ERROR - PROCESS | 21931 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:02:41 INFO - TEST-INFO | 21931: exit 0 19:02:41 INFO - Browser initialized. 19:02:41 INFO - Running cycle 1/1 for dromaeo_css test... 19:02:41 INFO - TEST-INFO | started process 22010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDFmvBy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:02:53 INFO - PROCESS | 22010 | RSS: Main: 155865088 19:02:53 INFO - PROCESS | 22010 | 19:03:44 INFO - PROCESS | 22010 | 1461636224966 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] 19:05:56 INFO - PROCESS | 22010 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 19:05:57 INFO - PROCESS | 22010 | RSS: Main: 266817536 19:05:57 INFO - PROCESS | 22010 | 19:08:59 INFO - PROCESS | 22010 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 19:09:00 INFO - PROCESS | 22010 | RSS: Main: 237604864 19:09:00 INFO - PROCESS | 22010 | 19:12:02 INFO - PROCESS | 22010 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 19:12:03 INFO - PROCESS | 22010 | RSS: Main: 241504256 19:12:03 INFO - PROCESS | 22010 | 19:15:05 INFO - PROCESS | 22010 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 19:15:06 INFO - PROCESS | 22010 | RSS: Main: 223350784 19:15:06 INFO - PROCESS | 22010 | 19:18:08 INFO - PROCESS | 22010 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 19:18:09 INFO - PROCESS | 22010 | RSS: Main: 212516864 19:18:09 INFO - PROCESS | 22010 | 19:21:12 INFO - PROCESS | 22010 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 19:21:12 INFO - PROCESS | 22010 | RSS: Main: 272252928 19:21:12 INFO - PROCESS | 22010 | 19:21:12 INFO - PROCESS | 22010 | __start_tp_report 19:21:12 INFO - PROCESS | 22010 | _x_x_mozilla_page_load 19:21:12 INFO - PROCESS | 22010 | _x_x_mozilla_page_load_details 19:21:12 INFO - PROCESS | 22010 | |i|pagename|runs| 19:21:12 INFO - PROCESS | 22010 | |0;dojo.html;2569.4989477051977;2647.5896236083404;2656.8140230183894;2667.906623268186;2690.421559364737;4485.618722408599;4623.560761727639;4645.419322584677;4666.78999445025;4687.8124875005005;4558.430196225472;4618.376519169911;4634.212183928732;4666.346711460398;4676.4855865854815;4152.584741525853;4233.343831706091;4233.703640745149;4252.8298868045395;4348.347747837834;4318.611324980751;4324.481062272532;4350.825966961318;4358.43340365752;4375.562443755631;4105.876823695294;4147.958520414818;4263.062126332233;4270.765107919079;4273.636740877029;4247.3628955656895;4271.295236286009;4272.743635381887;4279.7218180818145;4319.740815551077;4211.43145675333;4259.2759230930815;4260.531341552427;4262.296721041024;4309.267424537805;4365.2142614329405;4460.643148548108;4482.350059241392;4516.774161291923;4568.200564901129;4963.528464795839;4980.7509624518625;4981.12830254704;4981.277714731344;5016.046951079284;4919.901601967977;5004.699718016895;5008.449070602231;5010.974945125287;5067.0879241736475;4431.290993441034;4553.02110046335;4654.069186162781;4663.533646635309;4666.836660716858;5063.3417655704525;5070.721110338893;5075.644704870623;5096.184610462383;5097.439281679012;4880.511948805162;4882.292067650171;4883.389576302962;4893.412790465096;4914.33656456381;4846.588040016568;4943.72809495474;5024.271480635361;5049.469805670426;5063.987202559503;4907.631927605444;4964.453910069889;4968.6025117990475;4970.62720295972;5014.623903207274;4922.926156107661;4939.135651261086;4940.1601727706375;4940.431850337185;4983.302337672729;4048.716589838683;4106.691998100155;4182.519010313792;4246.278132717445;4259.829606815692;3708.4622729704042;3716.7026637869444;3723.2925744108534;3742.045778326509;3785.6592906638534;4271.444712187395;4277.807498662568;4281.293586558245;4321.2005778931;4334.43652325202;4779.474257831635;4978.925316120261;4989.077020751172;4990.2764099205415;5049.31834202378;4260.0840819223395;4288.935665965013;4289.699721019561;4296.548862369469;4336.34954756789;4478.193925093449;4498.50516443191;4508.729476231371;4509.774511274423;4553.33976573395;4556.6126879215635;4630.930536041895;4695.835645752382;4720.527947205252;4720.787564559603;4954.8761280968265;4967.105920934267;4990;4994.400671919393;5043.293938848491;4666.393368862026;4691.08523837862;4693.413323334583;4701.059788042337;4740.336352910526;4635.536446355338;4810.42274927011;4832.685875418087;4876.073546026244;4893.143699852582;4976.377952755905;4992.226204938241;4992.650514463952;5002.024605201951;5047.091523525801;4667.766611669471;4850.248211527219;4865.635077369282;4866.0997715421345;4918.680285781413;4692.41344831896;4728.054389122258;4732.029933863619;4749.335093086902;4773.594244489257;4695.413073365829;4719.551642593948;4723.50403207672;4729.385179926725;4774.283857421415;4663.417072865892;4782.306565548046;4823.831165909176;4867.367242258484;4880.585150262125;4527.38880251175;4599.609033232079;4639.953600463952;4675.111728771522;4801.327814106098 19:21:12 INFO - PROCESS | 22010 | |1;ext.html;578.8842231553688;596.2070446306412;608.9634621922683;620.1534904854874;628.2053202698587;34823.303533929335;35027;35494.645053549524;35620.82189589052;35672.64327356726;41248;42182.7890860546;42242;42262;42327.57672423275;7251.16611589666;7720.884186737189;7951.085625153123;9601;9786.755331116708;9633.518324083803;9808;9816.361936474106;9826.312158148932;9834.26243031772;9792.951035244814;9908.306418550705;9909.653162139326;9909.95045024774;9921.702348929544;9731.902680973171;9855.359401638942;9861.408315501092;9864.457454839945;9879.06148915852;9960.501974901226;10087.798244035079;10097.949510252474;10099.545520451524;10099.646512372032;38999.610003899885;39489.80255098735;39518.40722389166;39540.80229598862;39691.60308396908;3240.8541615627355;3395.337909107725;3454.827258637083;3517.0855577549764;3678;29310.70689293101;30268.24329391783;30316.242093947607;30366.240843978856;30949.845250773826;3422.57217847769;3422.9144271393166;3443.0530119289165;3457.6715212054814;3594.730395220369;236081;237297.81351093308;237677;237941;238308;57238.14142787862;57514.7124264376;57557.71221143867;57702.7114864423;57805.421945780006;60453.39546604566;60486.69756651189;60604.393956060754;60652;60665.69667151636;14391.712165756626;14841.70316593662;14869.107853528823;14885;14886.255687215596;11160.441977901073;11220.438978051228;11233.550657973752;11237.94381028106;11239.21325507223;19325.13036913342;19449.51376215606;19570.70643940342;19572;19592.314269000515;7089.184743754431;7242.275772422821;7283.2352602975925;7357.926420735724;7391.482596218213;858.5321000054985;923.9538023098818;945.4610871803144;992.151710287708;1029.8558201851747;27774;28663.71336286652;28972.855135724607;29033;29142.708572913998;936.784539555906;1007.2395341517108;1030.9845352319571;1057.984130238047;1072.303003048025;13228.404721787543;13985.58043258704;14283.500077497238;14296.57110286693;14319.713605727828;316952.41523792234;322512;322898;323246;323776;49854.75072624614;50654.24018639723;50669;50672;50776.74611626992;1169.7777422289737;1224.3143839449936;1277.5464710027993;1288.2850018239778;1293.909426340166;26423.73576264213;27467.450650987266;27582.44835103327;28049;28092.157235282975;42711;42785.57214427816;43108.78445607752;43131.353029703954;43149.78425107854;282165;284303;284723;284815;285291;28871.278218044718;29210.26974325574;34255.14362140966;38350;38934.2213155741;40373.1925361497;40477.595224047385;40789.592104078576;41059.7947010263;41389.793051034554;34470.65529344675;34780;35451.645483545864;35615.643843561236;35871.46192807162;34883.55815093021;35203.471947921316;35403.64596354003;35589.82205088958;35628.64371356253;34225.48661770125;34780.304393912484;34856.65143348534;35119;35368;30975.690243098183;31572.210694732814;31665.250212468312;31830.204244894063;31954.20114497156;23542.646860296765;24436.51126977486;24468;24702.752972470043;24754.50490990206 19:21:12 INFO - PROCESS | 22010 | |2;jquery.html;378.4153482868968;379.6326583206955;385.89773709966863;390.0891418537714;399.70421887802996;15637.921810390946;16983.57541061474;17173;17198;17251.223694933728;16971.3211471541;17207.22567484463;17289.30842766288;17536.12319384032;17545.91227043866;4940.901181976349;5176.767045482943;5205.791768329263;5211.140161873286;5213.713245771481;3700.870469533567;3898.629630185142;5671.63134396265;5967.880642387149;5968.224130863004;5843.5033022193165;5869.501092407129;5897.233359663238;5914.9408505915035;5920.970395148018;5680.545556355502;5830.82507524775;5861.4724674779045;5866.88266234675;5867.031939729961;3406.386850366933;3597.4244120940784;3598.6941110005682;3600.6579374959338;5001.824936127255;19162.329318473785;19666.803331966785;19737.703934440993;19946.601067978558;20707.5858482831;1884.5948121154017;1911.7132430135453;1986.632472992501;2050.559129787103;2373.0982226753895;12948.676283092998;12978.88046133042;13143.34283285832;13268.40292186854;13753.174809511462;1774.8491378232866;1848.815118488154;1852.935147269839;1877.8122187781112;1890.5368184794677;61842.38157618411;65534.01698974471;66720.6663966682;68401.65799171022;68897;9624.267631826338;9636.373635713657;9951.004899509991;10034.862530702721;10120.493975301206;13570.117942333716;13726.45094196241;13731.931340343235;13753.518626848012;13765.793513097311;7215.494915355875;7247.4926755126635;7280.563166210044;7406.740764073232;7415.85168296631;6876.17485901695;6904.344087311697;6976.860462790716;7085.89371159433;7106.538075025107;6178.41305076017;6201.193844800147;6232;6243.625382477066;6402.8719425611225;1611.613212828936;1708.5386945524638;1767.2842498788011;1768.8496477799274;1784.598465345313;900.4912224593083;924.3160061554536;933.3979583168818;981.2885657897967;1024.8052869954834;16624.83375166233;17210;17487.475375738748;17564;17700.645987080443;908.4413085952092;910.1035480052143;918.4764684130115;926.6664000959784;935.6573317289711;9706.486483785075;10199.235057370726;10230.6419275325;10288.691339259834;10387.636432724817;352223;364964;365271;368010;369249;69131.96302055473;72642.63678681679;72726.27273727302;73092.26907730961;74143.62928185324;941.289326558444;950.496236994394;954.3891909178132;971.533663841346;972.0522490571777;15375.69248614999;15471.149086800335;15515.612109697347;15689.921550392175;15694.529164125095;32626.673733263313;32696.673033269362;32952.505712413855;33051.83474082614;33102.17244568905;43238;44034.55965440433;44171.337429937936;44172.337414938156;44246.336304954806;7611.847763044598;7644.885326720215;7734.497257678233;7769.961150194213;7834.177411371952;8645.394822362627;11042.723931901766;11181.385023823768;11586.594469193538;11791.410429478663;5239.659422137549;5880.500157486662;9426.680264763076;9927.354721943051;10438.11276041545;9906.851397229191;9957.153641940227;10048.397096174253;10154.492275386348;10200.28597998133;5567.805126820542;7278.6724597392185;10184.032516910882;10274.434906080238;10310.278280520291;7529.360004399688;7540.359069479156;7557.697692092474;7725.845483090195;7736.667213041398;10224;10279.074883260542;10288.228382871164;10310.948445257725;10314.535845887103 19:21:12 INFO - PROCESS | 22010 | |3;mootools.html;1235.962921112367;1443.1701771481398;1443.45870298638;1577.2902194012697;1745.7294119411495;6120.632762034275;7298.525595836273;7465.664045117969;7520.6991720331125;7541.208173141817;7306.159791623965;7461.067366579177;7465.664045117969;7471.55170689759;7473.738419155331;1834.7523084383638;2129.925452609159;2148.4521447031025;2188.2013065231154;2220.5114874727533;2149;2182.159868450642;2182.443476913385;2183.8689678619335;2188.3872515695552;2097.1087287902656;2155.299527653511;2155.91376344946;2156.7196264485597;2158.686990386393;1826.6620675175136;2150.2366659835766;2217.1131547381015;2219.1567204462362;2219.6226641470826;2111.714918486;2125.968110478344;2136.0494579911947;2136.957260854774;2140.7859214078467;7348.632568371613;7401.0748656417945;7401.444891633149;7411.7035318587195;7413.851722965511;4393.275109606911;4573.519780423074;4578.496365399803;4584.770761461914;4585.426821647294;2906.694797046322;2917.985410072957;2965.110466859955;2984.104768569442;2989.7907146499756;893.749750069975;904.5432056811268;919.2737737187614;920.8434566123775;922.8800255966681;9820.361676491077;10086.092251697382;10125.493725313705;10129.442880641562;10136.037076477724;4020.9195816083516;4075;4156.958430415718;4182.226288136704;4182.937255941163;8823.382363234512;8854.114588541222;8862.291016718647;8868.113188681209;8874.245689116497;3833.5399752029375;4587.977060114678;4626.1210370029585;4665.183592871234;4668.5798278155125;3981.3828856527284;4086.0397806515443;4087.0599762054894;4088.9386659200136;4096.426500289962;3535.2399234164777;3540.1149712571855;3639.636036396339;3641.9635803642154;3660.5790334111916;1155.774623948322;1160.3560024186656;1165.4580620011736;1165.4755360087825;1166.4109624639502;805.8509175802495;817.1093508076107;844.9711309804467;851.6635928808087;854.1501206299771;4800.279958006257;4940.382452193476;4970.030843985388;5067.695938243717;5070.163423035158;391.90986073202754;407.06984540325806;408.1266090566191;914.111407950872;958.1495052219591;3332.0836769888474;3346.6318704942437;3361.8655253789575;3367.107716455141;3408.829558522064;8640.222379985831;8905.332100092519;8981.506017168987;9009.774755631162;9026.684066057656;8906.55467226636;8928.910710892807;8935.195832375117;8970.416922900122;8971.05803890595;6519.8696026079215;6753.898691519631;6789.660516974231;6818.420434263143;7093.82265443368;5078.263651770547;5101;5107.897842043212;5241.161414173714;5248.8425347239645;7984.92015079865;8214.096449390443;8471.745847624581;8540.060593334852;8555;8672.219500245008;8746.300295976434;8752.824943500967;8753.124687531195;8801.163889430494;5654.491095801233;6408.93591064102;6632;6666.666666666551;6793.150856142982;7256.092988376453;7287.708491660274;7335.816604584928;7342.48602597813;7350.77947661571;6314.55798094129;6411.3909178627955;6454.580452270588;6570.8028759137305;6610.3389661035435;6586.473082153512;6644.4020038196795;6714.194296684429;6745.543335847983;6754.3921047106;6117.510599152146;6167.6916154193;6193.225846769154;6199.876002479835;6200.627962322275;4469.463664360298;4537.977310113428;4649.814007439664;4683.180443422456;4708.552687494683;4579.9542004579525;4689.6717229793585;4703.341532185428;4713.717176969393;4716.080364328923 19:21:12 INFO - PROCESS | 22010 | |4;prototype.html;289.3590696607014;298.87895402362045;301.43180105501125;303.989360372387;307.8553080052375;4444.97777511112;4640.327152562876;4659.673822832403;4712.387389639346;4720.952790472099;4487.798049087791;4655.231886738692;4656.580907718305;4660.277656963176;4661.930071048929;3653.488511608377;3702.9629703702885;3706.703463722909;3713.7214708896804;3719.8140092995377;3481.982590087046;3553.9466907996402;3711.1464363196483;3725.944110838326;3741.4761933329355;3685.520882285299;3698.149425632106;3710.350688629479;3710.9443358349645;3715;3648.179159689062;3664.3221004114325;3677.7057835373107;3678.1907980244305;3699.315626609086;3279.852406641683;3290.50642403639;3297.093299342676;3300.1254667513126;3312.7846689965318;4282.886449523146;4514.887127821798;4521.480029796583;4535.138323718483;4539.4779600346055;4126.938095928564;4150.64719498843;4151.46031015969;4156.5635608261;4159.91680166398;4919.728380626879;4927.975360123212;4933.53131452515;4935.876603084916;4942.827001054946;3301.2077101495706;3487.3548393547276;3504.8948531544092;3507.2108775525558;3509.1578021274963;5108.846734597968;5124.9743751281;5142.562882155022;5153;5153.7165455900285;3575.4100573405617;3583.6492879158072;3589.2283159120916;3592.1019745063736;3598.5142005829402;3612.6026137124895;3619.8552057917914;3628.1473853644375;3638.6361363863402;3646.343658141507;3905.160390515996;4109;4117.691173162025;4131;4148.79256037197;4894.19245824435;4904.239842824368;4913.803447862046;4924.113659541317;4925.285833554115;1241.6895776055985;1271.4850485553366;1301.919406892277;1318.5780550224029;1322.4842311498523;853.2576658307312;865.948043117415;866.9826603467895;869.1525762381754;872.8516152254132;4569.588737013684;4583.770811459413;4592.885177870513;4595.977020114878;4610.124076425468;5328;5345.70598617072;5354.892902141935;5358;5365.1147560652835;4479;4555.589996900295;4570.748608826547;4579.9084018319445;4584.747838868894;2808.775297976157;2854.22935807335;2857.8999735009593;2869.0962346860674;2873.956890646642;5024.773885175103;5043.092243396224;5043.2687260347775;5043.899122017539;5045.84862454127;5284.524392804589;5454.427285135083;5459.181122831527;5475.698836564027;5476.479734425223;5042.621803364689;5044.4198917125;5047.091523525874;5047.545720885138;5052.787331040598;5307.310049693515;5320.17537281722;5328.440513746156;5336.599755018312;5341.839744807662;5057.266696329085;5207.817726379559;5210.140326846028;5224.451432599522;5227.973860130675;4982.2775697524385;5034.370703662043;5037.345145131109;5047.646664733434;5058.2918391425965;3692.1138926657945;3693.2613477304108;3702.9629703702617;3704.759190652599;3718.330700473941;4780.689255198401;4845.563899249085;5307.708076055854;5317.441668624739;5318.97340513295;4776.164171269945;4884.633652476007;4929.704217746947;4951;4952.529509696573;4930.901381972412;4937.456879743298;4945.431275403231;4950.77721502526;4965.751712414437;4633.513481084437;4856.805727770849;4858.319835223142;4869.634777391639;4871.853844384674;5009.649324547392;5016.344606279846;5025.321581586439;5029.862308518792;5036.798528058836;4895.828645997373;4910.337104490848;4912.7543622818;4918.827841025547;4920.2619607057795 19:21:12 INFO - PROCESS | 22010 | |5;yui.html;620.1132380695609;643.2795269298387;651.8852761777364;665.9533832631716;743.6244696428306;12285.508579656815;12299.32353720545;12477.31374774387;12522.248665080078;12523.311217883036;11697.122715796308;11763.35301558414;11771.587994420197;11786.116041296895;11824.349660768654;599.4155698194269;766.8696321625337;797.5254723439544;800.1558355934487;807.4872455990459;813.2802469814197;816.0330008939396;817.9222973817477;818.3657665309403;818.4352796570378;865.1694373401542;866.3545658484438;867.3234876796078;868.04515033463;868.4745728834059;669.6250099944023;826.396730386821;860.3805260212637;865.7922098696267;866.1468453573225;612.3111499562991;613.058954504833;613.1324176290589;613.1844646619985;614.6588643302965;11367.147463940237;11414.543418263342;11463.426828658618;11465.426728663533;11489.597864074718;11543.480543375568;12047.518099276018;12311.815322770166;12335.876641233563;12561.246325220516;9868;9936.956619554987;9977.950110249474;10007.29948903577;11169.385683787388;4158.334666453383;4217.283061879488;4238.533761286256;4377.934330985037;4385.583369579885;39742.60257397418;39838;40100.19799603992;40129;40650.9999999997;9780.31537792362;10197.643082492077;10209.99999999985;10221.233407494468;10559.788804223872;17561.297548098188;18147.63704725898;18155.909220453814;18161.727574086133;18212.36256731008;6801.387875091265;6815.318468153145;6843.520953533304;6856.725730970805;7027.89458158128;3743.082944678571;3796.430535419709;3818.9236215275537;3870.109874728772;3874.3219936511;2906.4768341698696;2973.52423612221;2976.4047190561973;2983.254186453387;2987.208389776711;491.17482629183314;510.4130250212286;523.0924346259237;525.7975679363473;534.2467121358943;436.56561721087724;456.41350864139423;469.7416420968522;535.7133933345641;551.2915903064622;7343.742968996059;7423.8011260598005;7687.154413014564;7733.226677332222;7795.220477952273;564.2044716949164;588.4380416702124;593.652713162796;619.454879705856;651.4462706699362;3933.9213215735526;4010.3583426651594;4119.258533463945;4191.97904010478;4239.936400953989;53837;61482.0777688335;61527.692361537906;61650.38349616536;61721.38278617156;49961.750191249535;50947.745261273456;51164.74417627888;52156.21765673518;53536.732316338166;44912.326315105296;45661.54338456573;45725;46564;47441.76279118582;7845.3723702104835;7933.325667318342;8111.718033571305;8155;8391.118932511998;30395;30476.542851857685;30722.539161913035;30762.38475230438;31171.37657246797;40100.39347442407;42115.368269475366;42471.78764106159;42593;42816;11012.724681883017;11091;11120;11176.888231117584;11535.250208736405;11354.26197297173;11514.42427878586;11633.47649355764;11838.33637431571;11840.348780817138;8042.9597852010365;9865;10333;10567.10179634709;10750.13998880072;10232;10313.896861031293;10821.404822734825;10845.891541084487;10965.561377545127;9693.466859322805;10058.698239052841;10268.178545716473;10271.435071071162;10414.739631509274;8520.531370774666;8793.692220772242;9087.727368178965;9259.379608568339;9435.575399107194;8672.479651220947;8774.34192435557;9108.499032553273;9117.77205569866;9179.127982841886 19:21:12 INFO - PROCESS | 22010 | __end_tp_report 19:21:12 INFO - PROCESS | 22010 | __start_cc_report 19:21:12 INFO - PROCESS | 22010 | _x_x_mozilla_cycle_collect,1013 19:21:12 INFO - PROCESS | 22010 | __end_cc_report 19:21:12 INFO - PROCESS | 22010 | __startTimestamp1461637272607__endTimestamp 19:21:12 INFO - PROCESS | 22010 | 19:21:12 INFO - PROCESS | 22010 | ------- Summary: start ------- 19:21:12 INFO - PROCESS | 22010 | Number of tests: 6 19:21:12 INFO - PROCESS | 22010 | 19:21:12 INFO - PROCESS | 22010 | [#0] dojo.html Cycles:165 Average:4577.07 Median:4675.11 stddev:470.48 (10.1%) stddev-sans-first:444.78 19:21:12 INFO - PROCESS | 22010 | Values: 2569.5 2647.6 2656.8 2667.9 2690.4 4485.6 4623.6 4645.4 4666.8 4687.8 4558.4 4618.4 4634.2 4666.3 4676.5 4152.6 4233.3 4233.7 4252.8 4348.3 4318.6 4324.5 4350.8 4358.4 4375.6 4105.9 4148.0 4263.1 4270.8 4273.6 4247.4 4271.3 4272.7 4279.7 4319.7 4211.4 4259.3 4260.5 4262.3 4309.3 4365.2 4460.6 4482.4 4516.8 4568.2 4963.5 4980.8 4981.1 4981.3 5016.0 4919.9 5004.7 5008.4 5011.0 5067.1 4431.3 4553.0 4654.1 4663.5 4666.8 5063.3 5070.7 5075.6 5096.2 5097.4 4880.5 4882.3 4883.4 4893.4 4914.3 4846.6 4943.7 5024.3 5049.5 5064.0 4907.6 4964.5 4968.6 4970.6 5014.6 4922.9 4939.1 4940.2 4940.4 4983.3 4048.7 4106.7 4182.5 4246.3 4259.8 3708.5 3716.7 3723.3 3742.0 3785.7 4271.4 4277.8 4281.3 4321.2 4334.4 4779.5 4978.9 4989.1 4990.3 5049.3 4260.1 4288.9 4289.7 4296.5 4336.3 4478.2 4498.5 4508.7 4509.8 4553.3 4556.6 4630.9 4695.8 4720.5 4720.8 4954.9 4967.1 4990.0 4994.4 5043.3 4666.4 4691.1 4693.4 4701.1 4740.3 4635.5 4810.4 4832.7 4876.1 4893.1 4976.4 4992.2 4992.7 5002.0 5047.1 4667.8 4850.2 4865.6 4866.1 4918.7 4692.4 4728.1 4732.0 4749.3 4773.6 4695.4 4719.6 4723.5 4729.4 4774.3 4663.4 4782.3 4823.8 4867.4 4880.6 4527.4 4599.6 4640.0 4675.1 4801.3 19:21:12 INFO - PROCESS | 22010 | 19:21:12 INFO - PROCESS | 22010 | [#1] ext.html Cycles:180 Average:45008.48 Median:34955.28 stddev:73979.50 (211.6%) stddev-sans-first:74111.82 19:21:12 INFO - PROCESS | 22010 | Values: 578.9 596.2 609.0 620.2 628.2 34823.3 35027.0 35494.6 35620.8 35672.6 41248.0 42182.8 42242.0 42262.0 42327.6 7251.2 7720.9 7951.1 9601.0 9786.8 9633.5 9808.0 9816.4 9826.3 9834.3 9793.0 9908.3 9909.7 9910.0 9921.7 9731.9 9855.4 9861.4 9864.5 9879.1 9960.5 10087.8 10097.9 10099.5 10099.6 38999.6 39489.8 39518.4 39540.8 39691.6 3240.9 3395.3 3454.8 3517.1 3678.0 29310.7 30268.2 30316.2 30366.2 30949.8 3422.6 3422.9 3443.1 3457.7 3594.7 236081.0 237297.8 237677.0 237941.0 238308.0 57238.1 57514.7 57557.7 57702.7 57805.4 60453.4 60486.7 60604.4 60652.0 60665.7 14391.7 14841.7 14869.1 14885.0 14886.3 11160.4 11220.4 11233.6 11237.9 11239.2 19325.1 19449.5 19570.7 19572.0 19592.3 7089.2 7242.3 7283.2 7357.9 7391.5 858.5 924.0 945.5 992.2 1029.9 27774.0 28663.7 28972.9 29033.0 29142.7 936.8 1007.2 1031.0 1058.0 1072.3 13228.4 13985.6 14283.5 14296.6 14319.7 316952.4 322512.0 322898.0 323246.0 323776.0 49854.8 50654.2 50669.0 50672.0 50776.7 1169.8 1224.3 1277.5 1288.3 1293.9 26423.7 27467.5 27582.4 28049.0 28092.2 42711.0 42785.6 43108.8 43131.4 43149.8 282165.0 284303.0 284723.0 284815.0 285291.0 28871.3 29210.3 34255.1 38350.0 38934.2 40373.2 40477.6 40789.6 41059.8 41389.8 34470.7 34780.0 35451.6 35615.6 35871.5 34883.6 35203.5 35403.6 35589.8 35628.6 34225.5 34780.3 34856.7 35119.0 35368.0 30975.7 31572.2 31665.3 31830.2 31954.2 23542.6 24436.5 24468.0 24702.8 24754.5 19:21:12 INFO - PROCESS | 22010 | 19:21:12 INFO - PROCESS | 22010 | [#2] jquery.html Cycles:180 Average:23106.23 Median:2142.26 stddev:60003.03 (2800.9%) stddev-sans-first:60147.09 19:21:12 INFO - PROCESS | 22010 | Values: 378.4 379.6 385.9 390.1 399.7 15637.9 16983.6 17173.0 17198.0 17251.2 16971.3 17207.2 17289.3 17536.1 17545.9 4940.9 5176.8 5205.8 5211.1 5213.7 3700.9 3898.6 5671.6 5967.9 5968.2 5843.5 5869.5 5897.2 5914.9 5921.0 5680.5 5830.8 5861.5 5866.9 5867.0 3406.4 3597.4 3598.7 3600.7 5001.8 19162.3 19666.8 19737.7 19946.6 20707.6 1884.6 1911.7 1986.6 2050.6 2373.1 12948.7 12978.9 13143.3 13268.4 13753.2 1774.8 1848.8 1852.9 1877.8 1890.5 61842.4 65534.0 66720.7 68401.7 68897.0 9624.3 9636.4 9951.0 10034.9 10120.5 13570.1 13726.5 13731.9 13753.5 13765.8 7215.5 7247.5 7280.6 7406.7 7415.9 6876.2 6904.3 6976.9 7085.9 7106.5 6178.4 6201.2 6232.0 6243.6 6402.9 1611.6 1708.5 1767.3 1768.8 1784.6 900.5 924.3 933.4 981.3 1024.8 16624.8 17210.0 17487.5 17564.0 17700.6 908.4 910.1 918.5 926.7 935.7 9706.5 10199.2 10230.6 10288.7 10387.6 352223.0 364964.0 365271.0 368010.0 369249.0 69132.0 72642.6 72726.3 73092.3 74143.6 941.3 950.5 954.4 971.5 972.1 15375.7 15471.1 15515.6 15689.9 15694.5 32626.7 32696.7 32952.5 33051.8 33102.2 43238.0 44034.6 44171.3 44172.3 44246.3 7611.8 7644.9 7734.5 7770.0 7834.2 8645.4 11042.7 11181.4 11586.6 11791.4 5239.7 5880.5 9426.7 9927.4 10438.1 9906.9 9957.2 10048.4 10154.5 10200.3 5567.8 7278.7 10184.0 10274.4 10310.3 7529.4 7540.4 7557.7 7725.8 7736.7 10224.0 10279.1 10288.2 10310.9 10314.5 19:21:12 INFO - PROCESS | 22010 | 19:21:12 INFO - PROCESS | 22010 | [#3] mootools.html Cycles:180 Average:4944.76 Median:5068.93 stddev:2712.55 (53.5%) stddev-sans-first:2705.83 19:21:12 INFO - PROCESS | 22010 | Values: 1236.0 1443.2 1443.5 1577.3 1745.7 6120.6 7298.5 7465.7 7520.7 7541.2 7306.2 7461.1 7465.7 7471.6 7473.7 1834.8 2129.9 2148.5 2188.2 2220.5 2149.0 2182.2 2182.4 2183.9 2188.4 2097.1 2155.3 2155.9 2156.7 2158.7 1826.7 2150.2 2217.1 2219.2 2219.6 2111.7 2126.0 2136.0 2137.0 2140.8 7348.6 7401.1 7401.4 7411.7 7413.9 4393.3 4573.5 4578.5 4584.8 4585.4 2906.7 2918.0 2965.1 2984.1 2989.8 893.7 904.5 919.3 920.8 922.9 9820.4 10086.1 10125.5 10129.4 10136.0 4020.9 4075.0 4157.0 4182.2 4182.9 8823.4 8854.1 8862.3 8868.1 8874.2 3833.5 4588.0 4626.1 4665.2 4668.6 3981.4 4086.0 4087.1 4088.9 4096.4 3535.2 3540.1 3639.6 3642.0 3660.6 1155.8 1160.4 1165.5 1165.5 1166.4 805.9 817.1 845.0 851.7 854.2 4800.3 4940.4 4970.0 5067.7 5070.2 391.9 407.1 408.1 914.1 958.1 3332.1 3346.6 3361.9 3367.1 3408.8 8640.2 8905.3 8981.5 9009.8 9026.7 8906.6 8928.9 8935.2 8970.4 8971.1 6519.9 6753.9 6789.7 6818.4 7093.8 5078.3 5101.0 5107.9 5241.2 5248.8 7984.9 8214.1 8471.7 8540.1 8555.0 8672.2 8746.3 8752.8 8753.1 8801.2 5654.5 6408.9 6632.0 6666.7 6793.2 7256.1 7287.7 7335.8 7342.5 7350.8 6314.6 6411.4 6454.6 6570.8 6610.3 6586.5 6644.4 6714.2 6745.5 6754.4 6117.5 6167.7 6193.2 6199.9 6200.6 4469.5 4538.0 4649.8 4683.2 4708.6 4580.0 4689.7 4703.3 4713.7 4716.1 19:21:12 INFO - PROCESS | 22010 | 19:21:12 INFO - PROCESS | 22010 | [#4] prototype.html Cycles:180 Average:4164.63 Median:4658.13 stddev:1221.24 (26.2%) stddev-sans-first:1189.52 19:21:12 INFO - PROCESS | 22010 | Values: 289.4 298.9 301.4 304.0 307.9 4445.0 4640.3 4659.7 4712.4 4721.0 4487.8 4655.2 4656.6 4660.3 4661.9 3653.5 3703.0 3706.7 3713.7 3719.8 3482.0 3553.9 3711.1 3725.9 3741.5 3685.5 3698.1 3710.4 3710.9 3715.0 3648.2 3664.3 3677.7 3678.2 3699.3 3279.9 3290.5 3297.1 3300.1 3312.8 4282.9 4514.9 4521.5 4535.1 4539.5 4126.9 4150.6 4151.5 4156.6 4159.9 4919.7 4928.0 4933.5 4935.9 4942.8 3301.2 3487.4 3504.9 3507.2 3509.2 5108.8 5125.0 5142.6 5153.0 5153.7 3575.4 3583.6 3589.2 3592.1 3598.5 3612.6 3619.9 3628.1 3638.6 3646.3 3905.2 4109.0 4117.7 4131.0 4148.8 4894.2 4904.2 4913.8 4924.1 4925.3 1241.7 1271.5 1301.9 1318.6 1322.5 853.3 865.9 867.0 869.2 872.9 4569.6 4583.8 4592.9 4596.0 4610.1 5328.0 5345.7 5354.9 5358.0 5365.1 4479.0 4555.6 4570.7 4579.9 4584.7 2808.8 2854.2 2857.9 2869.1 2874.0 5024.8 5043.1 5043.3 5043.9 5045.8 5284.5 5454.4 5459.2 5475.7 5476.5 5042.6 5044.4 5047.1 5047.5 5052.8 5307.3 5320.2 5328.4 5336.6 5341.8 5057.3 5207.8 5210.1 5224.5 5228.0 4982.3 5034.4 5037.3 5047.6 5058.3 3692.1 3693.3 3703.0 3704.8 3718.3 4780.7 4845.6 5307.7 5317.4 5319.0 4776.2 4884.6 4929.7 4951.0 4952.5 4930.9 4937.5 4945.4 4950.8 4965.8 4633.5 4856.8 4858.3 4869.6 4871.9 5009.6 5016.3 5025.3 5029.9 5036.8 4895.8 4910.3 4912.8 4918.8 4920.3 19:21:12 INFO - PROCESS | 22010 | 19:21:12 INFO - PROCESS | 22010 | [#5] yui.html Cycles:180 Average:13112.73 Median:23058.98 stddev:15499.29 (67.2%) stddev-sans-first:15514.37 19:21:12 INFO - PROCESS | 22010 | Values: 620.1 643.3 651.9 666.0 743.6 12285.5 12299.3 12477.3 12522.2 12523.3 11697.1 11763.4 11771.6 11786.1 11824.3 599.4 766.9 797.5 800.2 807.5 813.3 816.0 817.9 818.4 818.4 865.2 866.4 867.3 868.0 868.5 669.6 826.4 860.4 865.8 866.1 612.3 613.1 613.1 613.2 614.7 11367.1 11414.5 11463.4 11465.4 11489.6 11543.5 12047.5 12311.8 12335.9 12561.2 9868.0 9937.0 9978.0 10007.3 11169.4 4158.3 4217.3 4238.5 4377.9 4385.6 39742.6 39838.0 40100.2 40129.0 40651.0 9780.3 10197.6 10210.0 10221.2 10559.8 17561.3 18147.6 18155.9 18161.7 18212.4 6801.4 6815.3 6843.5 6856.7 7027.9 3743.1 3796.4 3818.9 3870.1 3874.3 2906.5 2973.5 2976.4 2983.3 2987.2 491.2 510.4 523.1 525.8 534.2 436.6 456.4 469.7 535.7 551.3 7343.7 7423.8 7687.2 7733.2 7795.2 564.2 588.4 593.7 619.5 651.4 3933.9 4010.4 4119.3 4192.0 4239.9 53837.0 61482.1 61527.7 61650.4 61721.4 49961.8 50947.7 51164.7 52156.2 53536.7 44912.3 45661.5 45725.0 46564.0 47441.8 7845.4 7933.3 8111.7 8155.0 8391.1 30395.0 30476.5 30722.5 30762.4 31171.4 40100.4 42115.4 42471.8 42593.0 42816.0 11012.7 11091.0 11120.0 11176.9 11535.3 11354.3 11514.4 11633.5 11838.3 11840.3 8043.0 9865.0 10333.0 10567.1 10750.1 10232.0 10313.9 10821.4 10845.9 10965.6 9693.5 10058.7 10268.2 10271.4 10414.7 8520.5 8793.7 9087.7 9259.4 9435.6 8672.5 8774.3 9108.5 9117.8 9179.1 19:21:12 INFO - PROCESS | 22010 | -------- Summary: end -------- 19:21:12 INFO - PROCESS | 22010 | 19:21:13 INFO - TEST-INFO | 22010: exit 0 19:21:13 INFO - TEST-OK | dromaeo_css | took 1117915ms 19:21:13 INFO - TEST-START | kraken 19:21:13 INFO - operating with platform_type : linux_ 19:21:13 INFO - Initialising browser for kraken test... 19:21:13 INFO - TEST-INFO | started process 22190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplKg7NR/profile http://localhost:49272/getInfo.html) 19:21:17 INFO - PROCESS | 22190 | __metrics Screen width/height:1600/1200 19:21:17 INFO - PROCESS | 22190 | colorDepth:24 19:21:17 INFO - PROCESS | 22190 | Browser inner width/height: 1024/697 19:21:17 INFO - PROCESS | 22190 | __metrics 19:21:18 ERROR - PROCESS | 22190 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:21:19 INFO - TEST-INFO | 22190: exit 0 19:21:19 INFO - Browser initialized. 19:21:19 INFO - Running cycle 1/1 for kraken test... 19:21:19 INFO - TEST-INFO | started process 22273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplKg7NR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:21:31 INFO - PROCESS | 22273 | RSS: Main: 156033024 19:21:31 INFO - PROCESS | 22273 | 19:21:34 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 19:21:35 INFO - PROCESS | 22273 | RSS: Main: 211582976 19:21:35 INFO - PROCESS | 22273 | 19:21:37 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 19:21:38 INFO - PROCESS | 22273 | RSS: Main: 196771840 19:21:38 INFO - PROCESS | 22273 | 19:21:41 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 19:21:42 INFO - PROCESS | 22273 | RSS: Main: 267190272 19:21:42 INFO - PROCESS | 22273 | 19:21:44 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 19:21:44 INFO - PROCESS | 22273 | RSS: Main: 175357952 19:21:44 INFO - PROCESS | 22273 | 19:21:47 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:21:47 INFO - PROCESS | 22273 | RSS: Main: 179535872 19:21:47 INFO - PROCESS | 22273 | 19:21:50 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 19:21:51 INFO - PROCESS | 22273 | RSS: Main: 215080960 19:21:51 INFO - PROCESS | 22273 | 19:21:55 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 19:21:55 INFO - PROCESS | 22273 | RSS: Main: 216150016 19:21:55 INFO - PROCESS | 22273 | 19:21:58 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 19:21:59 INFO - PROCESS | 22273 | RSS: Main: 215846912 19:21:59 INFO - PROCESS | 22273 | 19:22:00 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:22:01 INFO - PROCESS | 22273 | RSS: Main: 200945664 19:22:01 INFO - PROCESS | 22273 | 19:22:03 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:22:03 INFO - PROCESS | 22273 | RSS: Main: 202735616 19:22:03 INFO - PROCESS | 22273 | 19:22:06 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:22:06 INFO - PROCESS | 22273 | RSS: Main: 216399872 19:22:06 INFO - PROCESS | 22273 | 19:22:09 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:22:10 INFO - PROCESS | 22273 | RSS: Main: 226009088 19:22:10 INFO - PROCESS | 22273 | 19:22:13 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:22:13 INFO - PROCESS | 22273 | RSS: Main: 223371264 19:22:13 INFO - PROCESS | 22273 | 19:22:15 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 19:22:15 INFO - PROCESS | 22273 | RSS: Main: 286568448 19:22:15 INFO - PROCESS | 22273 | 19:22:15 INFO - PROCESS | 22273 | __start_tp_report 19:22:15 INFO - PROCESS | 22273 | _x_x_mozilla_page_load 19:22:15 INFO - PROCESS | 22273 | _x_x_mozilla_page_load_details 19:22:15 INFO - PROCESS | 22273 | |i|pagename|runs| 19:22:15 INFO - PROCESS | 22273 | |0;ai-astar;113;115;109;113;115;116;105;113;114;114 19:22:15 INFO - PROCESS | 22273 | |1;audio-beat-detection;163;132;162;190;134;157;172;136;187;133 19:22:15 INFO - PROCESS | 22273 | |2;audio-dft;160;160;161;159;161;160;161;161;161;164 19:22:15 INFO - PROCESS | 22273 | |3;audio-fft;75;74;101;113;74;76;74;121;104;73 19:22:15 INFO - PROCESS | 22273 | |4;audio-oscillator;94;95;141;94;95;94;149;95;95;153 19:22:15 INFO - PROCESS | 22273 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;117;117;116 19:22:15 INFO - PROCESS | 22273 | |6;imaging-darkroom;145;145;146;146;145;146;146;146;146;146 19:22:15 INFO - PROCESS | 22273 | |7;imaging-desaturate;95;94;95;94;94;95;95;94;94;95 19:22:15 INFO - PROCESS | 22273 | |8;json-parse-financial;65;67;66;66;67;67;66;79;74;65 19:22:15 INFO - PROCESS | 22273 | |9;json-stringify-tinderbox;65;65;65;65;65;66;65;65;64;65 19:22:15 INFO - PROCESS | 22273 | |10;stanford-crypto-aes;79;78;79;79;80;80;92;80;80;85 19:22:15 INFO - PROCESS | 22273 | |11;stanford-crypto-ccm;134;129;137;134;142;130;134;130;171;131 19:22:15 INFO - PROCESS | 22273 | |12;stanford-crypto-pbkdf2;180;186;176;175;178;183;177;185;178;180 19:22:15 INFO - PROCESS | 22273 | |13;stanford-crypto-sha256-iterative;74;73;74;73;74;75;72;73;73;73 19:22:15 INFO - PROCESS | 22273 | __end_tp_report 19:22:15 INFO - PROCESS | 22273 | __start_cc_report 19:22:15 INFO - PROCESS | 22273 | _x_x_mozilla_cycle_collect,1884 19:22:15 INFO - PROCESS | 22273 | __end_cc_report 19:22:15 INFO - PROCESS | 22273 | __startTimestamp1461637335766__endTimestamp 19:22:15 INFO - PROCESS | 22273 | 19:22:15 INFO - PROCESS | 22273 | ------- Summary: start ------- 19:22:15 INFO - PROCESS | 22273 | Number of tests: 14 19:22:15 INFO - PROCESS | 22273 | 19:22:15 INFO - PROCESS | 22273 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.30 (2.9%) stddev-sans-first:3.50 19:22:15 INFO - PROCESS | 22273 | Values: 113.0 115.0 109.0 113.0 115.0 116.0 105.0 113.0 114.0 114.0 19:22:15 INFO - PROCESS | 22273 | 19:22:15 INFO - PROCESS | 22273 | [#1] audio-beat-detection Cycles:10 Average:156.60 Median:162.50 stddev:22.22 (13.7%) stddev-sans-first:23.45 19:22:15 INFO - PROCESS | 22273 | Values: 163.0 132.0 162.0 190.0 134.0 157.0 172.0 136.0 187.0 133.0 19:22:15 INFO - PROCESS | 22273 | 19:22:15 INFO - PROCESS | 22273 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.32 (0.8%) stddev-sans-first:1.36 19:22:15 INFO - PROCESS | 22273 | Values: 160.0 160.0 161.0 159.0 161.0 160.0 161.0 161.0 161.0 164.0 19:22:15 INFO - PROCESS | 22273 | 19:22:15 INFO - PROCESS | 22273 | [#3] audio-fft Cycles:10 Average:88.50 Median:74.00 stddev:19.04 (25.7%) stddev-sans-first:19.56 19:22:15 INFO - PROCESS | 22273 | Values: 75.0 74.0 101.0 113.0 74.0 76.0 74.0 121.0 104.0 73.0 19:22:15 INFO - PROCESS | 22273 | 19:22:15 INFO - PROCESS | 22273 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:94.50 stddev:25.81 (27.3%) stddev-sans-first:26.68 19:22:15 INFO - PROCESS | 22273 | Values: 94.0 95.0 141.0 94.0 95.0 94.0 149.0 95.0 95.0 153.0 19:22:15 INFO - PROCESS | 22273 | 19:22:15 INFO - PROCESS | 22273 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:22:15 INFO - PROCESS | 22273 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 19:22:15 INFO - PROCESS | 22273 | 19:22:15 INFO - PROCESS | 22273 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 19:22:15 INFO - PROCESS | 22273 | Values: 145.0 145.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 19:22:15 INFO - PROCESS | 22273 | 19:22:15 INFO - PROCESS | 22273 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 19:22:15 INFO - PROCESS | 22273 | Values: 95.0 94.0 95.0 94.0 94.0 95.0 95.0 94.0 94.0 95.0 19:22:15 INFO - PROCESS | 22273 | 19:22:15 INFO - PROCESS | 22273 | [#8] json-parse-financial Cycles:10 Average:68.20 Median:67.00 stddev:4.59 (6.9%) stddev-sans-first:4.72 19:22:15 INFO - PROCESS | 22273 | Values: 65.0 67.0 66.0 66.0 67.0 67.0 66.0 79.0 74.0 65.0 19:22:15 INFO - PROCESS | 22273 | 19:22:15 INFO - PROCESS | 22273 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 19:22:15 INFO - PROCESS | 22273 | Values: 65.0 65.0 65.0 65.0 65.0 66.0 65.0 65.0 64.0 65.0 19:22:15 INFO - PROCESS | 22273 | 19:22:15 INFO - PROCESS | 22273 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.00 stddev:4.24 (5.3%) stddev-sans-first:4.42 19:22:15 INFO - PROCESS | 22273 | Values: 79.0 78.0 79.0 79.0 80.0 80.0 92.0 80.0 80.0 85.0 19:22:15 INFO - PROCESS | 22273 | 19:22:15 INFO - PROCESS | 22273 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:134.00 stddev:12.50 (9.3%) stddev-sans-first:13.20 19:22:15 INFO - PROCESS | 22273 | Values: 134.0 129.0 137.0 134.0 142.0 130.0 134.0 130.0 171.0 131.0 19:22:15 INFO - PROCESS | 22273 | 19:22:15 INFO - PROCESS | 22273 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.80 Median:180.00 stddev:3.77 (2.1%) stddev-sans-first:3.99 19:22:15 INFO - PROCESS | 22273 | Values: 180.0 186.0 176.0 175.0 178.0 183.0 177.0 185.0 178.0 180.0 19:22:15 INFO - PROCESS | 22273 | 19:22:15 INFO - PROCESS | 22273 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:73.50 stddev:0.84 (1.1%) stddev-sans-first:0.87 19:22:15 INFO - PROCESS | 22273 | Values: 74.0 73.0 74.0 73.0 74.0 75.0 72.0 73.0 73.0 73.0 19:22:15 INFO - PROCESS | 22273 | -------- Summary: end -------- 19:22:15 INFO - PROCESS | 22273 | 19:22:16 INFO - TEST-INFO | 22273: exit 0 19:22:16 INFO - TEST-OK | kraken | took 63372ms 19:22:16 INFO - SUITE-END | took 1181s 19:22:16 INFO - Completed test suite (00:19:41) 19:22:16 INFO - javascript benchmark 19:22:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2569.4989477051977, 2647.5896236083404, 2656.8140230183894, 2667.906623268186, 2690.421559364737, 4485.618722408599, 4623.560761727639, 4645.419322584677, 4666.78999445025, 4687.8124875005005, 4558.430196225472, 4618.376519169911, 4634.212183928732, 4666.346711460398, 4676.4855865854815, 4152.584741525853, 4233.343831706091, 4233.703640745149, 4252.8298868045395, 4348.347747837834, 4318.611324980751, 4324.481062272532, 4350.825966961318, 4358.43340365752, 4375.562443755631, 4105.876823695294, 4147.958520414818, 4263.062126332233, 4270.765107919079, 4273.636740877029, 4247.3628955656895, 4271.295236286009, 4272.743635381887, 4279.7218180818145, 4319.740815551077, 4211.43145675333, 4259.2759230930815, 4260.531341552427, 4262.296721041024, 4309.267424537805, 4365.2142614329405, 4460.643148548108, 4482.350059241392, 4516.774161291923, 4568.200564901129, 4963.528464795839, 4980.7509624518625, 4981.12830254704, 4981.277714731344, 5016.046951079284, 4919.901601967977, 5004.699718016895, 5008.449070602231, 5010.974945125287, 5067.0879241736475, 4431.290993441034, 4553.02110046335, 4654.069186162781, 4663.533646635309, 4666.836660716858, 5063.3417655704525, 5070.721110338893, 5075.644704870623, 5096.184610462383, 5097.439281679012, 4880.511948805162, 4882.292067650171, 4883.389576302962, 4893.412790465096, 4914.33656456381, 4846.588040016568, 4943.72809495474, 5024.271480635361, 5049.469805670426, 5063.987202559503, 4907.631927605444, 4964.453910069889, 4968.6025117990475, 4970.62720295972, 5014.623903207274, 4922.926156107661, 4939.135651261086, 4940.1601727706375, 4940.431850337185, 4983.302337672729, 4048.716589838683, 4106.691998100155, 4182.519010313792, 4246.278132717445, 4259.829606815692, 3708.4622729704042, 3716.7026637869444, 3723.2925744108534, 3742.045778326509, 3785.6592906638534, 4271.444712187395, 4277.807498662568, 4281.293586558245, 4321.2005778931, 4334.43652325202, 4779.474257831635, 4978.925316120261, 4989.077020751172, 4990.2764099205415, 5049.31834202378, 4260.0840819223395, 4288.935665965013, 4289.699721019561, 4296.548862369469, 4336.34954756789, 4478.193925093449, 4498.50516443191, 4508.729476231371, 4509.774511274423, 4553.33976573395, 4556.6126879215635, 4630.930536041895, 4695.835645752382, 4720.527947205252, 4720.787564559603, 4954.8761280968265, 4967.105920934267, 4990.0, 4994.400671919393, 5043.293938848491, 4666.393368862026, 4691.08523837862, 4693.413323334583, 4701.059788042337, 4740.336352910526, 4635.536446355338, 4810.42274927011, 4832.685875418087, 4876.073546026244, 4893.143699852582, 4976.377952755905, 4992.226204938241, 4992.650514463952, 5002.024605201951, 5047.091523525801, 4667.766611669471, 4850.248211527219, 4865.635077369282, 4866.0997715421345, 4918.680285781413, 4692.41344831896, 4728.054389122258, 4732.029933863619, 4749.335093086902, 4773.594244489257, 4695.413073365829, 4719.551642593948, 4723.50403207672, 4729.385179926725, 4774.283857421415, 4663.417072865892, 4782.306565548046, 4823.831165909176, 4867.367242258484, 4880.585150262125, 4527.38880251175, 4599.609033232079, 4639.953600463952, 4675.111728771522, 4801.327814106098], "value": 4548.184168753207, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.8842231553688, 596.2070446306412, 608.9634621922683, 620.1534904854874, 628.2053202698587, 34823.303533929335, 35027.0, 35494.645053549524, 35620.82189589052, 35672.64327356726, 41248.0, 42182.7890860546, 42242.0, 42262.0, 42327.57672423275, 7251.16611589666, 7720.884186737189, 7951.085625153123, 9601.0, 9786.755331116708, 9633.518324083803, 9808.0, 9816.361936474106, 9826.312158148932, 9834.26243031772, 9792.951035244814, 9908.306418550705, 9909.653162139326, 9909.95045024774, 9921.702348929544, 9731.902680973171, 9855.359401638942, 9861.408315501092, 9864.457454839945, 9879.06148915852, 9960.501974901226, 10087.798244035079, 10097.949510252474, 10099.545520451524, 10099.646512372032, 38999.610003899885, 39489.80255098735, 39518.40722389166, 39540.80229598862, 39691.60308396908, 3240.8541615627355, 3395.337909107725, 3454.827258637083, 3517.0855577549764, 3678.0, 29310.70689293101, 30268.24329391783, 30316.242093947607, 30366.240843978856, 30949.845250773826, 3422.57217847769, 3422.9144271393166, 3443.0530119289165, 3457.6715212054814, 3594.730395220369, 236081.0, 237297.81351093308, 237677.0, 237941.0, 238308.0, 57238.14142787862, 57514.7124264376, 57557.71221143867, 57702.7114864423, 57805.421945780006, 60453.39546604566, 60486.69756651189, 60604.393956060754, 60652.0, 60665.69667151636, 14391.712165756626, 14841.70316593662, 14869.107853528823, 14885.0, 14886.255687215596, 11160.441977901073, 11220.438978051228, 11233.550657973752, 11237.94381028106, 11239.21325507223, 19325.13036913342, 19449.51376215606, 19570.70643940342, 19572.0, 19592.314269000515, 7089.184743754431, 7242.275772422821, 7283.2352602975925, 7357.926420735724, 7391.482596218213, 858.5321000054985, 923.9538023098818, 945.4610871803144, 992.151710287708, 1029.8558201851747, 27774.0, 28663.71336286652, 28972.855135724607, 29033.0, 29142.708572913998, 936.784539555906, 1007.2395341517108, 1030.9845352319571, 1057.984130238047, 1072.303003048025, 13228.404721787543, 13985.58043258704, 14283.500077497238, 14296.57110286693, 14319.713605727828, 316952.41523792234, 322512.0, 322898.0, 323246.0, 323776.0, 49854.75072624614, 50654.24018639723, 50669.0, 50672.0, 50776.74611626992, 1169.7777422289737, 1224.3143839449936, 1277.5464710027993, 1288.2850018239778, 1293.909426340166, 26423.73576264213, 27467.450650987266, 27582.44835103327, 28049.0, 28092.157235282975, 42711.0, 42785.57214427816, 43108.78445607752, 43131.353029703954, 43149.78425107854, 282165.0, 284303.0, 284723.0, 284815.0, 285291.0, 28871.278218044718, 29210.26974325574, 34255.14362140966, 38350.0, 38934.2213155741, 40373.1925361497, 40477.595224047385, 40789.592104078576, 41059.7947010263, 41389.793051034554, 34470.65529344675, 34780.0, 35451.645483545864, 35615.643843561236, 35871.46192807162, 34883.55815093021, 35203.471947921316, 35403.64596354003, 35589.82205088958, 35628.64371356253, 34225.48661770125, 34780.304393912484, 34856.65143348534, 35119.0, 35368.0, 30975.690243098183, 31572.210694732814, 31665.250212468312, 31830.204244894063, 31954.20114497156, 23542.646860296765, 24436.51126977486, 24468.0, 24702.752972470043, 24754.50490990206], "value": 18247.169851512077, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.4153482868968, 379.6326583206955, 385.89773709966863, 390.0891418537714, 399.70421887802996, 15637.921810390946, 16983.57541061474, 17173.0, 17198.0, 17251.223694933728, 16971.3211471541, 17207.22567484463, 17289.30842766288, 17536.12319384032, 17545.91227043866, 4940.901181976349, 5176.767045482943, 5205.791768329263, 5211.140161873286, 5213.713245771481, 3700.870469533567, 3898.629630185142, 5671.63134396265, 5967.880642387149, 5968.224130863004, 5843.5033022193165, 5869.501092407129, 5897.233359663238, 5914.9408505915035, 5920.970395148018, 5680.545556355502, 5830.82507524775, 5861.4724674779045, 5866.88266234675, 5867.031939729961, 3406.386850366933, 3597.4244120940784, 3598.6941110005682, 3600.6579374959338, 5001.824936127255, 19162.329318473785, 19666.803331966785, 19737.703934440993, 19946.601067978558, 20707.5858482831, 1884.5948121154017, 1911.7132430135453, 1986.632472992501, 2050.559129787103, 2373.0982226753895, 12948.676283092998, 12978.88046133042, 13143.34283285832, 13268.40292186854, 13753.174809511462, 1774.8491378232866, 1848.815118488154, 1852.935147269839, 1877.8122187781112, 1890.5368184794677, 61842.38157618411, 65534.01698974471, 66720.6663966682, 68401.65799171022, 68897.0, 9624.267631826338, 9636.373635713657, 9951.004899509991, 10034.862530702721, 10120.493975301206, 13570.117942333716, 13726.45094196241, 13731.931340343235, 13753.518626848012, 13765.793513097311, 7215.494915355875, 7247.4926755126635, 7280.563166210044, 7406.740764073232, 7415.85168296631, 6876.17485901695, 6904.344087311697, 6976.860462790716, 7085.89371159433, 7106.538075025107, 6178.41305076017, 6201.193844800147, 6232.0, 6243.625382477066, 6402.8719425611225, 1611.613212828936, 1708.5386945524638, 1767.2842498788011, 1768.8496477799274, 1784.598465345313, 900.4912224593083, 924.3160061554536, 933.3979583168818, 981.2885657897967, 1024.8052869954834, 16624.83375166233, 17210.0, 17487.475375738748, 17564.0, 17700.645987080443, 908.4413085952092, 910.1035480052143, 918.4764684130115, 926.6664000959784, 935.6573317289711, 9706.486483785075, 10199.235057370726, 10230.6419275325, 10288.691339259834, 10387.636432724817, 352223.0, 364964.0, 365271.0, 368010.0, 369249.0, 69131.96302055473, 72642.63678681679, 72726.27273727302, 73092.26907730961, 74143.62928185324, 941.289326558444, 950.496236994394, 954.3891909178132, 971.533663841346, 972.0522490571777, 15375.69248614999, 15471.149086800335, 15515.612109697347, 15689.921550392175, 15694.529164125095, 32626.673733263313, 32696.673033269362, 32952.505712413855, 33051.83474082614, 33102.17244568905, 43238.0, 44034.55965440433, 44171.337429937936, 44172.337414938156, 44246.336304954806, 7611.847763044598, 7644.885326720215, 7734.497257678233, 7769.961150194213, 7834.177411371952, 8645.394822362627, 11042.723931901766, 11181.385023823768, 11586.594469193538, 11791.410429478663, 5239.659422137549, 5880.500157486662, 9426.680264763076, 9927.354721943051, 10438.11276041545, 9906.851397229191, 9957.153641940227, 10048.397096174253, 10154.492275386348, 10200.28597998133, 5567.805126820542, 7278.6724597392185, 10184.032516910882, 10274.434906080238, 10310.278280520291, 7529.360004399688, 7540.359069479156, 7557.697692092474, 7725.845483090195, 7736.667213041398, 10224.0, 10279.074883260542, 10288.228382871164, 10310.948445257725, 10314.535845887103], "value": 8198.36414495221, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1235.962921112367, 1443.1701771481398, 1443.45870298638, 1577.2902194012697, 1745.7294119411495, 6120.632762034275, 7298.525595836273, 7465.664045117969, 7520.6991720331125, 7541.208173141817, 7306.159791623965, 7461.067366579177, 7465.664045117969, 7471.55170689759, 7473.738419155331, 1834.7523084383638, 2129.925452609159, 2148.4521447031025, 2188.2013065231154, 2220.5114874727533, 2149.0, 2182.159868450642, 2182.443476913385, 2183.8689678619335, 2188.3872515695552, 2097.1087287902656, 2155.299527653511, 2155.91376344946, 2156.7196264485597, 2158.686990386393, 1826.6620675175136, 2150.2366659835766, 2217.1131547381015, 2219.1567204462362, 2219.6226641470826, 2111.714918486, 2125.968110478344, 2136.0494579911947, 2136.957260854774, 2140.7859214078467, 7348.632568371613, 7401.0748656417945, 7401.444891633149, 7411.7035318587195, 7413.851722965511, 4393.275109606911, 4573.519780423074, 4578.496365399803, 4584.770761461914, 4585.426821647294, 2906.694797046322, 2917.985410072957, 2965.110466859955, 2984.104768569442, 2989.7907146499756, 893.749750069975, 904.5432056811268, 919.2737737187614, 920.8434566123775, 922.8800255966681, 9820.361676491077, 10086.092251697382, 10125.493725313705, 10129.442880641562, 10136.037076477724, 4020.9195816083516, 4075.0, 4156.958430415718, 4182.226288136704, 4182.937255941163, 8823.382363234512, 8854.114588541222, 8862.291016718647, 8868.113188681209, 8874.245689116497, 3833.5399752029375, 4587.977060114678, 4626.1210370029585, 4665.183592871234, 4668.5798278155125, 3981.3828856527284, 4086.0397806515443, 4087.0599762054894, 4088.9386659200136, 4096.426500289962, 3535.2399234164777, 3540.1149712571855, 3639.636036396339, 3641.9635803642154, 3660.5790334111916, 1155.774623948322, 1160.3560024186656, 1165.4580620011736, 1165.4755360087825, 1166.4109624639502, 805.8509175802495, 817.1093508076107, 844.9711309804467, 851.6635928808087, 854.1501206299771, 4800.279958006257, 4940.382452193476, 4970.030843985388, 5067.695938243717, 5070.163423035158, 391.90986073202754, 407.06984540325806, 408.1266090566191, 914.111407950872, 958.1495052219591, 3332.0836769888474, 3346.6318704942437, 3361.8655253789575, 3367.107716455141, 3408.829558522064, 8640.222379985831, 8905.332100092519, 8981.506017168987, 9009.774755631162, 9026.684066057656, 8906.55467226636, 8928.910710892807, 8935.195832375117, 8970.416922900122, 8971.05803890595, 6519.8696026079215, 6753.898691519631, 6789.660516974231, 6818.420434263143, 7093.82265443368, 5078.263651770547, 5101.0, 5107.897842043212, 5241.161414173714, 5248.8425347239645, 7984.92015079865, 8214.096449390443, 8471.745847624581, 8540.060593334852, 8555.0, 8672.219500245008, 8746.300295976434, 8752.824943500967, 8753.124687531195, 8801.163889430494, 5654.491095801233, 6408.93591064102, 6632.0, 6666.666666666551, 6793.150856142982, 7256.092988376453, 7287.708491660274, 7335.816604584928, 7342.48602597813, 7350.77947661571, 6314.55798094129, 6411.3909178627955, 6454.580452270588, 6570.8028759137305, 6610.3389661035435, 6586.473082153512, 6644.4020038196795, 6714.194296684429, 6745.543335847983, 6754.3921047106, 6117.510599152146, 6167.6916154193, 6193.225846769154, 6199.876002479835, 6200.627962322275, 4469.463664360298, 4537.977310113428, 4649.814007439664, 4683.180443422456, 4708.552687494683, 4579.9542004579525, 4689.6717229793585, 4703.341532185428, 4713.717176969393, 4716.080364328923], "value": 3989.3392567040887, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.3590696607014, 298.87895402362045, 301.43180105501125, 303.989360372387, 307.8553080052375, 4444.97777511112, 4640.327152562876, 4659.673822832403, 4712.387389639346, 4720.952790472099, 4487.798049087791, 4655.231886738692, 4656.580907718305, 4660.277656963176, 4661.930071048929, 3653.488511608377, 3702.9629703702885, 3706.703463722909, 3713.7214708896804, 3719.8140092995377, 3481.982590087046, 3553.9466907996402, 3711.1464363196483, 3725.944110838326, 3741.4761933329355, 3685.520882285299, 3698.149425632106, 3710.350688629479, 3710.9443358349645, 3715.0, 3648.179159689062, 3664.3221004114325, 3677.7057835373107, 3678.1907980244305, 3699.315626609086, 3279.852406641683, 3290.50642403639, 3297.093299342676, 3300.1254667513126, 3312.7846689965318, 4282.886449523146, 4514.887127821798, 4521.480029796583, 4535.138323718483, 4539.4779600346055, 4126.938095928564, 4150.64719498843, 4151.46031015969, 4156.5635608261, 4159.91680166398, 4919.728380626879, 4927.975360123212, 4933.53131452515, 4935.876603084916, 4942.827001054946, 3301.2077101495706, 3487.3548393547276, 3504.8948531544092, 3507.2108775525558, 3509.1578021274963, 5108.846734597968, 5124.9743751281, 5142.562882155022, 5153.0, 5153.7165455900285, 3575.4100573405617, 3583.6492879158072, 3589.2283159120916, 3592.1019745063736, 3598.5142005829402, 3612.6026137124895, 3619.8552057917914, 3628.1473853644375, 3638.6361363863402, 3646.343658141507, 3905.160390515996, 4109.0, 4117.691173162025, 4131.0, 4148.79256037197, 4894.19245824435, 4904.239842824368, 4913.803447862046, 4924.113659541317, 4925.285833554115, 1241.6895776055985, 1271.4850485553366, 1301.919406892277, 1318.5780550224029, 1322.4842311498523, 853.2576658307312, 865.948043117415, 866.9826603467895, 869.1525762381754, 872.8516152254132, 4569.588737013684, 4583.770811459413, 4592.885177870513, 4595.977020114878, 4610.124076425468, 5328.0, 5345.70598617072, 5354.892902141935, 5358.0, 5365.1147560652835, 4479.0, 4555.589996900295, 4570.748608826547, 4579.9084018319445, 4584.747838868894, 2808.775297976157, 2854.22935807335, 2857.8999735009593, 2869.0962346860674, 2873.956890646642, 5024.773885175103, 5043.092243396224, 5043.2687260347775, 5043.899122017539, 5045.84862454127, 5284.524392804589, 5454.427285135083, 5459.181122831527, 5475.698836564027, 5476.479734425223, 5042.621803364689, 5044.4198917125, 5047.091523525874, 5047.545720885138, 5052.787331040598, 5307.310049693515, 5320.17537281722, 5328.440513746156, 5336.599755018312, 5341.839744807662, 5057.266696329085, 5207.817726379559, 5210.140326846028, 5224.451432599522, 5227.973860130675, 4982.2775697524385, 5034.370703662043, 5037.345145131109, 5047.646664733434, 5058.2918391425965, 3692.1138926657945, 3693.2613477304108, 3702.9629703702617, 3704.759190652599, 3718.330700473941, 4780.689255198401, 4845.563899249085, 5307.708076055854, 5317.441668624739, 5318.97340513295, 4776.164171269945, 4884.633652476007, 4929.704217746947, 4951.0, 4952.529509696573, 4930.901381972412, 4937.456879743298, 4945.431275403231, 4950.77721502526, 4965.751712414437, 4633.513481084437, 4856.805727770849, 4858.319835223142, 4869.634777391639, 4871.853844384674, 5009.649324547392, 5016.344606279846, 5025.321581586439, 5029.862308518792, 5036.798528058836, 4895.828645997373, 4910.337104490848, 4912.7543622818, 4918.827841025547, 4920.2619607057795], "value": 3780.7155184788153, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.1132380695609, 643.2795269298387, 651.8852761777364, 665.9533832631716, 743.6244696428306, 12285.508579656815, 12299.32353720545, 12477.31374774387, 12522.248665080078, 12523.311217883036, 11697.122715796308, 11763.35301558414, 11771.587994420197, 11786.116041296895, 11824.349660768654, 599.4155698194269, 766.8696321625337, 797.5254723439544, 800.1558355934487, 807.4872455990459, 813.2802469814197, 816.0330008939396, 817.9222973817477, 818.3657665309403, 818.4352796570378, 865.1694373401542, 866.3545658484438, 867.3234876796078, 868.04515033463, 868.4745728834059, 669.6250099944023, 826.396730386821, 860.3805260212637, 865.7922098696267, 866.1468453573225, 612.3111499562991, 613.058954504833, 613.1324176290589, 613.1844646619985, 614.6588643302965, 11367.147463940237, 11414.543418263342, 11463.426828658618, 11465.426728663533, 11489.597864074718, 11543.480543375568, 12047.518099276018, 12311.815322770166, 12335.876641233563, 12561.246325220516, 9868.0, 9936.956619554987, 9977.950110249474, 10007.29948903577, 11169.385683787388, 4158.334666453383, 4217.283061879488, 4238.533761286256, 4377.934330985037, 4385.583369579885, 39742.60257397418, 39838.0, 40100.19799603992, 40129.0, 40650.9999999997, 9780.31537792362, 10197.643082492077, 10209.99999999985, 10221.233407494468, 10559.788804223872, 17561.297548098188, 18147.63704725898, 18155.909220453814, 18161.727574086133, 18212.36256731008, 6801.387875091265, 6815.318468153145, 6843.520953533304, 6856.725730970805, 7027.89458158128, 3743.082944678571, 3796.430535419709, 3818.9236215275537, 3870.109874728772, 3874.3219936511, 2906.4768341698696, 2973.52423612221, 2976.4047190561973, 2983.254186453387, 2987.208389776711, 491.17482629183314, 510.4130250212286, 523.0924346259237, 525.7975679363473, 534.2467121358943, 436.56561721087724, 456.41350864139423, 469.7416420968522, 535.7133933345641, 551.2915903064622, 7343.742968996059, 7423.8011260598005, 7687.154413014564, 7733.226677332222, 7795.220477952273, 564.2044716949164, 588.4380416702124, 593.652713162796, 619.454879705856, 651.4462706699362, 3933.9213215735526, 4010.3583426651594, 4119.258533463945, 4191.97904010478, 4239.936400953989, 53837.0, 61482.0777688335, 61527.692361537906, 61650.38349616536, 61721.38278617156, 49961.750191249535, 50947.745261273456, 51164.74417627888, 52156.21765673518, 53536.732316338166, 44912.326315105296, 45661.54338456573, 45725.0, 46564.0, 47441.76279118582, 7845.3723702104835, 7933.325667318342, 8111.718033571305, 8155.0, 8391.118932511998, 30395.0, 30476.542851857685, 30722.539161913035, 30762.38475230438, 31171.37657246797, 40100.39347442407, 42115.368269475366, 42471.78764106159, 42593.0, 42816.0, 11012.724681883017, 11091.0, 11120.0, 11176.888231117584, 11535.250208736405, 11354.26197297173, 11514.42427878586, 11633.47649355764, 11838.33637431571, 11840.348780817138, 8042.9597852010365, 9865.0, 10333.0, 10567.10179634709, 10750.13998880072, 10232.0, 10313.896861031293, 10821.404822734825, 10845.891541084487, 10965.561377545127, 9693.466859322805, 10058.698239052841, 10268.178545716473, 10271.435071071162, 10414.739631509274, 8520.531370774666, 8793.692220772242, 9087.727368178965, 9259.379608568339, 9435.575399107194, 8672.479651220947, 8774.34192435557, 9108.499032553273, 9117.77205569866, 9179.127982841886], "value": 5942.665549537335, "unit": "score"}], "name": "dromaeo_css", "value": 6274.008831618541, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 109.0, 113.0, 115.0, 116.0, 105.0, 113.0, 114.0, 114.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 162.0, 190.0, 134.0, 157.0, 172.0, 136.0, 187.0, 133.0], "value": 156.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 159.0, 161.0, 160.0, 161.0, 161.0, 161.0, 164.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 101.0, 113.0, 74.0, 76.0, 74.0, 121.0, 104.0, 73.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 141.0, 94.0, 95.0, 94.0, 149.0, 95.0, 95.0, 153.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 66.0, 67.0, 67.0, 66.0, 79.0, 74.0, 65.0], "value": 68.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 64.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 79.0, 80.0, 80.0, 92.0, 80.0, 80.0, 85.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 129.0, 137.0, 134.0, 142.0, 130.0, 134.0, 130.0, 171.0, 131.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 186.0, 176.0, 175.0, 178.0, 183.0, 177.0, 185.0, 178.0, 180.0], "value": 179.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 73.0, 74.0, 75.0, 72.0, 73.0, 73.0, 73.0], "value": 73.4, "unit": "score"}], "name": "kraken", "value": 1590.8000000000002, "alertThreshold": 2.0}]} 19:22:16 INFO - Return code: 0 19:22:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:22:17 ERROR - # TBPL SUCCESS # 19:22:17 INFO - Running post-action listener: _resource_record_post_action 19:22:17 INFO - Running post-run listener: _resource_record_post_run 19:22:18 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 524939264; Read time: 0; Write time: 531084 19:22:18 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 241864704; Read time: 0; Write time: 371888 19:22:18 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 283074560; Read time: 0; Write time: 159196 19:22:18 INFO - Running post-run listener: _upload_blobber_files 19:22:18 INFO - Blob upload gear active. 19:22:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:22:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:22:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:22:18 INFO - (blobuploader) - INFO - Open directory for files ... 19:22:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:22:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:22:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:22:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:19 INFO - (blobuploader) - INFO - Done attempting. 19:22:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:22:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:22:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:22:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:20 INFO - (blobuploader) - INFO - Done attempting. 19:22:20 INFO - (blobuploader) - INFO - Iteration through files over. 19:22:20 INFO - Return code: 0 19:22:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:22:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:22:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d65c2d7827dfd7d80b95a48d54e46a6621bbcb7f1667f098efff10d66c345ee5b51da51655ad642c228df90de57e376d9c5fedc5ad1a2eca40e946deafa949da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83f99366ea900ca9437a0ada5609ba1cdec655eac8b9d9622a2462af81012af9738e72775c04bb14ef91f6591f044d6197b5dfd435de449a8f51ea57b4dc4e6b"} 19:22:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:22:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:22:20 INFO - Contents: 19:22:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d65c2d7827dfd7d80b95a48d54e46a6621bbcb7f1667f098efff10d66c345ee5b51da51655ad642c228df90de57e376d9c5fedc5ad1a2eca40e946deafa949da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83f99366ea900ca9437a0ada5609ba1cdec655eac8b9d9622a2462af81012af9738e72775c04bb14ef91f6591f044d6197b5dfd435de449a8f51ea57b4dc4e6b"} 19:22:20 INFO - Running post-run listener: copy_logs_to_upload_dir 19:22:20 INFO - Copying logs to upload dir... 19:22:20 INFO - mkdir: /builds/slave/test/build/upload/logs 19:22:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.355402 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-25 19:22:19.989495) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 19:22:19.993247) ========= 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=8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864 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/d65c2d7827dfd7d80b95a48d54e46a6621bbcb7f1667f098efff10d66c345ee5b51da51655ad642c228df90de57e376d9c5fedc5ad1a2eca40e946deafa949da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83f99366ea900ca9437a0ada5609ba1cdec655eac8b9d9622a2462af81012af9738e72775c04bb14ef91f6591f044d6197b5dfd435de449a8f51ea57b4dc4e6b"} build_url:https://queue.taskcluster.net/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011447 build_url: 'https://queue.taskcluster.net/v1/task/Bh86kMFBQDuAXtxLAY7afw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d65c2d7827dfd7d80b95a48d54e46a6621bbcb7f1667f098efff10d66c345ee5b51da51655ad642c228df90de57e376d9c5fedc5ad1a2eca40e946deafa949da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83f99366ea900ca9437a0ada5609ba1cdec655eac8b9d9622a2462af81012af9738e72775c04bb14ef91f6591f044d6197b5dfd435de449a8f51ea57b4dc4e6b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 19:22:20.018083) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 19:22:20.018419) ========= 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=8887e36bb8e381bfd44124ac000001a8-1461635972.410266-1705964864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 19:22:20.103295) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 19:22:20.103639) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 19:22:20.103967) ========= ========= Total master_lag: 0.18 =========