builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1463594956.62 results: success (0) buildid: 20160518083057 builduid: 08c91977155d4d7399b5439ac31657ca revision: 8f36fe8daf67cd1a586c9ec2009fc72f2d3624a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 11:09:16.624692) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 11:09:16.625111) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 11:09:16.625478) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 11:09:16.641697) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 11:09:16.642150) ========= 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=14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 11:09:16-- 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% 219M=0s 2016-05-18 11:09:16 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084346 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 11:09:16.743104) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 11:09:16.743699) ========= 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=14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016707 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 11:09:16.797709) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 11:09:16.798060) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8f36fe8daf67cd1a586c9ec2009fc72f2d3624a9 --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 8f36fe8daf67cd1a586c9ec2009fc72f2d3624a9 --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=14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 11:09:16,901 truncating revision to first 12 chars 2016-05-18 11:09:16,901 Setting DEBUG logging. 2016-05-18 11:09:16,901 attempt 1/10 2016-05-18 11:09:16,901 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8f36fe8daf67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 11:09:17,242 unpacking tar archive at: fx-team-8f36fe8daf67/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644477 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 11:09:17.457095) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 11:09:17.457418) ========= script_repo_revision: 8f36fe8daf67cd1a586c9ec2009fc72f2d3624a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 11:09:17.457877) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 11:09:17.458148) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 11:09:17.465368) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-18 11:09:17.465667) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:09:17 INFO - MultiFileLogger online at 20160518 11:09:17 in /builds/slave/test 11:09:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:09:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:09:17 INFO - {'append_to_log': False, 11:09:17 INFO - 'base_work_dir': '/builds/slave/test', 11:09:17 INFO - 'blob_upload_branch': 'Fx-Team', 11:09:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:09:17 INFO - 'branch': 'Fx-Team', 11:09:17 INFO - 'buildbot_json_path': 'buildprops.json', 11:09:17 INFO - 'config_files': ('talos/linux_config.py',), 11:09:17 INFO - 'default_actions': ('clobber', 11:09:17 INFO - 'read-buildbot-config', 11:09:17 INFO - 'download-and-extract', 11:09:17 INFO - 'populate-webroot', 11:09:17 INFO - 'create-virtualenv', 11:09:17 INFO - 'install', 11:09:17 INFO - 'run-tests'), 11:09:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:09:17 INFO - 'download_minidump_stackwalk': True, 11:09:17 INFO - 'download_symbols': 'ondemand', 11:09:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:09:17 INFO - 'tooltool.py': '/tools/tooltool.py', 11:09:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:09:17 INFO - '/tools/misc-python/virtualenv.py')}, 11:09:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:09:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:09:17 INFO - 'installer_path': 'installer.exe', 11:09:17 INFO - 'log_level': 'info', 11:09:17 INFO - 'log_name': 'talos', 11:09:17 INFO - 'log_to_console': True, 11:09:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:09:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:09:17 INFO - 'opt_config_files': (), 11:09:17 INFO - 'pip_index': False, 11:09:17 INFO - 'sps_profile': False, 11:09:17 INFO - 'sps_profile_interval': 0, 11:09:17 INFO - 'suite': 'dromaeojs', 11:09:17 INFO - 'system_bits': '32', 11:09:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:09:17 INFO - 'title': 'talos-linux64-ix-036', 11:09:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:09:17 INFO - 'use_talos_json': True, 11:09:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:09:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:09:17 INFO - 'work_dir': 'build'} 11:09:17 INFO - ##### 11:09:17 INFO - ##### Running clobber step. 11:09:17 INFO - ##### 11:09:17 INFO - Running pre-action listener: _resource_record_pre_action 11:09:17 INFO - Running main action method: clobber 11:09:17 INFO - rmtree: /builds/slave/test/build 11:09:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:09:18 INFO - Running post-action listener: _resource_record_post_action 11:09:18 INFO - ##### 11:09:18 INFO - ##### Finished clobber step (success) 11:09:18 INFO - ##### 11:09:18 INFO - ##### 11:09:18 INFO - ##### Running read-buildbot-config step. 11:09:18 INFO - ##### 11:09:18 INFO - Running pre-action listener: _resource_record_pre_action 11:09:18 INFO - Running main action method: read_buildbot_config 11:09:18 INFO - Using buildbot properties: 11:09:18 INFO - { 11:09:18 INFO - "project": "", 11:09:18 INFO - "product": "firefox", 11:09:18 INFO - "script_repo_revision": "production", 11:09:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:09:18 INFO - "repository": "", 11:09:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:09:18 INFO - "buildid": "20160518083057", 11:09:18 INFO - "pgo_build": "True", 11:09:18 INFO - "basedir": "/builds/slave/test", 11:09:18 INFO - "buildnumber": 104, 11:09:18 INFO - "slavename": "talos-linux64-ix-036", 11:09:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:09:18 INFO - "platform": "ubuntu64_hw", 11:09:18 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:09:18 INFO - "branch": "fx-team", 11:09:18 INFO - "repo_path": "integration/fx-team", 11:09:18 INFO - "revision": "8f36fe8daf67cd1a586c9ec2009fc72f2d3624a9", 11:09:18 INFO - "stage_platform": "linux64-pgo", 11:09:18 INFO - "builduid": "08c91977155d4d7399b5439ac31657ca", 11:09:18 INFO - "slavebuilddir": "test" 11:09:18 INFO - } 11:09:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:09:18 INFO - Running post-action listener: _resource_record_post_action 11:09:18 INFO - ##### 11:09:18 INFO - ##### Finished read-buildbot-config step (success) 11:09:18 INFO - ##### 11:09:18 INFO - ##### 11:09:18 INFO - ##### Running download-and-extract step. 11:09:18 INFO - ##### 11:09:18 INFO - Running pre-action listener: _resource_record_pre_action 11:09:18 INFO - Running main action method: download_and_extract 11:09:18 INFO - mkdir: /builds/slave/test/build/tests 11:09:18 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')]} 11:09:18 INFO - https://queue.taskcluster.net/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:09:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:09:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:09:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/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 11:09:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/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 11:09:20 INFO - Downloaded 1361 bytes. 11:09:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:09:20 INFO - Using the following test package requirements: 11:09:20 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:09:20 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:09:20 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:09:20 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:09:20 INFO - u'jsshell-linux-x86_64.zip'], 11:09:20 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:09:20 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:09:20 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:09:20 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:09:20 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:09:20 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:09:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:20 INFO - https://queue.taskcluster.net/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/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 11:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/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 11:09:21 INFO - Downloaded 24063312 bytes. 11:09:21 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'] 11:09:21 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 11:09:23 INFO - Return code: 0 11:09:23 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 11:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:23 INFO - https://queue.taskcluster.net/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:09:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:09:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:09:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/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 11:09:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/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 11:09:24 INFO - Downloaded 24063312 bytes. 11:09:24 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'] 11:09:24 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 11:09:26 INFO - Return code: 0 11:09:26 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')]} 11:09:26 INFO - https://queue.taskcluster.net/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:09:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:09:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:09:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/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 11:09:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/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 11:09:29 INFO - Downloaded 10840194 bytes. 11:09:29 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'] 11:09:29 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 11:09:29 INFO - Return code: 0 11:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:29 INFO - https://queue.taskcluster.net/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:09:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:09:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:09:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/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 11:09:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFhGv1rwSceQJBEno8a97A/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 11:09:35 INFO - Downloaded 58375951 bytes. 11:09:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:09:35 INFO - mkdir: /builds/slave/test/properties 11:09:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:09:35 INFO - Writing to file /builds/slave/test/properties/build_url 11:09:35 INFO - Contents: 11:09:35 INFO - build_url:https://queue.taskcluster.net/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:09:36 WARNING - Can't figure out symbols_url from installer_url: https://queue.taskcluster.net/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2! 11:09:36 WARNING - Traceback (most recent call last): 11:09:36 WARNING - 11:09:36 WARNING - File "/builds/slave/test/scripts/mozharness/mozilla/testing/testbase.py", line 200, in query_symbols_url 11:09:36 WARNING - self._urlopen(symbols_url, timeout=120) 11:09:36 WARNING - 11:09:36 WARNING - File "/builds/slave/test/scripts/mozharness/mozilla/testing/testbase.py", line 292, in _urlopen 11:09:36 WARNING - return urllib2.urlopen(url, **kwargs) 11:09:36 WARNING - 11:09:36 WARNING - File "/usr/lib/python2.7/urllib2.py", line 126, in urlopen 11:09:36 WARNING - return _opener.open(url, data, timeout) 11:09:36 WARNING - 11:09:36 WARNING - File "/usr/lib/python2.7/urllib2.py", line 406, in open 11:09:36 WARNING - response = meth(req, response) 11:09:36 WARNING - 11:09:36 WARNING - File "/usr/lib/python2.7/urllib2.py", line 519, in http_response 11:09:36 WARNING - 'http', request, response, code, msg, hdrs) 11:09:36 WARNING - 11:09:36 WARNING - File "/usr/lib/python2.7/urllib2.py", line 438, in error 11:09:36 WARNING - result = self._call_chain(*args) 11:09:36 WARNING - 11:09:36 WARNING - File "/usr/lib/python2.7/urllib2.py", line 378, in _call_chain 11:09:36 WARNING - result = func(*args) 11:09:36 WARNING - 11:09:36 WARNING - File "/usr/lib/python2.7/urllib2.py", line 625, in http_error_302 11:09:36 WARNING - return self.parent.open(new, timeout=req.timeout) 11:09:36 WARNING - 11:09:36 WARNING - File "/usr/lib/python2.7/urllib2.py", line 406, in open 11:09:36 WARNING - response = meth(req, response) 11:09:36 WARNING - 11:09:36 WARNING - File "/usr/lib/python2.7/urllib2.py", line 519, in http_response 11:09:36 WARNING - 'http', request, response, code, msg, hdrs) 11:09:36 WARNING - 11:09:36 WARNING - File "/usr/lib/python2.7/urllib2.py", line 444, in error 11:09:36 WARNING - return self._call_chain(*args) 11:09:36 WARNING - 11:09:36 WARNING - File "/usr/lib/python2.7/urllib2.py", line 378, in _call_chain 11:09:36 WARNING - result = func(*args) 11:09:36 WARNING - 11:09:36 WARNING - File "/usr/lib/python2.7/urllib2.py", line 527, in http_error_default 11:09:36 WARNING - raise HTTPError(req.get_full_url(), code, msg, hdrs, fp) 11:09:36 WARNING - 11:09:36 WARNING - HTTPError: HTTP Error 503: Service Unavailable 11:09:36 WARNING - 11:09:36 WARNING - No symbols_url found. Let minidump_stackwalk query for symbols. 11:09:36 INFO - Running post-action listener: _resource_record_post_action 11:09:36 INFO - Running post-action listener: set_extra_try_arguments 11:09:36 INFO - ##### 11:09:36 INFO - ##### Finished download-and-extract step (success) 11:09:36 INFO - ##### 11:09:36 INFO - ##### 11:09:36 INFO - ##### Running populate-webroot step. 11:09:36 INFO - ##### 11:09:36 INFO - Running pre-action listener: _resource_record_pre_action 11:09:36 INFO - Running main action method: populate_webroot 11:09:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:09:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:09:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:09:36 INFO - '--tppagecycles', 11:09:36 INFO - '7'], 11:09:36 INFO - 'tests': ['tsvgm']}}, 11:09:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:09:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:09:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:09:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:09:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:09:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:09:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:36 INFO - 'talos_options': ['--disable-e10s'], 11:09:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:36 INFO - 'talos_options': ['--disable-e10s'], 11:09:36 INFO - 'tests': ['damp', 'tps']}, 11:09:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:36 INFO - 'tests': ['damp', 'tps']}, 11:09:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:09:36 INFO - 'tests': ['dromaeo_dom']}, 11:09:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:09:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:09:36 INFO - 'tests': ['a11yr', 11:09:36 INFO - 'ts_paint', 11:09:36 INFO - 'tpaint', 11:09:36 INFO - 'sessionrestore', 11:09:36 INFO - 'sessionrestore_no_auto_restore', 11:09:36 INFO - 'tabpaint']}, 11:09:36 INFO - 'other-e10s': {'tests': ['a11yr', 11:09:36 INFO - 'ts_paint', 11:09:36 INFO - 'tpaint', 11:09:36 INFO - 'sessionrestore', 11:09:36 INFO - 'sessionrestore_no_auto_restore', 11:09:36 INFO - 'tabpaint']}, 11:09:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:09:36 INFO - 'ts_paint', 11:09:36 INFO - 'tpaint', 11:09:36 INFO - 'sessionrestore', 11:09:36 INFO - 'sessionrestore_no_auto_restore', 11:09:36 INFO - 'tabpaint']}, 11:09:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:09:36 INFO - 'ts_paint', 11:09:36 INFO - 'tpaint', 11:09:36 INFO - 'sessionrestore', 11:09:36 INFO - 'sessionrestore_no_auto_restore', 11:09:36 INFO - 'tabpaint']}, 11:09:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:09:36 INFO - 'tests': ['a11yr', 11:09:36 INFO - 'ts_paint', 11:09:36 INFO - 'tpaint', 11:09:36 INFO - 'sessionrestore', 11:09:36 INFO - 'sessionrestore_no_auto_restore', 11:09:36 INFO - 'tabpaint']}, 11:09:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:09:36 INFO - 'tests': ['a11yr', 11:09:36 INFO - 'ts_paint', 11:09:36 INFO - 'tpaint', 11:09:36 INFO - 'sessionrestore', 11:09:36 INFO - 'sessionrestore_no_auto_restore', 11:09:36 INFO - 'tabpaint']}, 11:09:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:09:36 INFO - 'tests': ['tsvgx', 11:09:36 INFO - 'tsvgr_opacity', 11:09:36 INFO - 'tart', 11:09:36 INFO - 'tscrollx', 11:09:36 INFO - 'cart']}, 11:09:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:09:36 INFO - 'tsvgr_opacity', 11:09:36 INFO - 'tart', 11:09:36 INFO - 'tscrollx', 11:09:36 INFO - 'cart']}, 11:09:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:36 INFO - 'talos_options': ['--disable-e10s'], 11:09:36 INFO - 'tests': ['tp5o']}, 11:09:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:36 INFO - 'tests': ['tp5o']}, 11:09:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:36 INFO - 'talos_options': ['--disable-e10s', 11:09:36 INFO - '--xperf_path', 11:09:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:36 INFO - 'tests': ['tp5n']}, 11:09:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:36 INFO - 'talos_options': ['--xperf_path', 11:09:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:36 INFO - 'tests': ['tp5n']}}, 11:09:36 INFO - 'talos.zip': {'path': '', 11:09:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:09:36 INFO - Running post-action listener: _resource_record_post_action 11:09:36 INFO - ##### 11:09:36 INFO - ##### Finished populate-webroot step (success) 11:09:36 INFO - ##### 11:09:36 INFO - ##### 11:09:36 INFO - ##### Running create-virtualenv step. 11:09:36 INFO - ##### 11:09:36 INFO - Running pre-action listener: _resource_record_pre_action 11:09:36 INFO - Running main action method: create_virtualenv 11:09:36 INFO - Creating virtualenv /builds/slave/test/build/venv 11:09:36 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 11:09:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:09:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:09:36 INFO - Using real prefix '/usr' 11:09:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:09:36 INFO - Installing distribute.............................................................................................................................................................................................done. 11:09:38 INFO - Installing pip.................done. 11:09:38 INFO - Return code: 0 11:09:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:09:38 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')]} 11:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:38 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')]} 11:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:38 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 0x7fd64e646f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10299c0>, '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 0x102a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', '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 11:09:38 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 11:09:38 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 11:09:38 INFO - Using env: {'DISPLAY': ':0', 11:09:38 INFO - 'HOME': '/home/cltbld', 11:09:38 INFO - 'LANG': 'en_US.UTF-8', 11:09:38 INFO - 'LANGUAGE': 'en_US:en', 11:09:38 INFO - 'LOGNAME': 'cltbld', 11:09:38 INFO - 'MAIL': '/var/mail/cltbld', 11:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:38 INFO - 'MOZ_NO_REMOTE': '1', 11:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:38 INFO - 'NO_EM_RESTART': '1', 11:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:38 INFO - 'PWD': '/builds/slave/test', 11:09:38 INFO - 'SHELL': '/bin/bash', 11:09:38 INFO - 'SHLVL': '1', 11:09:38 INFO - 'TERM': 'linux', 11:09:38 INFO - 'TMOUT': '86400', 11:09:38 INFO - 'USER': 'cltbld', 11:09:38 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', 11:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:38 INFO - '_': '/tools/buildbot/bin/python'} 11:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:39 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 11:09:39 INFO - Cleaning up... 11:09:39 INFO - Return code: 0 11:09:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:39 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd64e646f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10299c0>, '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 0x102a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', '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 11:09:39 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>=3.1.1'] in /builds/slave/test/build 11:09:39 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>=3.1.1 11:09:39 INFO - Using env: {'DISPLAY': ':0', 11:09:39 INFO - 'HOME': '/home/cltbld', 11:09:39 INFO - 'LANG': 'en_US.UTF-8', 11:09:39 INFO - 'LANGUAGE': 'en_US:en', 11:09:39 INFO - 'LOGNAME': 'cltbld', 11:09:39 INFO - 'MAIL': '/var/mail/cltbld', 11:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:39 INFO - 'MOZ_NO_REMOTE': '1', 11:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:39 INFO - 'NO_EM_RESTART': '1', 11:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:39 INFO - 'PWD': '/builds/slave/test', 11:09:39 INFO - 'SHELL': '/bin/bash', 11:09:39 INFO - 'SHLVL': '1', 11:09:39 INFO - 'TERM': 'linux', 11:09:39 INFO - 'TMOUT': '86400', 11:09:39 INFO - 'USER': 'cltbld', 11:09:39 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', 11:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:39 INFO - '_': '/tools/buildbot/bin/python'} 11:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:39 INFO - Downloading/unpacking psutil>=3.1.1 11:09:39 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 11:09:39 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 11:09:39 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 11:09:39 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 11:09:39 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 11:09:39 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 11:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:09:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:41 INFO - Installing collected packages: psutil 11:09:41 INFO - Running setup.py install for psutil 11:09:41 INFO - building 'psutil._psutil_linux' extension 11:09:41 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 11:09:41 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 11:09:41 INFO - building 'psutil._psutil_posix' extension 11:09:41 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 11:09:41 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 11:09:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:41 INFO - Successfully installed psutil 11:09:41 INFO - Cleaning up... 11:09:41 INFO - Return code: 0 11:09:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:41 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd64e646f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10299c0>, '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 0x102a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', '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 11:09:41 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.3'] in /builds/slave/test/build 11:09:41 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.3 11:09:41 INFO - Using env: {'DISPLAY': ':0', 11:09:41 INFO - 'HOME': '/home/cltbld', 11:09:41 INFO - 'LANG': 'en_US.UTF-8', 11:09:41 INFO - 'LANGUAGE': 'en_US:en', 11:09:41 INFO - 'LOGNAME': 'cltbld', 11:09:41 INFO - 'MAIL': '/var/mail/cltbld', 11:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:41 INFO - 'MOZ_NO_REMOTE': '1', 11:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:41 INFO - 'NO_EM_RESTART': '1', 11:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:41 INFO - 'PWD': '/builds/slave/test', 11:09:41 INFO - 'SHELL': '/bin/bash', 11:09:41 INFO - 'SHLVL': '1', 11:09:41 INFO - 'TERM': 'linux', 11:09:41 INFO - 'TMOUT': '86400', 11:09:41 INFO - 'USER': 'cltbld', 11:09:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', 11:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:41 INFO - '_': '/tools/buildbot/bin/python'} 11:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:09:42 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 11:09:42 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 11:09:42 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 11:09:42 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 11:09:42 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 11:09:42 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 11:09:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:09:44 INFO - Installing collected packages: mozsystemmonitor 11:09:44 INFO - Running setup.py install for mozsystemmonitor 11:09:44 INFO - Successfully installed mozsystemmonitor 11:09:44 INFO - Cleaning up... 11:09:44 INFO - Return code: 0 11:09:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:09: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')]} 11:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09: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')]} 11:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:44 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 0x7fd64e646f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10299c0>, '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 0x102a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', '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 11:09:44 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 11:09:44 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 11:09:44 INFO - Using env: {'DISPLAY': ':0', 11:09:44 INFO - 'HOME': '/home/cltbld', 11:09:44 INFO - 'LANG': 'en_US.UTF-8', 11:09:44 INFO - 'LANGUAGE': 'en_US:en', 11:09:44 INFO - 'LOGNAME': 'cltbld', 11:09:44 INFO - 'MAIL': '/var/mail/cltbld', 11:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:44 INFO - 'MOZ_NO_REMOTE': '1', 11:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:44 INFO - 'NO_EM_RESTART': '1', 11:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:44 INFO - 'PWD': '/builds/slave/test', 11:09:44 INFO - 'SHELL': '/bin/bash', 11:09:44 INFO - 'SHLVL': '1', 11:09:44 INFO - 'TERM': 'linux', 11:09:44 INFO - 'TMOUT': '86400', 11:09:44 INFO - 'USER': 'cltbld', 11:09:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', 11:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:44 INFO - '_': '/tools/buildbot/bin/python'} 11:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:44 INFO - Downloading/unpacking blobuploader==1.2.4 11:09:44 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 11:09:44 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 11:09:44 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 11:09:44 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 11:09:44 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 11:09:44 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 11:09:46 INFO - Downloading blobuploader-1.2.4.tar.gz 11:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:09:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:09:46 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 11:09:46 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 11:09:46 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 11:09:46 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 11:09:46 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 11:09:46 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 11:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:09:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:09:46 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 11:09:46 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 11:09:46 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 11:09:46 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 11:09:46 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 11:09:46 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 11:09:46 INFO - Downloading docopt-0.6.1.tar.gz 11:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:09:47 INFO - Installing collected packages: blobuploader, requests, docopt 11:09:47 INFO - Running setup.py install for blobuploader 11:09:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:09:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:09:47 INFO - Running setup.py install for requests 11:09:47 INFO - Running setup.py install for docopt 11:09:47 INFO - Successfully installed blobuploader requests docopt 11:09:47 INFO - Cleaning up... 11:09:47 INFO - Return code: 0 11:09:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09: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')]} 11:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09: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')]} 11:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:47 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 0x7fd64e646f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10299c0>, '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 0x102a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', '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 11:09:47 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 11:09:47 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 11:09:47 INFO - Using env: {'DISPLAY': ':0', 11:09:47 INFO - 'HOME': '/home/cltbld', 11:09:47 INFO - 'LANG': 'en_US.UTF-8', 11:09:47 INFO - 'LANGUAGE': 'en_US:en', 11:09:47 INFO - 'LOGNAME': 'cltbld', 11:09:47 INFO - 'MAIL': '/var/mail/cltbld', 11:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:47 INFO - 'MOZ_NO_REMOTE': '1', 11:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:47 INFO - 'NO_EM_RESTART': '1', 11:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:47 INFO - 'PWD': '/builds/slave/test', 11:09:47 INFO - 'SHELL': '/bin/bash', 11:09:47 INFO - 'SHLVL': '1', 11:09:47 INFO - 'TERM': 'linux', 11:09:47 INFO - 'TMOUT': '86400', 11:09:47 INFO - 'USER': 'cltbld', 11:09:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', 11:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:47 INFO - '_': '/tools/buildbot/bin/python'} 11:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:47 INFO - Running setup.py (path:/tmp/pip-5Bw5oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:47 INFO - Running setup.py (path:/tmp/pip-tv42hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:48 INFO - Running setup.py (path:/tmp/pip-12j313-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:48 INFO - Running setup.py (path:/tmp/pip-i6wMne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:48 INFO - Running setup.py (path:/tmp/pip-Pt4yzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:48 INFO - Running setup.py (path:/tmp/pip-hluziL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:48 INFO - Running setup.py (path:/tmp/pip-SmxbHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:48 INFO - Running setup.py (path:/tmp/pip-pb7qhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:48 INFO - Running setup.py (path:/tmp/pip-sMvDO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:48 INFO - Running setup.py (path:/tmp/pip-2rcM45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:48 INFO - Running setup.py (path:/tmp/pip-3SiZjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:48 INFO - Running setup.py (path:/tmp/pip-GgqUCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:48 INFO - Running setup.py (path:/tmp/pip-OaY6po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:48 INFO - Running setup.py (path:/tmp/pip-19gz23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:48 INFO - Running setup.py (path:/tmp/pip-n_ELYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:48 INFO - Running setup.py (path:/tmp/pip-o1Qs3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:49 INFO - Running setup.py (path:/tmp/pip-f8kVH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:09:49 INFO - Running setup.py install for manifestparser 11:09:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:09:49 INFO - Running setup.py install for mozcrash 11:09:49 INFO - Running setup.py install for mozdebug 11:09:49 INFO - Running setup.py install for mozdevice 11:09:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:09:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:09:49 INFO - Running setup.py install for mozfile 11:09:49 INFO - Running setup.py install for mozhttpd 11:09:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:09:49 INFO - Running setup.py install for mozinfo 11:09:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:09:49 INFO - Running setup.py install for mozInstall 11:09:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:09:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:09:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:09:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:09:49 INFO - Running setup.py install for mozleak 11:09:50 INFO - Running setup.py install for mozlog 11:09:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:09:50 INFO - Running setup.py install for moznetwork 11:09:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:09:50 INFO - Running setup.py install for mozprocess 11:09:50 INFO - Running setup.py install for mozprofile 11:09:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:09:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:09:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:09:50 INFO - Running setup.py install for mozrunner 11:09:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:09:50 INFO - Running setup.py install for mozscreenshot 11:09:50 INFO - Running setup.py install for moztest 11:09:50 INFO - Running setup.py install for mozversion 11:09:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:09:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:09:50 INFO - Cleaning up... 11:09:50 INFO - Return code: 0 11:09:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09: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')]} 11:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09: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')]} 11:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:50 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 0x7fd64e646f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10299c0>, '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 0x102a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', '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 11:09:50 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 11:09:50 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 11:09:50 INFO - Using env: {'DISPLAY': ':0', 11:09:50 INFO - 'HOME': '/home/cltbld', 11:09:50 INFO - 'LANG': 'en_US.UTF-8', 11:09:50 INFO - 'LANGUAGE': 'en_US:en', 11:09:50 INFO - 'LOGNAME': 'cltbld', 11:09:50 INFO - 'MAIL': '/var/mail/cltbld', 11:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:50 INFO - 'MOZ_NO_REMOTE': '1', 11:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:50 INFO - 'NO_EM_RESTART': '1', 11:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:50 INFO - 'PWD': '/builds/slave/test', 11:09:50 INFO - 'SHELL': '/bin/bash', 11:09:50 INFO - 'SHLVL': '1', 11:09:50 INFO - 'TERM': 'linux', 11:09:50 INFO - 'TMOUT': '86400', 11:09:50 INFO - 'USER': 'cltbld', 11:09:50 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', 11:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:50 INFO - '_': '/tools/buildbot/bin/python'} 11:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:51 INFO - Running setup.py (path:/tmp/pip-DcQlH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:51 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)) 11:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:51 INFO - Running setup.py (path:/tmp/pip-h_n6cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:51 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)) 11:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:51 INFO - Running setup.py (path:/tmp/pip-dXS7lJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:51 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)) 11:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:51 INFO - Running setup.py (path:/tmp/pip-YKX57p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:51 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)) 11:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:51 INFO - Running setup.py (path:/tmp/pip-6Qr1mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:51 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)) 11:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:51 INFO - Running setup.py (path:/tmp/pip-Iei6Wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:51 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)) 11:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:51 INFO - Running setup.py (path:/tmp/pip-HipGPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:51 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)) 11:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:51 INFO - Running setup.py (path:/tmp/pip-FgeNNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:51 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)) 11:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:51 INFO - Running setup.py (path:/tmp/pip-1ba8XW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:51 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)) 11:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:51 INFO - Running setup.py (path:/tmp/pip-OvAfH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 11:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:51 INFO - Running setup.py (path:/tmp/pip-UEAbzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:51 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)) 11:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:51 INFO - Running setup.py (path:/tmp/pip-FnkSym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:51 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)) 11:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:52 INFO - Running setup.py (path:/tmp/pip-SS93Ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:52 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)) 11:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:52 INFO - Running setup.py (path:/tmp/pip-PsFbdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:52 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)) 11:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:52 INFO - Running setup.py (path:/tmp/pip-T1A59Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:52 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)) 11:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:52 INFO - Running setup.py (path:/tmp/pip-2tYFYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:52 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)) 11:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:52 INFO - Running setup.py (path:/tmp/pip-OouKM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:52 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)) 11:09:52 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)) 11:09:52 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)) 11:09:52 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)) 11:09:52 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)) 11:09:52 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)) 11:09:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 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 11:09:54 INFO - Downloading blessings-1.6.tar.gz 11:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:09:54 INFO - Installing collected packages: blessings 11:09:54 INFO - Running setup.py install for blessings 11:09:54 INFO - Successfully installed blessings 11:09:54 INFO - Cleaning up... 11:09:54 INFO - Return code: 0 11:09:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:09:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:09:54 INFO - Reading from file tmpfile_stdout 11:09:54 INFO - Current package versions: 11:09:54 INFO - argparse == 1.2.1 11:09:54 INFO - blessings == 1.6 11:09:54 INFO - blobuploader == 1.2.4 11:09:54 INFO - docopt == 0.6.1 11:09:54 INFO - manifestparser == 1.1 11:09:54 INFO - mozInstall == 1.12 11:09:54 INFO - mozcrash == 0.17 11:09:54 INFO - mozdebug == 0.1 11:09:54 INFO - mozdevice == 0.48 11:09:54 INFO - mozfile == 1.2 11:09:54 INFO - mozhttpd == 0.7 11:09:54 INFO - mozinfo == 0.9 11:09:54 INFO - mozleak == 0.1 11:09:54 INFO - mozlog == 3.2 11:09:54 INFO - moznetwork == 0.27 11:09:54 INFO - mozprocess == 0.22 11:09:54 INFO - mozprofile == 0.28 11:09:54 INFO - mozrunner == 6.11 11:09:54 INFO - mozscreenshot == 0.1 11:09:54 INFO - mozsystemmonitor == 0.3 11:09:54 INFO - moztest == 0.7 11:09:54 INFO - mozversion == 1.4 11:09:54 INFO - psutil == 3.1.1 11:09:54 INFO - requests == 1.2.3 11:09:54 INFO - wsgiref == 0.1.2 11:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:54 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 0x7fd64e646f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10299c0>, '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 0x102a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', '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 11:09:54 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 11:09:54 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 11:09:54 INFO - Using env: {'DISPLAY': ':0', 11:09:54 INFO - 'HOME': '/home/cltbld', 11:09:54 INFO - 'LANG': 'en_US.UTF-8', 11:09:54 INFO - 'LANGUAGE': 'en_US:en', 11:09:54 INFO - 'LOGNAME': 'cltbld', 11:09:54 INFO - 'MAIL': '/var/mail/cltbld', 11:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:54 INFO - 'MOZ_NO_REMOTE': '1', 11:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:54 INFO - 'NO_EM_RESTART': '1', 11:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:54 INFO - 'PWD': '/builds/slave/test', 11:09:54 INFO - 'SHELL': '/bin/bash', 11:09:54 INFO - 'SHLVL': '1', 11:09:54 INFO - 'TERM': 'linux', 11:09:54 INFO - 'TMOUT': '86400', 11:09:54 INFO - 'USER': 'cltbld', 11:09:54 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', 11:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:54 INFO - '_': '/tools/buildbot/bin/python'} 11:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:54 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)) 11:09:54 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)) 11:09:54 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)) 11:09:54 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)) 11:09:54 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)) 11:09:54 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)) 11:09:54 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)) 11:09:54 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)) 11:09:54 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)) 11:09:54 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)) 11:09:54 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)) 11:09:54 INFO - Cleaning up... 11:09:54 INFO - Return code: 0 11:09:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd64e646f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10299c0>, '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 0x102a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', '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 11:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:09:54 INFO - Using env: {'DISPLAY': ':0', 11:09:54 INFO - 'HOME': '/home/cltbld', 11:09:54 INFO - 'LANG': 'en_US.UTF-8', 11:09:54 INFO - 'LANGUAGE': 'en_US:en', 11:09:54 INFO - 'LOGNAME': 'cltbld', 11:09:54 INFO - 'MAIL': '/var/mail/cltbld', 11:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:54 INFO - 'MOZ_NO_REMOTE': '1', 11:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:54 INFO - 'NO_EM_RESTART': '1', 11:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:54 INFO - 'PWD': '/builds/slave/test', 11:09:54 INFO - 'SHELL': '/bin/bash', 11:09:54 INFO - 'SHLVL': '1', 11:09:54 INFO - 'TERM': 'linux', 11:09:54 INFO - 'TMOUT': '86400', 11:09:54 INFO - 'USER': 'cltbld', 11:09:54 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', 11:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:54 INFO - '_': '/tools/buildbot/bin/python'} 11:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:55 INFO - Downloading/unpacking jsonschema 11:09:55 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 11:09:55 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 11:09:55 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 11:09:55 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 11:09:55 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 11:09:55 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 11:09:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:09:57 INFO - Downloading/unpacking functools32 (from jsonschema) 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09:57 INFO - Downloading functools32-3.2.3-2.tar.gz 11:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:09:57 INFO - warning: no files found matching '*.txt' 11:09:57 INFO - no previously-included directories found matching 'build' 11:09:57 INFO - no previously-included directories found matching 'dist' 11:09:57 INFO - no previously-included directories found matching '.git*' 11:09:57 INFO - Installing collected packages: jsonschema, functools32 11:09:57 INFO - Running setup.py install for functools32 11:09:57 INFO - warning: no files found matching '*.txt' 11:09:57 INFO - no previously-included directories found matching 'build' 11:09:57 INFO - no previously-included directories found matching 'dist' 11:09:57 INFO - no previously-included directories found matching '.git*' 11:09:57 INFO - Successfully installed jsonschema functools32 11:09:57 INFO - Cleaning up... 11:09:57 INFO - Return code: 0 11:09:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:09:57 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')]} 11:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:57 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')]} 11:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:57 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 0x7fd64e646f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10299c0>, '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 0x102a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', '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 11:09:57 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 11:09:57 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 11:09:57 INFO - Using env: {'DISPLAY': ':0', 11:09:57 INFO - 'HOME': '/home/cltbld', 11:09:57 INFO - 'LANG': 'en_US.UTF-8', 11:09:57 INFO - 'LANGUAGE': 'en_US:en', 11:09:57 INFO - 'LOGNAME': 'cltbld', 11:09:57 INFO - 'MAIL': '/var/mail/cltbld', 11:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:57 INFO - 'MOZ_NO_REMOTE': '1', 11:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:57 INFO - 'NO_EM_RESTART': '1', 11:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:57 INFO - 'PWD': '/builds/slave/test', 11:09:57 INFO - 'SHELL': '/bin/bash', 11:09:57 INFO - 'SHLVL': '1', 11:09:57 INFO - 'TERM': 'linux', 11:09:57 INFO - 'TMOUT': '86400', 11:09:57 INFO - 'USER': 'cltbld', 11:09:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', 11:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:57 INFO - '_': '/tools/buildbot/bin/python'} 11:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:57 INFO - Downloading/unpacking flake8 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:09:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:09:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:10:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:10:00 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 11:10:00 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 11:10:00 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 11:10:00 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 11:10:00 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 11:10:00 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 11:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:10:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:10:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:10:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:10:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:10:00 INFO - no previously-included directories found matching 'docs/_build' 11:10:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:10:00 INFO - Running setup.py install for pep8 11:10:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:10:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:10:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:10:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:10:00 INFO - no previously-included directories found matching 'docs/_build' 11:10:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:10:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:10:00 INFO - Cleaning up... 11:10:00 INFO - Return code: 0 11:10:00 INFO - Running post-action listener: _resource_record_post_action 11:10:00 INFO - Running post-action listener: _start_resource_monitoring 11:10:00 INFO - Starting resource monitoring. 11:10:00 INFO - ##### 11:10:00 INFO - ##### Finished create-virtualenv step (success) 11:10:00 INFO - ##### 11:10:00 INFO - ##### 11:10:00 INFO - ##### Running install step. 11:10:00 INFO - ##### 11:10:00 INFO - Running pre-action listener: _resource_record_pre_action 11:10:00 INFO - Running main action method: install 11:10:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:10:00 INFO - Reading from file tmpfile_stdout 11:10:00 INFO - Detecting whether we're running mozinstall >=1.0... 11:10:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:10:00 INFO - Reading from file tmpfile_stdout 11:10:00 INFO - Output received: 11:10:00 INFO - Usage: mozinstall [options] installer 11:10:00 INFO - Options: 11:10:00 INFO - -h, --help show this help message and exit 11:10:00 INFO - -d DEST, --destination=DEST 11:10:00 INFO - Directory to install application into. [default: 11:10:00 INFO - "/builds/slave/test"] 11:10:00 INFO - --app=APP Application being installed. [default: firefox] 11:10:00 INFO - mkdir: /builds/slave/test/build/application 11:10:00 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'] 11:10:00 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 11:10:17 INFO - Reading from file tmpfile_stdout 11:10:17 INFO - Output received: 11:10:17 INFO - /builds/slave/test/build/application/firefox/firefox 11:10:17 INFO - Running post-action listener: _resource_record_post_action 11:10:17 INFO - ##### 11:10:17 INFO - ##### Finished install step (success) 11:10:17 INFO - ##### 11:10:17 INFO - ##### 11:10:17 INFO - ##### Running run-tests step. 11:10:17 INFO - ##### 11:10:17 INFO - Running pre-action listener: _resource_record_pre_action 11:10:17 INFO - Running main action method: run_tests 11:10:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:10:17 INFO - Python 2.7.3 11:10:17 INFO - Return code: 0 11:10:17 INFO - grabbing minidump binary from tooltool 11:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:17 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10299c0>, '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 0x102a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:10:17 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 11:10:17 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 11:10:17 INFO - Calling ['/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'] with output_timeout 600 11:10:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:10:17 INFO - Return code: 0 11:10:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:10:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:10:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:10:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:10:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:10:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:10:18 INFO - Return code: 0 11:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--title', 'talos-linux64-ix-036', '--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 11:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --title talos-linux64-ix-036 --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 11:10:18 INFO - Using env: {'DISPLAY': ':0', 11:10:18 INFO - 'HOME': '/home/cltbld', 11:10:18 INFO - 'LANG': 'en_US.UTF-8', 11:10:18 INFO - 'LANGUAGE': 'en_US:en', 11:10:18 INFO - 'LOGNAME': 'cltbld', 11:10:18 INFO - 'MAIL': '/var/mail/cltbld', 11:10:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:10:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:18 INFO - 'MOZ_NO_REMOTE': '1', 11:10:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:18 INFO - 'NO_EM_RESTART': '1', 11:10:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:18 INFO - 'PWD': '/builds/slave/test', 11:10:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:10:18 INFO - 'SHELL': '/bin/bash', 11:10:18 INFO - 'SHLVL': '1', 11:10:18 INFO - 'TERM': 'linux', 11:10:18 INFO - 'TMOUT': '86400', 11:10:18 INFO - 'USER': 'cltbld', 11:10:18 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861', 11:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:18 INFO - '_': '/tools/buildbot/bin/python'} 11:10:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--title', 'talos-linux64-ix-036', '--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 11:10:18 INFO - mozversion application_buildid: 20160518083057 11:10:18 INFO - mozversion application_changeset: 8f36fe8daf67cd1a586c9ec2009fc72f2d3624a9 11:10:18 INFO - mozversion application_display_name: Nightly 11:10:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:10:18 INFO - mozversion application_name: Firefox 11:10:18 INFO - mozversion application_remotingname: firefox 11:10:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:10:18 INFO - mozversion application_vendor: Mozilla 11:10:18 INFO - mozversion application_version: 49.0a1 11:10:18 INFO - mozversion platform_buildid: 20160518083057 11:10:18 INFO - mozversion platform_changeset: 8f36fe8daf67cd1a586c9ec2009fc72f2d3624a9 11:10:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:10:18 INFO - mozversion platform_version: 49.0a1 11:10:18 INFO - using testdate: 1463595018 11:10:18 INFO - actual date: 1463595018 11:10:18 INFO - starting webserver on 'localhost:51539' 11:10:18 INFO - SUITE-START | Running 2 tests 11:10:18 INFO - TEST-START | dromaeo_css 11:10:18 INFO - operating with platform_type : linux_ 11:10:18 INFO - Initialising browser for dromaeo_css test... 11:10:18 INFO - TEST-INFO | started process 21991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyNrl8G/profile http://localhost:51539/getInfo.html) 11:10:22 INFO - PROCESS | 21991 | __metrics Screen width/height:1600/1200 11:10:22 INFO - PROCESS | 21991 | colorDepth:24 11:10:22 INFO - PROCESS | 21991 | Browser inner width/height: 1024/697 11:10:22 INFO - PROCESS | 21991 | __metrics 11:10:24 ERROR - PROCESS | 21991 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:10:24 INFO - TEST-INFO | 21991: exit 0 11:10:24 INFO - Browser initialized. 11:10:24 INFO - Running cycle 1/1 for dromaeo_css test... 11:10:24 INFO - TEST-INFO | started process 22072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyNrl8G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:10:36 INFO - PROCESS | 22072 | RSS: Main: 153022464 11:10:36 INFO - PROCESS | 22072 | 11:11:27 INFO - PROCESS | 22072 | 1463595087743 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] 11:13:35 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:51539/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51539/tests/dromaeo/cssquery-ext.html) 11:13:36 INFO - PROCESS | 22072 | RSS: Main: 253218816 11:13:36 INFO - PROCESS | 22072 | 11:16:38 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:51539/tests/dromaeo/cssquery-ext.html (next: http://localhost:51539/tests/dromaeo/cssquery-jquery.html) 11:16:39 INFO - PROCESS | 22072 | RSS: Main: 242352128 11:16:39 INFO - PROCESS | 22072 | 11:19:41 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:51539/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51539/tests/dromaeo/cssquery-mootools.html) 11:19:41 INFO - PROCESS | 22072 | RSS: Main: 233467904 11:19:41 INFO - PROCESS | 22072 | 11:22:43 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:51539/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51539/tests/dromaeo/cssquery-prototype.html) 11:22:44 INFO - PROCESS | 22072 | RSS: Main: 229244928 11:22:44 INFO - PROCESS | 22072 | 11:25:47 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:51539/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51539/tests/dromaeo/cssquery-yui.html) 11:25:47 INFO - PROCESS | 22072 | RSS: Main: 224329728 11:25:47 INFO - PROCESS | 22072 | 11:28:50 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:51539/tests/dromaeo/cssquery-yui.html (next: http://localhost:51539/tests/dromaeo/cssquery-dojo.html) 11:28:50 INFO - PROCESS | 22072 | RSS: Main: 280526848 11:28:50 INFO - PROCESS | 22072 | 11:28:50 INFO - PROCESS | 22072 | __start_tp_report 11:28:50 INFO - PROCESS | 22072 | _x_x_mozilla_page_load 11:28:50 INFO - PROCESS | 22072 | _x_x_mozilla_page_load_details 11:28:50 INFO - PROCESS | 22072 | |i|pagename|runs| 11:28:50 INFO - PROCESS | 22072 | |0;dojo.html;3108.2850944282814;3124.453220686379;3153.132888455674;3165.699258570435;3187.2669286064206;5270.762815673294;5303.65526240795;5323.254744335792;5407.5133238008575;5440.619156659035;5264.736763161845;5284.497972692598;5320.095583750762;5323.866903327419;5356.223347614594;4716.033213191296;4835.540623640766;4844.903101937959;4845.079434907374;5052.26742122392;4935.8272460463895;4969.70181789092;4987.725675087887;5004.599632029447;5012.849614511552;4763.999560092385;4814.422269327668;4837.806487740486;4839.249916262967;4844.927326090112;4826.686265392738;4830.178869592142;4913.385826771653;4939.3578834751615;4958;4746.477887432379;4863.537963893425;4874.707517548958;4897.975510122462;4923.852284431473;5252.133397989327;5275.973620131913;5348.893022139574;5418.376886658046;5421.728913554307;5736.512396446307;5740.512056475204;5748.5975981681295;5790.913136302959;5796.101604251347;5592.105263157916;5653.180288858133;5658.151277308396;5765.4811067004175;5825.359210486843;5367.677939323614;5392.514673679349;5397.73011349431;5404.486573775485;5410.458954104597;5880.117982302689;5898.026825573818;5899.321578018497;5903.586748927534;5904;5513.393526712059;5577.6932268724795;5605.859853503695;5619.915701264485;5662.631928924689;5726.541876649858;5727.11229759388;5740.966626007359;5796.710164491843;5798.94201057984;5685.545156387562;5711.657300561979;5736.13957906309;5744.253247077853;5752.050911599539;5541.030319694118;5619.719014049281;5646.322441307069;5660.632058916157;5690.317161940511;4313.245182093121;4315.568443155659;4315.741055536678;4332.220200363965;4356.411884395629;3822.617738226211;3857.176205305453;3860.3630400984084;3918.3730603103368;3927.3912543555793;5285.577153827761;5294.841154765363;5297.417284098746;5310.097283461821;5387.057264978613;5690.6870122142855;5695.1741997410145;5701.572382071361;5708.71456427177;5724.542036637059;5300.92048619271;5369.275147855068;5388;5389.649672771257;5438.755256013489;4898.387701537308;4945.505449455098;4954.1825598775795;4977.626677999165;4981.32752078472;5948.613340132878;5950.166976623276;5956.285245770535;5960.970195149083;5967.850803729854;5648.350439699323;5794.420557944256;5802.5357971361345;5803;5806.854828629318;5869.266341707286;5906.822795315976;5943.286805583185;5962.880742385215;5974.522038237017;5645.915311270416;5654.802081927113;5680.4319568042865;5686.800961966312;5693.231413759089;5629.6903670298525;5660.490555849993;5802.245708057925;5819.447152520504;5821.214136091573;5527.44725527444;5580.386157522588;5601.663900166003;5604.131359639263;5648.519875810603;5567.331920169606;5574.9721251393485;5580;5589.77640894376;5592.105263157875;5358.598105142052;5478.91781623284;5492.231087647652;5517.531009864046;5547.084731019337;5680.772769089355;5707.743151558273;5713.942860571341;5721.5136713379825;5737.168110624019;5565.248691426767;5571.888562228652;5573.665580065209;5575.609707320611;5614.185943038318 11:28:50 INFO - PROCESS | 22072 | |1;ext.html;596.9313528944173;624.3880996623309;628.0516420205488;640.151798866502;643.8712257548491;35420.645793542055;36014.81992590037;36129.81935090327;43201.56798432015;44216;46638.533614663844;46720.76639616806;47023;47069.52930470694;47139.29291060637;8744.431611945234;8916.197542221198;8917.108289171096;8917.77705557363;8964.910350896473;8834.779130521756;8903.332250081237;8922.73231803047;8944.329175311845;8952.462852228855;9007;9032;9051.864222036675;9056;9059.909400906006;8918.152775486318;8934.106589341047;8961.820763584758;8971.685990990349;8985.37102402832;8703.173198546128;8802.515861627608;8811.030786613468;8823.602937867812;8829.55852207387;41752.58247417517;41789.16421671549;42068.57931420677;42079.158416831495;42168.57831421708;3608.368535506302;3674.4488326751202;3772.9434058489146;4125.381192821101;4421.60205581496;30625.38749225003;32564;32834.50748238778;33289.83355083209;33867.66132338694;4358.0848021915435;4409.867703968886;4425.402570652953;4448.377227188196;4502.729836209838;329723;332446;332894.3486977968;333077.3346133278;333110.68559172255;35249.295014099574;36056.819715901256;62975.37024629787;63450.36549634537;63530.36469635337;37465.25069498649;37644.62355376466;37796.811015944746;37816.05459863525;37829.810850946116;13727.382267797973;13879.722405551833;13887.722245555033;13891.235982020884;13895.722085558435;11232.157588180919;11292.604758833402;11310.434478276053;11315.264507806965;11331.093512518979;8546.145385461405;8582.914170858336;8605.397622166389;8629.22336989674;8654.567271636393;3271.4275001874576;3275.7051865332232;3334.749893757978;3335.7831740936763;3374.6794054564775;962.2927148545813;1022.2946167144646;1035.5133087448887;1074.1836204484648;1107.8116720157593;32476.512852307234;32994.835025825196;33248.501272480935;33314;33683.66316336854;1112.238116889933;1116.4138827115667;1126.7352172239516;1176.7999440095205;1185.5020891225533;16910.239039243017;17264.654706905792;17388.130593470276;17625.383111591033;17671.558211044827;524106;528875;530000;530123;530211;59979.700101500086;60550.69724651348;60614.696926515084;60618;60706;1267.113020885384;1396.1553260277385;1397.105852254558;1407.6973450708147;1431.7494438473225;33538;34742.82628586841;35113.824430877685;35284.47073293851;35370.29259414849;52689;53281.46718532765;53303;53327.73336133295;53350.73324633352;419682;423276;423587;423806;425278;28052;29302.26744331409;29347.413051739273;29363.265918352212;29460.410791784474;48170;49220.2616960753;49251;50047.249291259934;50377.74811126068;42244.788776055924;42263.7886810564;42757;42921;43642.781786092135;41738;42256;42325.78837105795;42405.787971059945;42943.57056429521;41322.58677413187;41897.79051104725;43050.138997219256;43110.35334470048;45257.094858103315;36082;37197.814010929775;38303.42544861885;38526.229475410895;38862.80568597139;29153.125406237847;29184.56223156612;29195.270118246364;29417.14771889752;29593.408131837674 11:28:50 INFO - PROCESS | 22072 | |2;jquery.html;373.5517379145023;379.9696024318053;408.46695062942865;412.26410856620936;415.21731536054546;18138.54653633658;18602.441926742187;19368.903155484204;19809.108590113443;19821.504462388446;17425.912870435663;17732.37936672217;18050.81949180508;18288.72566911494;18314.450566482992;5526.198701188336;5574.804881829137;5588.133839254922;5719.857003574903;5732.914006289888;5625;5665.320161580596;5681.7727290908315;5686.6019378643305;5699.515541179005;5517.282753242073;5669.886602267952;5670.177824215486;5786;5791.21818554494;5762.3373312069225;5823.388544202861;5825.359210486864;5869.941300587004;5899.410058994109;5773.624714393551;5826.941730582682;5855.2973643163095;5860.7948721794955;5864.032434648278;13734.931325343408;13930.721385572333;14349.923755718259;14369.13785172893;14385.78421323681;2271.3980795089315;2357.351728274721;2394.856308621471;2416.7945724613255;2513.057603398707;9879.604815807359;10470.476476176236;10519.47402629873;10603.045725884707;10664.893351066468;1955.4426988308405;2022.5247066939257;2071.989640051805;2118.3962570667286;2154.8707077575395;63048.68475657592;78325;83450;83687.58156209241;86421;9199.954000229956;9770.169535589412;9898.406095634286;10110.545025473872;10752.516136773864;13683;13715.1085179463;14359.138451692932;15238.847611523743;15256.771148432783;7658.885116723253;7697.730579429805;7894.763157105296;8033.517988920684;8049.476784009021;7327.743528976567;7375.451155257349;7430.479866409408;7464.365528929993;7546.471746977769;4906.533879281534;4906.656534042583;4920.803167873317;4937.7777999990085;4976.651634385631;1916.6741653918866;2001.5896741168026;2011.8390528757664;2012.9698054528901;2027.2600500817096;922.5387306346827;1051;1091.792559413709;1095.6932059023486;1116.5366372955132;18358;18989.715154272697;19094.14076366567;19113;19234.519137021685;1011.4437059617181;1032.9018743219533;1051.4795176387738;1068.076114161245;1098.8516550265613;10242.6415075472;10929.836052459219;10956.671299861016;10962.451877406258;10979.1765617579;425176;425271;457373;467365;467918;92442.53778731063;93918.53040734753;94421;95364;96477.6937268443;1039.1063685230847;1042.2704107125044;1051.779126383468;1051.8001579699985;1057.5082586597268;16582;16836.326546937984;17048.403305884236;17116.144192790558;17364;42009;42091.57908420999;42507.7874610625;42642.36036459394;42875.142497150504;58299.70850145722;59210.37501437357;59871.10193347016;60182.398176017676;60725.0891236623;8601.95699021526;8717.782055448664;8724.476531408136;9000;9099.090090990849;9835.360701554377;12703.93648031754;13146.145500542816;13157.60527184186;13220.603381898558;5477.507024367826;5795.82612521625;11444.94277528607;11839.348835814113;11918.761624767283;11513.597024104116;11582.768344632892;11599.188056835941;11685.182037257311;11740.823887641522;11627.534898604299;11813;11865.228760130563;11873.168878178445;12114.454849531969;7704.114026886979;8648.913510864812;8814.864047139523;8815.074417186359;8856;11616.825747613624;12004.519819207135;12119.636410907688;12247.448864800926;12406.875931240573 11:28:50 INFO - PROCESS | 22072 | |3;mootools.html;1351.5742541099546;1504.1351223046747;1555.237933412628;1676.3210899585665;1848.8613353998453;8445.704400345989;8815.559222038888;8822.514761688113;9094.49980251086;9099.408538444997;8834.425762325445;9023.23302519285;9031;9034.81930361394;9038.096190380975;2033.857629965903;2296.0815673730517;2296.632538793793;2324.0122947747222;2375.168690958168;2389.0205015943466;2392.820538459614;2399.4961058177805;2400.6879105716234;2401.555712193241;2295.82781291403;2347.049444974788;2347.7065366829147;2350.3419042667997;2352.047420794581;2033.4204751645784;2263.1400067974228;2303.7926586607286;2311.5492478966607;2332.54515369503;2257.3115199864037;2264.388615073937;2267.30847091637;2274.226762900622;2310.445493081665;9313;9350.251979841596;9387.812243755156;9393.953030234805;9396.201322887562;5259.894802103975;5379.462053794628;5388.7305634718105;5389;5393.460653934614;3394.3381040697072;3406.8466918988456;3485.1984043669845;3528.752987290891;3546.131197856542;1154.8440960470314;1164.2781475485253;1166.789977803995;1214.7401750420745;1237.2885590785245;12871.549495767696;12928.224306541637;12937.935310323483;12968.675783105404;12980.156289841225;4680.368150299734;4728.17256980034;4836.298736683231;4848.684835485682;4849;10296.485175741183;10300.381977081399;10306.639267625596;10312.226583006304;10315.484225788681;4634.814607415733;5391.865203369947;5397.622166448389;5402.405735369106;5403.189521571796;4393.582609652142;4452.354408610733;4453.599176074104;4742.691725037862;4859.222524396079;3845.615438456188;3868.671162951124;3965.3060714375447;3990.2618015666612;4000.299947509174;1168.3807581981393;1170.6722117807028;1173.3781096019125;1176.7352345722145;1185.5909711149638;892.7946572288411;899.1997122560927;901.7790641292926;937.105064663245;951.3435729346728;5855.268091488564;5929.341925716447;5945.078512830518;5996.67018313997;6046.5767396281835;938.7606160429046;945.2013048973606;981.7840075183448;985.0592683986775;985.1675334342469;4052.2908491014546;4077.7553346799286;4125.793710314472;4133.503979522417;4197.055662475918;11526.827097593543;11796.174267801172;11853.111016673784;11891.28652280866;11936.28382297065;10696.144308455305;11608.709782255512;11612.94193529027;11676.065914726802;11873.109516786275;8277.710280140167;8642.092580279106;8666.350023748244;8710.825783484295;8723.60743766532;5814.883702326015;5887.646741195542;5893;5925.970370148121;5990.071538911476;9812;10150.340227885164;10316.27786054969;10345.275830691779;10370.11853992389;10357.4303413313;10379.325343852626;10390.58437662485;10400.47997600102;10416.270861039655;7359.558426494427;7925.405594580545;8023.759287221393;8164.0814408615115;8310.792230194053;8967.686130985385;8997.91002089997;9016.459012459274;9051.366404351895;9065.909340906506;7944.880826787718;8131.186881311822;8135.552544609866;8188.303994160325;8217.424780265324;7674;7779.92220077792;7785.727499537489;8014.438989270695;8173.386995975445;7138.357547820721;7305.707771689073;7508.324250817453;7542.094948606203;7563.168051514219;5024.949750502595;5046.873828154178;5067.239914012927;5151.587872970228;5225;5177.974110129576;5270.288511051112;5321.946780532146;5429.294191755047;5475.6440831345835 11:28:50 INFO - PROCESS | 22072 | |4;prototype.html;304.16810024582765;317.3082679758127;318.5731120298799;321.4856230031949;321.7442133503864;5233.319668443097;5363.597730170233;5394.165983565587;5441.2654291670615;5451.563874890014;5227.477252274771;5411.648242864211;5429.782808687658;5446.945530544694;5448.863778405542;4215.599518045796;4221.32458806591;4228.661707063436;4233.957660423403;4248.406847432213;3972.324704800191;4017.8995525111814;4196.790160491979;4219.789010549475;4233.216854881842;4118.917621647565;4160.667146628278;4166.375043743433;4182.560831112735;4182.6235638792505;4138.530821558348;4142.647874930634;4146;4165.33354663254;4177.811998460076;3444.50054742061;3661.560612726463;3667.423008106513;3667.5782285037294;3676.3198808220563;5200.427952925213;5232.241325007891;5232.372115346145;5245.947540524584;5266.262723218752;4731.580525842268;4732;4732.9763351183365;4733.573978341931;4741.596964258008;5387.434319396485;5587.413321601254;5615.691136987464;5619.157126431027;5628.155776633497;3896.7272290939645;3941.881743547698;3947.723659343847;3960.3465428204313;3964.2467931093;5804.564657650651;5855.268091488564;5859;5881.647101173943;5904.409559044061;3948.5853985331128;3989.9601003989587;4009.9599004009588;4011.839526418969;4018.718689691752;4062.431259623655;4066.512018557792;4073.6944729145434;4077.857274995361;4095.4266402703647;4669.789859456333;4670.299455081765;4692.601128904082;4693.906121877543;4749.168895443284;5333.5199832015305;5580.386157522669;5689.231953686282;5691.658500489901;5706.174024312263;1351.7228968061524;1367.2275164532207;1373.7115205806692;1382.1292585671165;1389.173441802126;868.8957325121025;894.3024440936081;894.8434024045766;899.5142622983647;904.6471875968377;4775.689580177277;4834.685745426536;4862.513748625109;4865.659403841768;4891;4881.633877459205;5134.614903882149;5151.6908985461;5181;5181.611379146579;4803.519648035169;4810.4467986182035;4848.8302909398;4858.416989961227;4911.582515486152;2686.535837968273;2701.1356365963097;2721;2742.58861170822;2743.670759508832;5049.495050494921;5219.478052194826;5222.764975576032;5235.39792923811;5291.708956007379;5150.510701483353;5166.940777140677;5175.343889955178;5185.325907632059;5207.583393328525;5246.685198888079;5259.289995850511;5259.973700131475;5295.232191332235;5331.840044798662;4809.278608208797;5118.488151185001;5184.740762961761;5201.479852014768;5230.34620672416;5051.953958646754;5068.695878247317;5077.517635824591;5102.69383836971;5190.844274671766;4945.4807245238735;5219.843404697714;5224.947750522446;5244.239585260192;5274.709890955881;3692.1692619160476;3699.9260014799015;3700.5744339401313;3703.5000274963613;3715.479832823353;5124.820631278037;5134.358205224347;5146.6911985281;5157.323869742274;5205.45342739007;4890.6550698558185;4900.240462728283;4994.525520075587;5002.8243362810435;5012.072766538202;5278.129108697176;5424.728763561727;5568.97215513936;5682.636167319731;5703.5722320826935;5479.205515200194;5481.616286859881;5519.254900588369;5620.718964051863;5630.465105814941;5699.686517241592;5754.510866576388;5766;5770.3364113125845;5778.81534285462;5488.259085023471;5501.9174712380145;5540.310205387395;5581.944180558305;5585.743207778218 11:28:50 INFO - PROCESS | 22072 | |5;yui.html;813.5118928642813;819.5779173725531;850.8681154421067;854.3891117850735;876.1282523888732;14459.493917712882;15031.549053528399;15048.473303434355;15095.62260943477;15097.698046039073;13307.201567905908;13714.519991800289;14074.29628518575;14202.147871127714;14223.502177423792;813.9186081391873;819.7335865843595;826.7313123234943;826.8304997475533;827.3009307135491;811.6144831205189;816.6692489541745;818.472085504849;819.1276290750361;819.7212947597816;857.3826844671827;859.3426029087752;865.9740207793776;868.6699054359366;868.9782755431133;855.2345650642671;856.1780690537092;856.9614367353485;859.1236938322938;862.5256109139948;623.5261201486902;625.6527627166921;627.2347735762363;629.072118625029;629.4177885455935;13463.192208467523;13525.932370338085;13555.390007449689;14203.360848761831;14551.563453096318;13312.400941957538;13638.727225455435;13793.379297931617;13930.094543854719;14089.436422543085;11119.499622517005;11271.718207044889;11297.491612877358;11347.982619491;11422.14333924959;3635.836387362575;3685.1155722626377;3692.150805314766;3712.925741485155;3765.7363984521094;54764;56029.15956260659;56059.719701401234;61354.94418141882;62346.376536234966;10505.632302869362;10680.465976701134;10706.357618542912;10840.241183117107;11371.749107598158;19761.209551618063;19914.402567922985;19947;20050.498737531678;20062.39812805589;8293.751187464264;8326.167383261625;8330.66677332912;8377.83244335122;8600.09698981598;4609.516000819933;4655.767211639404;4735.313379559944;4818.349522814376;4913.434954980223;3320.9833950830575;3327.5008748687405;3368.326334733063;3397.881074162442;3399.8810041648426;673.6934694713893;676.5500941873697;688.2601203705937;694.5936627073118;702.5644100657523;697.1425147069133;706.4348521183033;713.5575942915426;761.6382218446194;778.4473024152915;10005.549750261256;10122.54448549817;10257.435841028815;10329.173666106693;10368.274220804622;682.9248782633906;772.2663469703804;781.1914668318377;810.3719617296642;822.942394032412;4679.953200467951;4780.259059845729;4800.975995120002;4803.927941080887;4872.9512704872495;73311.63344183352;77106.22893771103;78835.60582197167;79641.60179199182;81469.59265203636;70445.6477717608;70477.2952270481;70634.29365706276;70770.64614676894;71879.6406017977;52710.736446317525;52909;62851.685741571;64643.67678161579;65067.34932650708;9706.320557560903;9709.757256068655;9796.608135674493;9869.259805514472;9939.254555908192;38078.238435231695;38239;38613.80693096516;38915.416268756555;39201;48053.75973120112;51556.484435155166;52592.737036314575;53338.73330633322;53821;12663.93668031654;12728.809067863804;12813.487460501476;12894.548690795777;13090.738185236432;14130.717385652024;14240.287985600471;14381;14464.855351446771;14647.070585882653;13331.733365332446;13390.397432115773;13535.187888726708;13769;13890.791638125638;13004.544840930523;13324.400401982128;13329.600111996655;13791.862081379059;13807.792883106962;13264.734705306033;13468.86531134676;14244.715105698035;14250.216238107003;14274;10866.945665271624;11015.284006539548;11297.661070167907;11304.49129789145;11632.302061876315;10192.337498062601;10282.948585257325;11249.268797528135;11279.718007049561;11359.148063895405 11:28:50 INFO - PROCESS | 22072 | __end_tp_report 11:28:50 INFO - PROCESS | 22072 | __start_cc_report 11:28:50 INFO - PROCESS | 22072 | _x_x_mozilla_cycle_collect,824 11:28:50 INFO - PROCESS | 22072 | __end_cc_report 11:28:50 INFO - PROCESS | 22072 | __startTimestamp1463596130412__endTimestamp 11:28:50 INFO - PROCESS | 22072 | 11:28:50 INFO - PROCESS | 22072 | ------- Summary: start ------- 11:28:50 INFO - PROCESS | 22072 | Number of tests: 6 11:28:50 INFO - PROCESS | 22072 | 11:28:50 INFO - PROCESS | 22072 | [#0] dojo.html Cycles:165 Average:5321.35 Median:5547.08 stddev:604.88 (10.9%) stddev-sans-first:581.29 11:28:50 INFO - PROCESS | 22072 | Values: 3108.3 3124.5 3153.1 3165.7 3187.3 5270.8 5303.7 5323.3 5407.5 5440.6 5264.7 5284.5 5320.1 5323.9 5356.2 4716.0 4835.5 4844.9 4845.1 5052.3 4935.8 4969.7 4987.7 5004.6 5012.8 4764.0 4814.4 4837.8 4839.2 4844.9 4826.7 4830.2 4913.4 4939.4 4958.0 4746.5 4863.5 4874.7 4898.0 4923.9 5252.1 5276.0 5348.9 5418.4 5421.7 5736.5 5740.5 5748.6 5790.9 5796.1 5592.1 5653.2 5658.2 5765.5 5825.4 5367.7 5392.5 5397.7 5404.5 5410.5 5880.1 5898.0 5899.3 5903.6 5904.0 5513.4 5577.7 5605.9 5619.9 5662.6 5726.5 5727.1 5741.0 5796.7 5798.9 5685.5 5711.7 5736.1 5744.3 5752.1 5541.0 5619.7 5646.3 5660.6 5690.3 4313.2 4315.6 4315.7 4332.2 4356.4 3822.6 3857.2 3860.4 3918.4 3927.4 5285.6 5294.8 5297.4 5310.1 5387.1 5690.7 5695.2 5701.6 5708.7 5724.5 5300.9 5369.3 5388.0 5389.6 5438.8 4898.4 4945.5 4954.2 4977.6 4981.3 5948.6 5950.2 5956.3 5961.0 5967.9 5648.4 5794.4 5802.5 5803.0 5806.9 5869.3 5906.8 5943.3 5962.9 5974.5 5645.9 5654.8 5680.4 5686.8 5693.2 5629.7 5660.5 5802.2 5819.4 5821.2 5527.4 5580.4 5601.7 5604.1 5648.5 5567.3 5575.0 5580.0 5589.8 5592.1 5358.6 5478.9 5492.2 5517.5 5547.1 5680.8 5707.7 5713.9 5721.5 5737.2 5565.2 5571.9 5573.7 5575.6 5614.2 11:28:50 INFO - PROCESS | 22072 | 11:28:50 INFO - PROCESS | 22072 | [#1] ext.html Cycles:180 Average:58371.97 Median:42123.87 stddev:115568.50 (274.4%) stddev-sans-first:115811.29 11:28:50 INFO - PROCESS | 22072 | Values: 596.9 624.4 628.1 640.2 643.9 35420.6 36014.8 36129.8 43201.6 44216.0 46638.5 46720.8 47023.0 47069.5 47139.3 8744.4 8916.2 8917.1 8917.8 8964.9 8834.8 8903.3 8922.7 8944.3 8952.5 9007.0 9032.0 9051.9 9056.0 9059.9 8918.2 8934.1 8961.8 8971.7 8985.4 8703.2 8802.5 8811.0 8823.6 8829.6 41752.6 41789.2 42068.6 42079.2 42168.6 3608.4 3674.4 3772.9 4125.4 4421.6 30625.4 32564.0 32834.5 33289.8 33867.7 4358.1 4409.9 4425.4 4448.4 4502.7 329723.0 332446.0 332894.3 333077.3 333110.7 35249.3 36056.8 62975.4 63450.4 63530.4 37465.3 37644.6 37796.8 37816.1 37829.8 13727.4 13879.7 13887.7 13891.2 13895.7 11232.2 11292.6 11310.4 11315.3 11331.1 8546.1 8582.9 8605.4 8629.2 8654.6 3271.4 3275.7 3334.7 3335.8 3374.7 962.3 1022.3 1035.5 1074.2 1107.8 32476.5 32994.8 33248.5 33314.0 33683.7 1112.2 1116.4 1126.7 1176.8 1185.5 16910.2 17264.7 17388.1 17625.4 17671.6 524106.0 528875.0 530000.0 530123.0 530211.0 59979.7 60550.7 60614.7 60618.0 60706.0 1267.1 1396.2 1397.1 1407.7 1431.7 33538.0 34742.8 35113.8 35284.5 35370.3 52689.0 53281.5 53303.0 53327.7 53350.7 419682.0 423276.0 423587.0 423806.0 425278.0 28052.0 29302.3 29347.4 29363.3 29460.4 48170.0 49220.3 49251.0 50047.2 50377.7 42244.8 42263.8 42757.0 42921.0 43642.8 41738.0 42256.0 42325.8 42405.8 42943.6 41322.6 41897.8 43050.1 43110.4 45257.1 36082.0 37197.8 38303.4 38526.2 38862.8 29153.1 29184.6 29195.3 29417.1 29593.4 11:28:50 INFO - PROCESS | 22072 | 11:28:50 INFO - PROCESS | 22072 | [#2] jquery.html Cycles:180 Average:27517.23 Median:2464.93 stddev:74407.64 (3018.7%) stddev-sans-first:74588.46 11:28:50 INFO - PROCESS | 22072 | Values: 373.6 380.0 408.5 412.3 415.2 18138.5 18602.4 19368.9 19809.1 19821.5 17425.9 17732.4 18050.8 18288.7 18314.5 5526.2 5574.8 5588.1 5719.9 5732.9 5625.0 5665.3 5681.8 5686.6 5699.5 5517.3 5669.9 5670.2 5786.0 5791.2 5762.3 5823.4 5825.4 5869.9 5899.4 5773.6 5826.9 5855.3 5860.8 5864.0 13734.9 13930.7 14349.9 14369.1 14385.8 2271.4 2357.4 2394.9 2416.8 2513.1 9879.6 10470.5 10519.5 10603.0 10664.9 1955.4 2022.5 2072.0 2118.4 2154.9 63048.7 78325.0 83450.0 83687.6 86421.0 9200.0 9770.2 9898.4 10110.5 10752.5 13683.0 13715.1 14359.1 15238.8 15256.8 7658.9 7697.7 7894.8 8033.5 8049.5 7327.7 7375.5 7430.5 7464.4 7546.5 4906.5 4906.7 4920.8 4937.8 4976.7 1916.7 2001.6 2011.8 2013.0 2027.3 922.5 1051.0 1091.8 1095.7 1116.5 18358.0 18989.7 19094.1 19113.0 19234.5 1011.4 1032.9 1051.5 1068.1 1098.9 10242.6 10929.8 10956.7 10962.5 10979.2 425176.0 425271.0 457373.0 467365.0 467918.0 92442.5 93918.5 94421.0 95364.0 96477.7 1039.1 1042.3 1051.8 1051.8 1057.5 16582.0 16836.3 17048.4 17116.1 17364.0 42009.0 42091.6 42507.8 42642.4 42875.1 58299.7 59210.4 59871.1 60182.4 60725.1 8602.0 8717.8 8724.5 9000.0 9099.1 9835.4 12703.9 13146.1 13157.6 13220.6 5477.5 5795.8 11444.9 11839.3 11918.8 11513.6 11582.8 11599.2 11685.2 11740.8 11627.5 11813.0 11865.2 11873.2 12114.5 7704.1 8648.9 8814.9 8815.1 8856.0 11616.8 12004.5 12119.6 12247.4 12406.9 11:28:50 INFO - PROCESS | 22072 | 11:28:50 INFO - PROCESS | 22072 | [#3] mootools.html Cycles:180 Average:5958.21 Median:4789.50 stddev:3472.10 (72.5%) stddev-sans-first:3464.58 11:28:50 INFO - PROCESS | 22072 | Values: 1351.6 1504.1 1555.2 1676.3 1848.9 8445.7 8815.6 8822.5 9094.5 9099.4 8834.4 9023.2 9031.0 9034.8 9038.1 2033.9 2296.1 2296.6 2324.0 2375.2 2389.0 2392.8 2399.5 2400.7 2401.6 2295.8 2347.0 2347.7 2350.3 2352.0 2033.4 2263.1 2303.8 2311.5 2332.5 2257.3 2264.4 2267.3 2274.2 2310.4 9313.0 9350.3 9387.8 9394.0 9396.2 5259.9 5379.5 5388.7 5389.0 5393.5 3394.3 3406.8 3485.2 3528.8 3546.1 1154.8 1164.3 1166.8 1214.7 1237.3 12871.5 12928.2 12937.9 12968.7 12980.2 4680.4 4728.2 4836.3 4848.7 4849.0 10296.5 10300.4 10306.6 10312.2 10315.5 4634.8 5391.9 5397.6 5402.4 5403.2 4393.6 4452.4 4453.6 4742.7 4859.2 3845.6 3868.7 3965.3 3990.3 4000.3 1168.4 1170.7 1173.4 1176.7 1185.6 892.8 899.2 901.8 937.1 951.3 5855.3 5929.3 5945.1 5996.7 6046.6 938.8 945.2 981.8 985.1 985.2 4052.3 4077.8 4125.8 4133.5 4197.1 11526.8 11796.2 11853.1 11891.3 11936.3 10696.1 11608.7 11612.9 11676.1 11873.1 8277.7 8642.1 8666.4 8710.8 8723.6 5814.9 5887.6 5893.0 5926.0 5990.1 9812.0 10150.3 10316.3 10345.3 10370.1 10357.4 10379.3 10390.6 10400.5 10416.3 7359.6 7925.4 8023.8 8164.1 8310.8 8967.7 8997.9 9016.5 9051.4 9065.9 7944.9 8131.2 8135.6 8188.3 8217.4 7674.0 7779.9 7785.7 8014.4 8173.4 7138.4 7305.7 7508.3 7542.1 7563.2 5024.9 5046.9 5067.2 5151.6 5225.0 5178.0 5270.3 5321.9 5429.3 5475.6 11:28:50 INFO - PROCESS | 22072 | 11:28:50 INFO - PROCESS | 22072 | [#4] prototype.html Cycles:180 Average:4503.04 Median:5073.11 stddev:1310.08 (25.8%) stddev-sans-first:1275.28 11:28:50 INFO - PROCESS | 22072 | Values: 304.2 317.3 318.6 321.5 321.7 5233.3 5363.6 5394.2 5441.3 5451.6 5227.5 5411.6 5429.8 5446.9 5448.9 4215.6 4221.3 4228.7 4234.0 4248.4 3972.3 4017.9 4196.8 4219.8 4233.2 4118.9 4160.7 4166.4 4182.6 4182.6 4138.5 4142.6 4146.0 4165.3 4177.8 3444.5 3661.6 3667.4 3667.6 3676.3 5200.4 5232.2 5232.4 5245.9 5266.3 4731.6 4732.0 4733.0 4733.6 4741.6 5387.4 5587.4 5615.7 5619.2 5628.2 3896.7 3941.9 3947.7 3960.3 3964.2 5804.6 5855.3 5859.0 5881.6 5904.4 3948.6 3990.0 4010.0 4011.8 4018.7 4062.4 4066.5 4073.7 4077.9 4095.4 4669.8 4670.3 4692.6 4693.9 4749.2 5333.5 5580.4 5689.2 5691.7 5706.2 1351.7 1367.2 1373.7 1382.1 1389.2 868.9 894.3 894.8 899.5 904.6 4775.7 4834.7 4862.5 4865.7 4891.0 4881.6 5134.6 5151.7 5181.0 5181.6 4803.5 4810.4 4848.8 4858.4 4911.6 2686.5 2701.1 2721.0 2742.6 2743.7 5049.5 5219.5 5222.8 5235.4 5291.7 5150.5 5166.9 5175.3 5185.3 5207.6 5246.7 5259.3 5260.0 5295.2 5331.8 4809.3 5118.5 5184.7 5201.5 5230.3 5052.0 5068.7 5077.5 5102.7 5190.8 4945.5 5219.8 5224.9 5244.2 5274.7 3692.2 3699.9 3700.6 3703.5 3715.5 5124.8 5134.4 5146.7 5157.3 5205.5 4890.7 4900.2 4994.5 5002.8 5012.1 5278.1 5424.7 5569.0 5682.6 5703.6 5479.2 5481.6 5519.3 5620.7 5630.5 5699.7 5754.5 5766.0 5770.3 5778.8 5488.3 5501.9 5540.3 5581.9 5585.7 11:28:50 INFO - PROCESS | 22072 | 11:28:50 INFO - PROCESS | 22072 | [#5] yui.html Cycles:180 Average:16609.34 Median:4632.64 stddev:20682.39 (446.4%) stddev-sans-first:20706.39 11:28:50 INFO - PROCESS | 22072 | Values: 813.5 819.6 850.9 854.4 876.1 14459.5 15031.5 15048.5 15095.6 15097.7 13307.2 13714.5 14074.3 14202.1 14223.5 813.9 819.7 826.7 826.8 827.3 811.6 816.7 818.5 819.1 819.7 857.4 859.3 866.0 868.7 869.0 855.2 856.2 857.0 859.1 862.5 623.5 625.7 627.2 629.1 629.4 13463.2 13525.9 13555.4 14203.4 14551.6 13312.4 13638.7 13793.4 13930.1 14089.4 11119.5 11271.7 11297.5 11348.0 11422.1 3635.8 3685.1 3692.2 3712.9 3765.7 54764.0 56029.2 56059.7 61354.9 62346.4 10505.6 10680.5 10706.4 10840.2 11371.7 19761.2 19914.4 19947.0 20050.5 20062.4 8293.8 8326.2 8330.7 8377.8 8600.1 4609.5 4655.8 4735.3 4818.3 4913.4 3321.0 3327.5 3368.3 3397.9 3399.9 673.7 676.6 688.3 694.6 702.6 697.1 706.4 713.6 761.6 778.4 10005.5 10122.5 10257.4 10329.2 10368.3 682.9 772.3 781.2 810.4 822.9 4680.0 4780.3 4801.0 4803.9 4873.0 73311.6 77106.2 78835.6 79641.6 81469.6 70445.6 70477.3 70634.3 70770.6 71879.6 52710.7 52909.0 62851.7 64643.7 65067.3 9706.3 9709.8 9796.6 9869.3 9939.3 38078.2 38239.0 38613.8 38915.4 39201.0 48053.8 51556.5 52592.7 53338.7 53821.0 12663.9 12728.8 12813.5 12894.5 13090.7 14130.7 14240.3 14381.0 14464.9 14647.1 13331.7 13390.4 13535.2 13769.0 13890.8 13004.5 13324.4 13329.6 13791.9 13807.8 13264.7 13468.9 14244.7 14250.2 14274.0 10866.9 11015.3 11297.7 11304.5 11632.3 10192.3 10282.9 11249.3 11279.7 11359.1 11:28:50 INFO - PROCESS | 22072 | -------- Summary: end -------- 11:28:50 INFO - PROCESS | 22072 | 11:28:51 INFO - TEST-INFO | 22072: exit 0 11:28:51 INFO - TEST-OK | dromaeo_css | took 1112387ms 11:28:51 INFO - TEST-START | kraken 11:28:51 INFO - operating with platform_type : linux_ 11:28:51 INFO - Initialising browser for kraken test... 11:28:51 INFO - TEST-INFO | started process 22264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVe91QJ/profile http://localhost:51539/getInfo.html) 11:28:55 INFO - PROCESS | 22264 | __metrics Screen width/height:1600/1200 11:28:55 INFO - PROCESS | 22264 | colorDepth:24 11:28:55 INFO - PROCESS | 22264 | Browser inner width/height: 1024/697 11:28:55 INFO - PROCESS | 22264 | __metrics 11:28:56 ERROR - PROCESS | 22264 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:28:57 INFO - TEST-INFO | 22264: exit 0 11:28:57 INFO - Browser initialized. 11:28:57 INFO - Running cycle 1/1 for kraken test... 11:28:57 INFO - TEST-INFO | started process 22345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVe91QJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:29:08 INFO - PROCESS | 22345 | RSS: Main: 152883200 11:29:08 INFO - PROCESS | 22345 | 11:29:11 INFO - PROCESS | 22345 | Cycle 1(1): loaded http://localhost:51539/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51539/tests/kraken/driver.html?testName=audio-beat-detection) 11:29:12 INFO - PROCESS | 22345 | RSS: Main: 208994304 11:29:12 INFO - PROCESS | 22345 | 11:29:15 INFO - PROCESS | 22345 | Cycle 1(1): loaded http://localhost:51539/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51539/tests/kraken/driver.html?testName=audio-dft) 11:29:15 INFO - PROCESS | 22345 | RSS: Main: 197804032 11:29:15 INFO - PROCESS | 22345 | 11:29:18 INFO - PROCESS | 22345 | Cycle 1(1): loaded http://localhost:51539/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51539/tests/kraken/driver.html?testName=audio-fft) 11:29:19 INFO - PROCESS | 22345 | RSS: Main: 264830976 11:29:19 INFO - PROCESS | 22345 | 11:29:21 INFO - PROCESS | 22345 | Cycle 1(1): loaded http://localhost:51539/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51539/tests/kraken/driver.html?testName=audio-oscillator) 11:29:22 INFO - PROCESS | 22345 | RSS: Main: 174645248 11:29:22 INFO - PROCESS | 22345 | 11:29:24 INFO - PROCESS | 22345 | Cycle 1(1): loaded http://localhost:51539/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51539/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:29:25 INFO - PROCESS | 22345 | RSS: Main: 179478528 11:29:25 INFO - PROCESS | 22345 | 11:29:28 INFO - PROCESS | 22345 | Cycle 1(1): loaded http://localhost:51539/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51539/tests/kraken/driver.html?testName=imaging-darkroom) 11:29:28 INFO - PROCESS | 22345 | RSS: Main: 214433792 11:29:28 INFO - PROCESS | 22345 | 11:29:32 INFO - PROCESS | 22345 | Cycle 1(1): loaded http://localhost:51539/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51539/tests/kraken/driver.html?testName=imaging-desaturate) 11:29:33 INFO - PROCESS | 22345 | RSS: Main: 212254720 11:29:33 INFO - PROCESS | 22345 | 11:29:35 INFO - PROCESS | 22345 | Cycle 1(1): loaded http://localhost:51539/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51539/tests/kraken/driver.html?testName=json-parse-financial) 11:29:36 INFO - PROCESS | 22345 | RSS: Main: 214458368 11:29:36 INFO - PROCESS | 22345 | 11:29:38 INFO - PROCESS | 22345 | Cycle 1(1): loaded http://localhost:51539/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51539/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:29:38 INFO - PROCESS | 22345 | RSS: Main: 201711616 11:29:38 INFO - PROCESS | 22345 | 11:29:40 INFO - PROCESS | 22345 | Cycle 1(1): loaded http://localhost:51539/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51539/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:29:41 INFO - PROCESS | 22345 | RSS: Main: 206196736 11:29:41 INFO - PROCESS | 22345 | 11:29:43 INFO - PROCESS | 22345 | Cycle 1(1): loaded http://localhost:51539/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51539/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:29:44 INFO - PROCESS | 22345 | RSS: Main: 216248320 11:29:44 INFO - PROCESS | 22345 | 11:29:46 INFO - PROCESS | 22345 | Cycle 1(1): loaded http://localhost:51539/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51539/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:29:47 INFO - PROCESS | 22345 | RSS: Main: 222912512 11:29:47 INFO - PROCESS | 22345 | 11:29:50 INFO - PROCESS | 22345 | Cycle 1(1): loaded http://localhost:51539/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51539/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:29:50 INFO - PROCESS | 22345 | RSS: Main: 218177536 11:29:50 INFO - PROCESS | 22345 | 11:29:52 INFO - PROCESS | 22345 | Cycle 1(1): loaded http://localhost:51539/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51539/tests/kraken/driver.html?testName=ai-astar) 11:29:52 INFO - PROCESS | 22345 | RSS: Main: 264101888 11:29:52 INFO - PROCESS | 22345 | 11:29:52 INFO - PROCESS | 22345 | __start_tp_report 11:29:52 INFO - PROCESS | 22345 | _x_x_mozilla_page_load 11:29:52 INFO - PROCESS | 22345 | _x_x_mozilla_page_load_details 11:29:52 INFO - PROCESS | 22345 | |i|pagename|runs| 11:29:52 INFO - PROCESS | 22345 | |0;ai-astar;109;105;110;108;109;113;113;110;111;109 11:29:52 INFO - PROCESS | 22345 | |1;audio-beat-detection;159;125;153;204;124;159;151;126;197;126 11:29:52 INFO - PROCESS | 22345 | |2;audio-dft;162;162;162;161;159;161;162;161;161;161 11:29:52 INFO - PROCESS | 22345 | |3;audio-fft;74;75;75;144;75;73;75;73;133;75 11:29:52 INFO - PROCESS | 22345 | |4;audio-oscillator;91;92;151;101;91;91;134;91;92;121 11:29:52 INFO - PROCESS | 22345 | |5;imaging-gaussian-blur;116;116;117;117;116;117;117;117;116;117 11:29:52 INFO - PROCESS | 22345 | |6;imaging-darkroom;146;145;144;146;145;145;145;145;145;145 11:29:52 INFO - PROCESS | 22345 | |7;imaging-desaturate;94;94;95;95;94;95;94;95;95;94 11:29:52 INFO - PROCESS | 22345 | |8;json-parse-financial;54;52;54;53;54;54;55;114;53;52 11:29:52 INFO - PROCESS | 22345 | |9;json-stringify-tinderbox;59;61;60;59;60;60;60;59;64;59 11:29:52 INFO - PROCESS | 22345 | |10;stanford-crypto-aes;79;79;85;79;81;79;79;81;83;80 11:29:52 INFO - PROCESS | 22345 | |11;stanford-crypto-ccm;120;131;119;132;126;117;116;117;210;123 11:29:52 INFO - PROCESS | 22345 | |12;stanford-crypto-pbkdf2;160;157;163;158;164;157;158;163;157;157 11:29:52 INFO - PROCESS | 22345 | |13;stanford-crypto-sha256-iterative;63;63;62;63;61;62;64;62;61;61 11:29:52 INFO - PROCESS | 22345 | __end_tp_report 11:29:52 INFO - PROCESS | 22345 | __start_cc_report 11:29:52 INFO - PROCESS | 22345 | _x_x_mozilla_cycle_collect,1862 11:29:52 INFO - PROCESS | 22345 | __end_cc_report 11:29:52 INFO - PROCESS | 22345 | __startTimestamp1463596192652__endTimestamp 11:29:52 INFO - PROCESS | 22345 | 11:29:52 INFO - PROCESS | 22345 | ------- Summary: start ------- 11:29:52 INFO - PROCESS | 22345 | Number of tests: 14 11:29:52 INFO - PROCESS | 22345 | 11:29:52 INFO - PROCESS | 22345 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:2.36 (2.1%) stddev-sans-first:2.49 11:29:52 INFO - PROCESS | 22345 | Values: 109.0 105.0 110.0 108.0 109.0 113.0 113.0 110.0 111.0 109.0 11:29:52 INFO - PROCESS | 22345 | 11:29:52 INFO - PROCESS | 22345 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:156.00 stddev:29.24 (18.7%) stddev-sans-first:30.91 11:29:52 INFO - PROCESS | 22345 | Values: 159.0 125.0 153.0 204.0 124.0 159.0 151.0 126.0 197.0 126.0 11:29:52 INFO - PROCESS | 22345 | 11:29:52 INFO - PROCESS | 22345 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.92 (0.6%) stddev-sans-first:0.93 11:29:52 INFO - PROCESS | 22345 | Values: 162.0 162.0 162.0 161.0 159.0 161.0 162.0 161.0 161.0 161.0 11:29:52 INFO - PROCESS | 22345 | 11:29:52 INFO - PROCESS | 22345 | [#3] audio-fft Cycles:10 Average:87.20 Median:75.00 stddev:27.17 (36.2%) stddev-sans-first:28.40 11:29:52 INFO - PROCESS | 22345 | Values: 74.0 75.0 75.0 144.0 75.0 73.0 75.0 73.0 133.0 75.0 11:29:52 INFO - PROCESS | 22345 | 11:29:52 INFO - PROCESS | 22345 | [#4] audio-oscillator Cycles:10 Average:105.50 Median:91.00 stddev:21.98 (24.2%) stddev-sans-first:22.68 11:29:52 INFO - PROCESS | 22345 | Values: 91.0 92.0 151.0 101.0 91.0 91.0 134.0 91.0 92.0 121.0 11:29:52 INFO - PROCESS | 22345 | 11:29:52 INFO - PROCESS | 22345 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:29:52 INFO - PROCESS | 22345 | Values: 116.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 11:29:52 INFO - PROCESS | 22345 | 11:29:52 INFO - PROCESS | 22345 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 11:29:52 INFO - PROCESS | 22345 | Values: 146.0 145.0 144.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 11:29:52 INFO - PROCESS | 22345 | 11:29:52 INFO - PROCESS | 22345 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 11:29:52 INFO - PROCESS | 22345 | Values: 94.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 11:29:52 INFO - PROCESS | 22345 | 11:29:52 INFO - PROCESS | 22345 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:54.00 stddev:19.17 (35.5%) stddev-sans-first:20.23 11:29:52 INFO - PROCESS | 22345 | Values: 54.0 52.0 54.0 53.0 54.0 54.0 55.0 114.0 53.0 52.0 11:29:52 INFO - PROCESS | 22345 | 11:29:52 INFO - PROCESS | 22345 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:1.52 (2.5%) stddev-sans-first:1.56 11:29:52 INFO - PROCESS | 22345 | Values: 59.0 61.0 60.0 59.0 60.0 60.0 60.0 59.0 64.0 59.0 11:29:52 INFO - PROCESS | 22345 | 11:29:52 INFO - PROCESS | 22345 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.50 stddev:2.07 (2.6%) stddev-sans-first:2.12 11:29:52 INFO - PROCESS | 22345 | Values: 79.0 79.0 85.0 79.0 81.0 79.0 79.0 81.0 83.0 80.0 11:29:52 INFO - PROCESS | 22345 | 11:29:52 INFO - PROCESS | 22345 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:124.50 stddev:28.31 (22.7%) stddev-sans-first:29.74 11:29:52 INFO - PROCESS | 22345 | Values: 120.0 131.0 119.0 132.0 126.0 117.0 116.0 117.0 210.0 123.0 11:29:52 INFO - PROCESS | 22345 | 11:29:52 INFO - PROCESS | 22345 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.40 Median:159.00 stddev:2.88 (1.8%) stddev-sans-first:3.04 11:29:52 INFO - PROCESS | 22345 | Values: 160.0 157.0 163.0 158.0 164.0 157.0 158.0 163.0 157.0 157.0 11:29:52 INFO - PROCESS | 22345 | 11:29:52 INFO - PROCESS | 22345 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.50 stddev:1.03 (1.7%) stddev-sans-first:1.05 11:29:52 INFO - PROCESS | 22345 | Values: 63.0 63.0 62.0 63.0 61.0 62.0 64.0 62.0 61.0 61.0 11:29:52 INFO - PROCESS | 22345 | -------- Summary: end -------- 11:29:52 INFO - PROCESS | 22345 | 11:29:53 INFO - TEST-INFO | 22345: exit 0 11:29:53 INFO - TEST-OK | kraken | took 62482ms 11:29:53 INFO - SUITE-END | took 1174s 11:29:53 INFO - Completed test suite (00:19:35) 11:29:53 INFO - javascript benchmark 11:29:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.2850944282814, 3124.453220686379, 3153.132888455674, 3165.699258570435, 3187.2669286064206, 5270.762815673294, 5303.65526240795, 5323.254744335792, 5407.5133238008575, 5440.619156659035, 5264.736763161845, 5284.497972692598, 5320.095583750762, 5323.866903327419, 5356.223347614594, 4716.033213191296, 4835.540623640766, 4844.903101937959, 4845.079434907374, 5052.26742122392, 4935.8272460463895, 4969.70181789092, 4987.725675087887, 5004.599632029447, 5012.849614511552, 4763.999560092385, 4814.422269327668, 4837.806487740486, 4839.249916262967, 4844.927326090112, 4826.686265392738, 4830.178869592142, 4913.385826771653, 4939.3578834751615, 4958.0, 4746.477887432379, 4863.537963893425, 4874.707517548958, 4897.975510122462, 4923.852284431473, 5252.133397989327, 5275.973620131913, 5348.893022139574, 5418.376886658046, 5421.728913554307, 5736.512396446307, 5740.512056475204, 5748.5975981681295, 5790.913136302959, 5796.101604251347, 5592.105263157916, 5653.180288858133, 5658.151277308396, 5765.4811067004175, 5825.359210486843, 5367.677939323614, 5392.514673679349, 5397.73011349431, 5404.486573775485, 5410.458954104597, 5880.117982302689, 5898.026825573818, 5899.321578018497, 5903.586748927534, 5904.0, 5513.393526712059, 5577.6932268724795, 5605.859853503695, 5619.915701264485, 5662.631928924689, 5726.541876649858, 5727.11229759388, 5740.966626007359, 5796.710164491843, 5798.94201057984, 5685.545156387562, 5711.657300561979, 5736.13957906309, 5744.253247077853, 5752.050911599539, 5541.030319694118, 5619.719014049281, 5646.322441307069, 5660.632058916157, 5690.317161940511, 4313.245182093121, 4315.568443155659, 4315.741055536678, 4332.220200363965, 4356.411884395629, 3822.617738226211, 3857.176205305453, 3860.3630400984084, 3918.3730603103368, 3927.3912543555793, 5285.577153827761, 5294.841154765363, 5297.417284098746, 5310.097283461821, 5387.057264978613, 5690.6870122142855, 5695.1741997410145, 5701.572382071361, 5708.71456427177, 5724.542036637059, 5300.92048619271, 5369.275147855068, 5388.0, 5389.649672771257, 5438.755256013489, 4898.387701537308, 4945.505449455098, 4954.1825598775795, 4977.626677999165, 4981.32752078472, 5948.613340132878, 5950.166976623276, 5956.285245770535, 5960.970195149083, 5967.850803729854, 5648.350439699323, 5794.420557944256, 5802.5357971361345, 5803.0, 5806.854828629318, 5869.266341707286, 5906.822795315976, 5943.286805583185, 5962.880742385215, 5974.522038237017, 5645.915311270416, 5654.802081927113, 5680.4319568042865, 5686.800961966312, 5693.231413759089, 5629.6903670298525, 5660.490555849993, 5802.245708057925, 5819.447152520504, 5821.214136091573, 5527.44725527444, 5580.386157522588, 5601.663900166003, 5604.131359639263, 5648.519875810603, 5567.331920169606, 5574.9721251393485, 5580.0, 5589.77640894376, 5592.105263157875, 5358.598105142052, 5478.91781623284, 5492.231087647652, 5517.531009864046, 5547.084731019337, 5680.772769089355, 5707.743151558273, 5713.942860571341, 5721.5136713379825, 5737.168110624019, 5565.248691426767, 5571.888562228652, 5573.665580065209, 5575.609707320611, 5614.185943038318], "value": 5280.723413177451, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.9313528944173, 624.3880996623309, 628.0516420205488, 640.151798866502, 643.8712257548491, 35420.645793542055, 36014.81992590037, 36129.81935090327, 43201.56798432015, 44216.0, 46638.533614663844, 46720.76639616806, 47023.0, 47069.52930470694, 47139.29291060637, 8744.431611945234, 8916.197542221198, 8917.108289171096, 8917.77705557363, 8964.910350896473, 8834.779130521756, 8903.332250081237, 8922.73231803047, 8944.329175311845, 8952.462852228855, 9007.0, 9032.0, 9051.864222036675, 9056.0, 9059.909400906006, 8918.152775486318, 8934.106589341047, 8961.820763584758, 8971.685990990349, 8985.37102402832, 8703.173198546128, 8802.515861627608, 8811.030786613468, 8823.602937867812, 8829.55852207387, 41752.58247417517, 41789.16421671549, 42068.57931420677, 42079.158416831495, 42168.57831421708, 3608.368535506302, 3674.4488326751202, 3772.9434058489146, 4125.381192821101, 4421.60205581496, 30625.38749225003, 32564.0, 32834.50748238778, 33289.83355083209, 33867.66132338694, 4358.0848021915435, 4409.867703968886, 4425.402570652953, 4448.377227188196, 4502.729836209838, 329723.0, 332446.0, 332894.3486977968, 333077.3346133278, 333110.68559172255, 35249.295014099574, 36056.819715901256, 62975.37024629787, 63450.36549634537, 63530.36469635337, 37465.25069498649, 37644.62355376466, 37796.811015944746, 37816.05459863525, 37829.810850946116, 13727.382267797973, 13879.722405551833, 13887.722245555033, 13891.235982020884, 13895.722085558435, 11232.157588180919, 11292.604758833402, 11310.434478276053, 11315.264507806965, 11331.093512518979, 8546.145385461405, 8582.914170858336, 8605.397622166389, 8629.22336989674, 8654.567271636393, 3271.4275001874576, 3275.7051865332232, 3334.749893757978, 3335.7831740936763, 3374.6794054564775, 962.2927148545813, 1022.2946167144646, 1035.5133087448887, 1074.1836204484648, 1107.8116720157593, 32476.512852307234, 32994.835025825196, 33248.501272480935, 33314.0, 33683.66316336854, 1112.238116889933, 1116.4138827115667, 1126.7352172239516, 1176.7999440095205, 1185.5020891225533, 16910.239039243017, 17264.654706905792, 17388.130593470276, 17625.383111591033, 17671.558211044827, 524106.0, 528875.0, 530000.0, 530123.0, 530211.0, 59979.700101500086, 60550.69724651348, 60614.696926515084, 60618.0, 60706.0, 1267.113020885384, 1396.1553260277385, 1397.105852254558, 1407.6973450708147, 1431.7494438473225, 33538.0, 34742.82628586841, 35113.824430877685, 35284.47073293851, 35370.29259414849, 52689.0, 53281.46718532765, 53303.0, 53327.73336133295, 53350.73324633352, 419682.0, 423276.0, 423587.0, 423806.0, 425278.0, 28052.0, 29302.26744331409, 29347.413051739273, 29363.265918352212, 29460.410791784474, 48170.0, 49220.2616960753, 49251.0, 50047.249291259934, 50377.74811126068, 42244.788776055924, 42263.7886810564, 42757.0, 42921.0, 43642.781786092135, 41738.0, 42256.0, 42325.78837105795, 42405.787971059945, 42943.57056429521, 41322.58677413187, 41897.79051104725, 43050.138997219256, 43110.35334470048, 45257.094858103315, 36082.0, 37197.814010929775, 38303.42544861885, 38526.229475410895, 38862.80568597139, 29153.125406237847, 29184.56223156612, 29195.270118246364, 29417.14771889752, 29593.408131837674], "value": 19106.45615972993, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.5517379145023, 379.9696024318053, 408.46695062942865, 412.26410856620936, 415.21731536054546, 18138.54653633658, 18602.441926742187, 19368.903155484204, 19809.108590113443, 19821.504462388446, 17425.912870435663, 17732.37936672217, 18050.81949180508, 18288.72566911494, 18314.450566482992, 5526.198701188336, 5574.804881829137, 5588.133839254922, 5719.857003574903, 5732.914006289888, 5625.0, 5665.320161580596, 5681.7727290908315, 5686.6019378643305, 5699.515541179005, 5517.282753242073, 5669.886602267952, 5670.177824215486, 5786.0, 5791.21818554494, 5762.3373312069225, 5823.388544202861, 5825.359210486864, 5869.941300587004, 5899.410058994109, 5773.624714393551, 5826.941730582682, 5855.2973643163095, 5860.7948721794955, 5864.032434648278, 13734.931325343408, 13930.721385572333, 14349.923755718259, 14369.13785172893, 14385.78421323681, 2271.3980795089315, 2357.351728274721, 2394.856308621471, 2416.7945724613255, 2513.057603398707, 9879.604815807359, 10470.476476176236, 10519.47402629873, 10603.045725884707, 10664.893351066468, 1955.4426988308405, 2022.5247066939257, 2071.989640051805, 2118.3962570667286, 2154.8707077575395, 63048.68475657592, 78325.0, 83450.0, 83687.58156209241, 86421.0, 9199.954000229956, 9770.169535589412, 9898.406095634286, 10110.545025473872, 10752.516136773864, 13683.0, 13715.1085179463, 14359.138451692932, 15238.847611523743, 15256.771148432783, 7658.885116723253, 7697.730579429805, 7894.763157105296, 8033.517988920684, 8049.476784009021, 7327.743528976567, 7375.451155257349, 7430.479866409408, 7464.365528929993, 7546.471746977769, 4906.533879281534, 4906.656534042583, 4920.803167873317, 4937.7777999990085, 4976.651634385631, 1916.6741653918866, 2001.5896741168026, 2011.8390528757664, 2012.9698054528901, 2027.2600500817096, 922.5387306346827, 1051.0, 1091.792559413709, 1095.6932059023486, 1116.5366372955132, 18358.0, 18989.715154272697, 19094.14076366567, 19113.0, 19234.519137021685, 1011.4437059617181, 1032.9018743219533, 1051.4795176387738, 1068.076114161245, 1098.8516550265613, 10242.6415075472, 10929.836052459219, 10956.671299861016, 10962.451877406258, 10979.1765617579, 425176.0, 425271.0, 457373.0, 467365.0, 467918.0, 92442.53778731063, 93918.53040734753, 94421.0, 95364.0, 96477.6937268443, 1039.1063685230847, 1042.2704107125044, 1051.779126383468, 1051.8001579699985, 1057.5082586597268, 16582.0, 16836.326546937984, 17048.403305884236, 17116.144192790558, 17364.0, 42009.0, 42091.57908420999, 42507.7874610625, 42642.36036459394, 42875.142497150504, 58299.70850145722, 59210.37501437357, 59871.10193347016, 60182.398176017676, 60725.0891236623, 8601.95699021526, 8717.782055448664, 8724.476531408136, 9000.0, 9099.090090990849, 9835.360701554377, 12703.93648031754, 13146.145500542816, 13157.60527184186, 13220.603381898558, 5477.507024367826, 5795.82612521625, 11444.94277528607, 11839.348835814113, 11918.761624767283, 11513.597024104116, 11582.768344632892, 11599.188056835941, 11685.182037257311, 11740.823887641522, 11627.534898604299, 11813.0, 11865.228760130563, 11873.168878178445, 12114.454849531969, 7704.114026886979, 8648.913510864812, 8814.864047139523, 8815.074417186359, 8856.0, 11616.825747613624, 12004.519819207135, 12119.636410907688, 12247.448864800926, 12406.875931240573], "value": 9031.84757591138, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.5742541099546, 1504.1351223046747, 1555.237933412628, 1676.3210899585665, 1848.8613353998453, 8445.704400345989, 8815.559222038888, 8822.514761688113, 9094.49980251086, 9099.408538444997, 8834.425762325445, 9023.23302519285, 9031.0, 9034.81930361394, 9038.096190380975, 2033.857629965903, 2296.0815673730517, 2296.632538793793, 2324.0122947747222, 2375.168690958168, 2389.0205015943466, 2392.820538459614, 2399.4961058177805, 2400.6879105716234, 2401.555712193241, 2295.82781291403, 2347.049444974788, 2347.7065366829147, 2350.3419042667997, 2352.047420794581, 2033.4204751645784, 2263.1400067974228, 2303.7926586607286, 2311.5492478966607, 2332.54515369503, 2257.3115199864037, 2264.388615073937, 2267.30847091637, 2274.226762900622, 2310.445493081665, 9313.0, 9350.251979841596, 9387.812243755156, 9393.953030234805, 9396.201322887562, 5259.894802103975, 5379.462053794628, 5388.7305634718105, 5389.0, 5393.460653934614, 3394.3381040697072, 3406.8466918988456, 3485.1984043669845, 3528.752987290891, 3546.131197856542, 1154.8440960470314, 1164.2781475485253, 1166.789977803995, 1214.7401750420745, 1237.2885590785245, 12871.549495767696, 12928.224306541637, 12937.935310323483, 12968.675783105404, 12980.156289841225, 4680.368150299734, 4728.17256980034, 4836.298736683231, 4848.684835485682, 4849.0, 10296.485175741183, 10300.381977081399, 10306.639267625596, 10312.226583006304, 10315.484225788681, 4634.814607415733, 5391.865203369947, 5397.622166448389, 5402.405735369106, 5403.189521571796, 4393.582609652142, 4452.354408610733, 4453.599176074104, 4742.691725037862, 4859.222524396079, 3845.615438456188, 3868.671162951124, 3965.3060714375447, 3990.2618015666612, 4000.299947509174, 1168.3807581981393, 1170.6722117807028, 1173.3781096019125, 1176.7352345722145, 1185.5909711149638, 892.7946572288411, 899.1997122560927, 901.7790641292926, 937.105064663245, 951.3435729346728, 5855.268091488564, 5929.341925716447, 5945.078512830518, 5996.67018313997, 6046.5767396281835, 938.7606160429046, 945.2013048973606, 981.7840075183448, 985.0592683986775, 985.1675334342469, 4052.2908491014546, 4077.7553346799286, 4125.793710314472, 4133.503979522417, 4197.055662475918, 11526.827097593543, 11796.174267801172, 11853.111016673784, 11891.28652280866, 11936.28382297065, 10696.144308455305, 11608.709782255512, 11612.94193529027, 11676.065914726802, 11873.109516786275, 8277.710280140167, 8642.092580279106, 8666.350023748244, 8710.825783484295, 8723.60743766532, 5814.883702326015, 5887.646741195542, 5893.0, 5925.970370148121, 5990.071538911476, 9812.0, 10150.340227885164, 10316.27786054969, 10345.275830691779, 10370.11853992389, 10357.4303413313, 10379.325343852626, 10390.58437662485, 10400.47997600102, 10416.270861039655, 7359.558426494427, 7925.405594580545, 8023.759287221393, 8164.0814408615115, 8310.792230194053, 8967.686130985385, 8997.91002089997, 9016.459012459274, 9051.366404351895, 9065.909340906506, 7944.880826787718, 8131.186881311822, 8135.552544609866, 8188.303994160325, 8217.424780265324, 7674.0, 7779.92220077792, 7785.727499537489, 8014.438989270695, 8173.386995975445, 7138.357547820721, 7305.707771689073, 7508.324250817453, 7542.094948606203, 7563.168051514219, 5024.949750502595, 5046.873828154178, 5067.239914012927, 5151.587872970228, 5225.0, 5177.974110129576, 5270.288511051112, 5321.946780532146, 5429.294191755047, 5475.6440831345835], "value": 4716.470330133415, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.16810024582765, 317.3082679758127, 318.5731120298799, 321.4856230031949, 321.7442133503864, 5233.319668443097, 5363.597730170233, 5394.165983565587, 5441.2654291670615, 5451.563874890014, 5227.477252274771, 5411.648242864211, 5429.782808687658, 5446.945530544694, 5448.863778405542, 4215.599518045796, 4221.32458806591, 4228.661707063436, 4233.957660423403, 4248.406847432213, 3972.324704800191, 4017.8995525111814, 4196.790160491979, 4219.789010549475, 4233.216854881842, 4118.917621647565, 4160.667146628278, 4166.375043743433, 4182.560831112735, 4182.6235638792505, 4138.530821558348, 4142.647874930634, 4146.0, 4165.33354663254, 4177.811998460076, 3444.50054742061, 3661.560612726463, 3667.423008106513, 3667.5782285037294, 3676.3198808220563, 5200.427952925213, 5232.241325007891, 5232.372115346145, 5245.947540524584, 5266.262723218752, 4731.580525842268, 4732.0, 4732.9763351183365, 4733.573978341931, 4741.596964258008, 5387.434319396485, 5587.413321601254, 5615.691136987464, 5619.157126431027, 5628.155776633497, 3896.7272290939645, 3941.881743547698, 3947.723659343847, 3960.3465428204313, 3964.2467931093, 5804.564657650651, 5855.268091488564, 5859.0, 5881.647101173943, 5904.409559044061, 3948.5853985331128, 3989.9601003989587, 4009.9599004009588, 4011.839526418969, 4018.718689691752, 4062.431259623655, 4066.512018557792, 4073.6944729145434, 4077.857274995361, 4095.4266402703647, 4669.789859456333, 4670.299455081765, 4692.601128904082, 4693.906121877543, 4749.168895443284, 5333.5199832015305, 5580.386157522669, 5689.231953686282, 5691.658500489901, 5706.174024312263, 1351.7228968061524, 1367.2275164532207, 1373.7115205806692, 1382.1292585671165, 1389.173441802126, 868.8957325121025, 894.3024440936081, 894.8434024045766, 899.5142622983647, 904.6471875968377, 4775.689580177277, 4834.685745426536, 4862.513748625109, 4865.659403841768, 4891.0, 4881.633877459205, 5134.614903882149, 5151.6908985461, 5181.0, 5181.611379146579, 4803.519648035169, 4810.4467986182035, 4848.8302909398, 4858.416989961227, 4911.582515486152, 2686.535837968273, 2701.1356365963097, 2721.0, 2742.58861170822, 2743.670759508832, 5049.495050494921, 5219.478052194826, 5222.764975576032, 5235.39792923811, 5291.708956007379, 5150.510701483353, 5166.940777140677, 5175.343889955178, 5185.325907632059, 5207.583393328525, 5246.685198888079, 5259.289995850511, 5259.973700131475, 5295.232191332235, 5331.840044798662, 4809.278608208797, 5118.488151185001, 5184.740762961761, 5201.479852014768, 5230.34620672416, 5051.953958646754, 5068.695878247317, 5077.517635824591, 5102.69383836971, 5190.844274671766, 4945.4807245238735, 5219.843404697714, 5224.947750522446, 5244.239585260192, 5274.709890955881, 3692.1692619160476, 3699.9260014799015, 3700.5744339401313, 3703.5000274963613, 3715.479832823353, 5124.820631278037, 5134.358205224347, 5146.6911985281, 5157.323869742274, 5205.45342739007, 4890.6550698558185, 4900.240462728283, 4994.525520075587, 5002.8243362810435, 5012.072766538202, 5278.129108697176, 5424.728763561727, 5568.97215513936, 5682.636167319731, 5703.5722320826935, 5479.205515200194, 5481.616286859881, 5519.254900588369, 5620.718964051863, 5630.465105814941, 5699.686517241592, 5754.510866576388, 5766.0, 5770.3364113125845, 5778.81534285462, 5488.259085023471, 5501.9174712380145, 5540.310205387395, 5581.944180558305, 5585.743207778218], "value": 4081.4996626855104, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.5118928642813, 819.5779173725531, 850.8681154421067, 854.3891117850735, 876.1282523888732, 14459.493917712882, 15031.549053528399, 15048.473303434355, 15095.62260943477, 15097.698046039073, 13307.201567905908, 13714.519991800289, 14074.29628518575, 14202.147871127714, 14223.502177423792, 813.9186081391873, 819.7335865843595, 826.7313123234943, 826.8304997475533, 827.3009307135491, 811.6144831205189, 816.6692489541745, 818.472085504849, 819.1276290750361, 819.7212947597816, 857.3826844671827, 859.3426029087752, 865.9740207793776, 868.6699054359366, 868.9782755431133, 855.2345650642671, 856.1780690537092, 856.9614367353485, 859.1236938322938, 862.5256109139948, 623.5261201486902, 625.6527627166921, 627.2347735762363, 629.072118625029, 629.4177885455935, 13463.192208467523, 13525.932370338085, 13555.390007449689, 14203.360848761831, 14551.563453096318, 13312.400941957538, 13638.727225455435, 13793.379297931617, 13930.094543854719, 14089.436422543085, 11119.499622517005, 11271.718207044889, 11297.491612877358, 11347.982619491, 11422.14333924959, 3635.836387362575, 3685.1155722626377, 3692.150805314766, 3712.925741485155, 3765.7363984521094, 54764.0, 56029.15956260659, 56059.719701401234, 61354.94418141882, 62346.376536234966, 10505.632302869362, 10680.465976701134, 10706.357618542912, 10840.241183117107, 11371.749107598158, 19761.209551618063, 19914.402567922985, 19947.0, 20050.498737531678, 20062.39812805589, 8293.751187464264, 8326.167383261625, 8330.66677332912, 8377.83244335122, 8600.09698981598, 4609.516000819933, 4655.767211639404, 4735.313379559944, 4818.349522814376, 4913.434954980223, 3320.9833950830575, 3327.5008748687405, 3368.326334733063, 3397.881074162442, 3399.8810041648426, 673.6934694713893, 676.5500941873697, 688.2601203705937, 694.5936627073118, 702.5644100657523, 697.1425147069133, 706.4348521183033, 713.5575942915426, 761.6382218446194, 778.4473024152915, 10005.549750261256, 10122.54448549817, 10257.435841028815, 10329.173666106693, 10368.274220804622, 682.9248782633906, 772.2663469703804, 781.1914668318377, 810.3719617296642, 822.942394032412, 4679.953200467951, 4780.259059845729, 4800.975995120002, 4803.927941080887, 4872.9512704872495, 73311.63344183352, 77106.22893771103, 78835.60582197167, 79641.60179199182, 81469.59265203636, 70445.6477717608, 70477.2952270481, 70634.29365706276, 70770.64614676894, 71879.6406017977, 52710.736446317525, 52909.0, 62851.685741571, 64643.67678161579, 65067.34932650708, 9706.320557560903, 9709.757256068655, 9796.608135674493, 9869.259805514472, 9939.254555908192, 38078.238435231695, 38239.0, 38613.80693096516, 38915.416268756555, 39201.0, 48053.75973120112, 51556.484435155166, 52592.737036314575, 53338.73330633322, 53821.0, 12663.93668031654, 12728.809067863804, 12813.487460501476, 12894.548690795777, 13090.738185236432, 14130.717385652024, 14240.287985600471, 14381.0, 14464.855351446771, 14647.070585882653, 13331.733365332446, 13390.397432115773, 13535.187888726708, 13769.0, 13890.791638125638, 13004.544840930523, 13324.400401982128, 13329.600111996655, 13791.862081379059, 13807.792883106962, 13264.734705306033, 13468.86531134676, 14244.715105698035, 14250.216238107003, 14274.0, 10866.945665271624, 11015.284006539548, 11297.661070167907, 11304.49129789145, 11632.302061876315, 10192.337498062601, 10282.948585257325, 11249.268797528135, 11279.718007049561, 11359.148063895405], "value": 7132.318132769789, "unit": "score"}], "name": "dromaeo_css", "value": 7072.29366805282, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 110.0, 108.0, 109.0, 113.0, 113.0, 110.0, 111.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 153.0, 204.0, 124.0, 159.0, 151.0, 126.0, 197.0, 126.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 159.0, 161.0, 162.0, 161.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 144.0, 75.0, 73.0, 75.0, 73.0, 133.0, 75.0], "value": 87.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 151.0, 101.0, 91.0, 91.0, 134.0, 91.0, 92.0, 121.0], "value": 105.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 144.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 54.0, 53.0, 54.0, 54.0, 55.0, 114.0, 53.0, 52.0], "value": 59.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 59.0, 60.0, 60.0, 60.0, 59.0, 64.0, 59.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 85.0, 79.0, 81.0, 79.0, 79.0, 81.0, 83.0, 80.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 131.0, 119.0, 132.0, 126.0, 117.0, 116.0, 117.0, 210.0, 123.0], "value": 131.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 157.0, 163.0, 158.0, 164.0, 157.0, 158.0, 163.0, 157.0, 157.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 63.0, 61.0, 62.0, 64.0, 62.0, 61.0, 61.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1525.0, "alertThreshold": 2.0}]} 11:29:53 INFO - Return code: 0 11:29:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:29:53 ERROR - # TBPL SUCCESS # 11:29:53 INFO - Running post-action listener: _resource_record_post_action 11:29:53 INFO - ##### 11:29:53 INFO - ##### Finished run-tests step (success) 11:29:53 INFO - ##### 11:29:53 INFO - Running post-run listener: _resource_record_post_run 11:29:54 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 388370432; Read time: 20; Write time: 345320 11:29:54 INFO - TinderboxPrint: CPU usage
13.2% 11:29:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 11:29:54 INFO - TinderboxPrint: I/O write bytes / time
388,370,432 / 345,320 11:29:54 INFO - TinderboxPrint: CPU idle
8,264.1 (86.8%) 11:29:54 INFO - TinderboxPrint: CPU user
1,212.0 (12.7%) 11:29:54 INFO - TinderboxPrint: Swap in / out
0 / 0 11:29:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104271872; Read time: 0; Write time: 72964 11:29:54 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284098560; Read time: 20; Write time: 272356 11:29:54 INFO - Running post-run listener: _upload_blobber_files 11:29:54 INFO - Blob upload gear active. 11:29:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:29:54 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 11:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:29:55 INFO - (blobuploader) - INFO - Open directory for files ... 11:29:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:29:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:29:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:55 INFO - (blobuploader) - INFO - Done attempting. 11:29:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:29:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:29:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:56 INFO - (blobuploader) - INFO - Done attempting. 11:29:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:29:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:30:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:30:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:30:00 INFO - (blobuploader) - INFO - Done attempting. 11:30:00 INFO - (blobuploader) - INFO - Iteration through files over. 11:30:00 INFO - Return code: 0 11:30:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:30:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:30:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7ad6c57325db2797ed0e464bed9433d7048666b55ba15bf08688ba1682177d983c058bebeca03c20dde6f93d15f8e749ad36e0deac06b34c53d99c178d357c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ff91944b7224f55d8835b458982a68eb1389173d1a1eb34fa325613059fbdcc013f772948dcf09f52ea3547cce26ff88473c925356b6be6b43a2d51f0822409", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/562bac5dbcef76091a979a634f7887990bf0f0c279a7b4ae1077528aa12f3947572091f42383d6acca317c909dd064039c96dcb575e1f5f96cfa2885d8cdae49"} 11:30:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:30:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:30:00 INFO - Contents: 11:30:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7ad6c57325db2797ed0e464bed9433d7048666b55ba15bf08688ba1682177d983c058bebeca03c20dde6f93d15f8e749ad36e0deac06b34c53d99c178d357c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ff91944b7224f55d8835b458982a68eb1389173d1a1eb34fa325613059fbdcc013f772948dcf09f52ea3547cce26ff88473c925356b6be6b43a2d51f0822409", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/562bac5dbcef76091a979a634f7887990bf0f0c279a7b4ae1077528aa12f3947572091f42383d6acca317c909dd064039c96dcb575e1f5f96cfa2885d8cdae49"} 11:30:00 INFO - Running post-run listener: copy_logs_to_upload_dir 11:30:00 INFO - Copying logs to upload dir... 11:30:00 INFO - mkdir: /builds/slave/test/build/upload/logs 11:30:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.601474 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-18 11:30:00.089881) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 11:30:00.092929) ========= 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=14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7ad6c57325db2797ed0e464bed9433d7048666b55ba15bf08688ba1682177d983c058bebeca03c20dde6f93d15f8e749ad36e0deac06b34c53d99c178d357c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ff91944b7224f55d8835b458982a68eb1389173d1a1eb34fa325613059fbdcc013f772948dcf09f52ea3547cce26ff88473c925356b6be6b43a2d51f0822409", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/562bac5dbcef76091a979a634f7887990bf0f0c279a7b4ae1077528aa12f3947572091f42383d6acca317c909dd064039c96dcb575e1f5f96cfa2885d8cdae49"} build_url:https://queue.taskcluster.net/v1/task/PFhGv1rwSceQJBEno8a97A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/PFhGv1rwSceQJBEno8a97A/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/sha512/c7ad6c57325db2797ed0e464bed9433d7048666b55ba15bf08688ba1682177d983c058bebeca03c20dde6f93d15f8e749ad36e0deac06b34c53d99c178d357c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ff91944b7224f55d8835b458982a68eb1389173d1a1eb34fa325613059fbdcc013f772948dcf09f52ea3547cce26ff88473c925356b6be6b43a2d51f0822409", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/562bac5dbcef76091a979a634f7887990bf0f0c279a7b4ae1077528aa12f3947572091f42383d6acca317c909dd064039c96dcb575e1f5f96cfa2885d8cdae49"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 11:30:00.117458) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 11:30:00.117814) ========= 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=14ef55db36f7623abb31b9cf000001d5-1463594942.46458-1484941861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 11:30:00.201299) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 11:30:00.204709) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 11:30:00.205026) ========= ========= Total master_lag: 0.18 =========