builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-047 starttime: 1460076847.67 results: success (0) buildid: 20160407170648 builduid: 92a1e42c42a649d689eb15422eddfbe0 revision: bb1926280d496c73c43f89db6b7b5f8f9165504c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:07.665735) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:07.666470) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:07.666851) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006356 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:07.740772) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:07.741100) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:07.786547) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:07.786850) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:07.852327) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:07.852601) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:07.852932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:07.853226) ========= 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=03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-07 17:54:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 97.2M=0s 2016-04-07 17:54:08 (97.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161149 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:08.037308) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:08.037595) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016149 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:08.092047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 17:54:08.092412) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bb1926280d496c73c43f89db6b7b5f8f9165504c --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 bb1926280d496c73c43f89db6b7b5f8f9165504c --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=03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-07 17:54:08,244 truncating revision to first 12 chars 2016-04-07 17:54:08,244 Setting DEBUG logging. 2016-04-07 17:54:08,244 attempt 1/10 2016-04-07 17:54:08,244 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bb1926280d49?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 17:54:08,994 unpacking tar archive at: fx-team-bb1926280d49/testing/mozharness/ program finished with exit code 0 elapsedTime=1.019301 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 17:54:09.130282) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:09.130584) ========= echo bb1926280d496c73c43f89db6b7b5f8f9165504c in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'bb1926280d496c73c43f89db6b7b5f8f9165504c'] 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=03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False bb1926280d496c73c43f89db6b7b5f8f9165504c program finished with exit code 0 elapsedTime=0.004753 script_repo_revision: 'bb1926280d496c73c43f89db6b7b5f8f9165504c' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:09.180912) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:09.181227) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 17:54:09.195907) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-04-07 17:54:09.196643) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:54:09 INFO - MultiFileLogger online at 20160407 17:54:09 in /builds/slave/test 17:54:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:54:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:54:09 INFO - {'append_to_log': False, 17:54:09 INFO - 'base_work_dir': '/builds/slave/test', 17:54:09 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:54:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:54:09 INFO - 'branch': 'Fx-Team-Non-PGO', 17:54:09 INFO - 'buildbot_json_path': 'buildprops.json', 17:54:09 INFO - 'config_files': ('talos/linux_config.py',), 17:54:09 INFO - 'default_actions': ('clobber', 17:54:09 INFO - 'read-buildbot-config', 17:54:09 INFO - 'download-and-extract', 17:54:09 INFO - 'populate-webroot', 17:54:09 INFO - 'create-virtualenv', 17:54:09 INFO - 'install', 17:54:09 INFO - 'run-tests'), 17:54:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:54:09 INFO - 'download_minidump_stackwalk': True, 17:54:09 INFO - 'download_symbols': 'ondemand', 17:54:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:54:09 INFO - 'tooltool.py': '/tools/tooltool.py', 17:54:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:54:09 INFO - '/tools/misc-python/virtualenv.py')}, 17:54:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:54:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:54:09 INFO - 'installer_path': 'installer.exe', 17:54:09 INFO - 'log_level': 'info', 17:54:09 INFO - 'log_name': 'talos', 17:54:09 INFO - 'log_to_console': True, 17:54:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:54:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:54:09 INFO - 'opt_config_files': (), 17:54:09 INFO - 'pip_index': False, 17:54:09 INFO - 'sps_profile': False, 17:54:09 INFO - 'sps_profile_interval': 0, 17:54:09 INFO - 'suite': 'dromaeojs-e10s', 17:54:09 INFO - 'system_bits': '32', 17:54:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:54:09 INFO - 'title': 'talos-linux64-ix-047', 17:54:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:54:09 INFO - 'use_talos_json': True, 17:54:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:54:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:54:09 INFO - 'work_dir': 'build'} 17:54:09 INFO - ##### 17:54:09 INFO - ##### Running clobber step. 17:54:09 INFO - ##### 17:54:09 INFO - Running pre-action listener: _resource_record_pre_action 17:54:09 INFO - Running main action method: clobber 17:54:09 INFO - rmtree: /builds/slave/test/build 17:54:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:54:10 INFO - Running post-action listener: _resource_record_post_action 17:54:10 INFO - ##### 17:54:10 INFO - ##### Running read-buildbot-config step. 17:54:10 INFO - ##### 17:54:10 INFO - Running pre-action listener: _resource_record_pre_action 17:54:10 INFO - Running main action method: read_buildbot_config 17:54:10 INFO - Using buildbot properties: 17:54:10 INFO - { 17:54:10 INFO - "project": "", 17:54:10 INFO - "product": "firefox", 17:54:10 INFO - "script_repo_revision": "production", 17:54:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:54:10 INFO - "repository": "", 17:54:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 17:54:10 INFO - "buildid": "20160407170648", 17:54:10 INFO - "pgo_build": "False", 17:54:10 INFO - "basedir": "/builds/slave/test", 17:54:10 INFO - "buildnumber": 1111, 17:54:10 INFO - "slavename": "talos-linux64-ix-047", 17:54:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:54:10 INFO - "platform": "ubuntu64_hw", 17:54:10 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:54:10 INFO - "branch": "fx-team", 17:54:10 INFO - "repo_path": "integration/fx-team", 17:54:10 INFO - "revision": "bb1926280d496c73c43f89db6b7b5f8f9165504c", 17:54:10 INFO - "stage_platform": "linux64", 17:54:10 INFO - "builduid": "92a1e42c42a649d689eb15422eddfbe0", 17:54:10 INFO - "slavebuilddir": "test" 17:54:10 INFO - } 17:54:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:54:10 INFO - Running post-action listener: _resource_record_post_action 17:54:10 INFO - ##### 17:54:10 INFO - ##### Running download-and-extract step. 17:54:10 INFO - ##### 17:54:10 INFO - Running pre-action listener: _resource_record_pre_action 17:54:10 INFO - Running main action method: download_and_extract 17:54:10 INFO - mkdir: /builds/slave/test/build/tests 17:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:54:10 INFO - https://queue.taskcluster.net/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:54:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:54:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:54:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:54:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:54:22 INFO - Downloaded 1361 bytes. 17:54:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:54:22 INFO - Using the following test package requirements: 17:54:22 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:54:22 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:54:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:54:22 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:54:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:54:22 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:54:22 INFO - u'jsshell-linux-x86_64.zip'], 17:54:22 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:54:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:54:22 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:54:22 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:54:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:54:22 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:54:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:54:22 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:54:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:54:22 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:54:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:54:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:54:22 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')]} 17:54:22 INFO - https://queue.taskcluster.net/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:54:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:54:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:54:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:54:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:54:35 INFO - Downloaded 22186272 bytes. 17:54:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:54:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:54:36 INFO - Return code: 0 17:54:36 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:54:36 INFO - https://queue.taskcluster.net/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:54:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:54:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:54:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:54:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:54:39 INFO - Downloaded 22186272 bytes. 17:54:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:54:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:54:40 INFO - Return code: 0 17:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:54:40 INFO - https://queue.taskcluster.net/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:54:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:54:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:54:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:54:43 INFO - Downloaded 10847693 bytes. 17:54:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:54:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:54:43 INFO - Return code: 0 17:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:54:43 INFO - https://queue.taskcluster.net/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:54:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:54:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:54:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:54:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:54:46 INFO - Downloaded 54040193 bytes. 17:54:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:54:46 INFO - mkdir: /builds/slave/test/properties 17:54:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:54:46 INFO - Writing to file /builds/slave/test/properties/build_url 17:54:46 INFO - Contents: 17:54:46 INFO - build_url:https://queue.taskcluster.net/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:54:47 INFO - Running post-action listener: _resource_record_post_action 17:54:47 INFO - Running post-action listener: set_extra_try_arguments 17:54:47 INFO - ##### 17:54:47 INFO - ##### Running populate-webroot step. 17:54:47 INFO - ##### 17:54:47 INFO - Running pre-action listener: _resource_record_pre_action 17:54:47 INFO - Running main action method: populate_webroot 17:54:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:54:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:54:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:54:47 INFO - '--tppagecycles', 17:54:47 INFO - '7'], 17:54:47 INFO - 'tests': ['tsvgm']}}, 17:54:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:54:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:54:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:54:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:54:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:54:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:54:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:47 INFO - 'talos_options': ['--disable-e10s'], 17:54:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:54:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:54:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:47 INFO - 'talos_options': ['--disable-e10s'], 17:54:47 INFO - 'tests': ['damp', 'tps']}, 17:54:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:47 INFO - 'tests': ['damp', 'tps']}, 17:54:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:54:47 INFO - 'tests': ['dromaeo_dom']}, 17:54:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:54:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:54:47 INFO - 'tests': ['a11yr', 17:54:47 INFO - 'ts_paint', 17:54:47 INFO - 'tpaint', 17:54:47 INFO - 'sessionrestore', 17:54:47 INFO - 'sessionrestore_no_auto_restore', 17:54:47 INFO - 'tabpaint']}, 17:54:47 INFO - 'other-e10s': {'tests': ['a11yr', 17:54:47 INFO - 'ts_paint', 17:54:47 INFO - 'tpaint', 17:54:47 INFO - 'sessionrestore', 17:54:47 INFO - 'sessionrestore_no_auto_restore', 17:54:47 INFO - 'tabpaint']}, 17:54:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:54:47 INFO - 'ts_paint', 17:54:47 INFO - 'tpaint', 17:54:47 INFO - 'sessionrestore', 17:54:47 INFO - 'sessionrestore_no_auto_restore', 17:54:47 INFO - 'tabpaint']}, 17:54:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:54:47 INFO - 'ts_paint', 17:54:47 INFO - 'tpaint', 17:54:47 INFO - 'sessionrestore', 17:54:47 INFO - 'sessionrestore_no_auto_restore', 17:54:47 INFO - 'tabpaint']}, 17:54:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:54:47 INFO - 'tests': ['a11yr', 17:54:47 INFO - 'ts_paint', 17:54:47 INFO - 'tpaint', 17:54:47 INFO - 'sessionrestore', 17:54:47 INFO - 'sessionrestore_no_auto_restore', 17:54:47 INFO - 'tabpaint']}, 17:54:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:54:47 INFO - 'tests': ['a11yr', 17:54:47 INFO - 'ts_paint', 17:54:47 INFO - 'tpaint', 17:54:47 INFO - 'sessionrestore', 17:54:47 INFO - 'sessionrestore_no_auto_restore', 17:54:47 INFO - 'tabpaint']}, 17:54:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:54:47 INFO - 'tests': ['tsvgx', 17:54:47 INFO - 'tsvgr_opacity', 17:54:47 INFO - 'tart', 17:54:47 INFO - 'tscrollx', 17:54:47 INFO - 'cart']}, 17:54:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:54:47 INFO - 'tsvgr_opacity', 17:54:47 INFO - 'tart', 17:54:47 INFO - 'tscrollx', 17:54:47 INFO - 'cart']}, 17:54:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:47 INFO - 'talos_options': ['--disable-e10s'], 17:54:47 INFO - 'tests': ['tp5o']}, 17:54:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:47 INFO - 'tests': ['tp5o']}, 17:54:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:47 INFO - 'talos_options': ['--disable-e10s', 17:54:47 INFO - '--xperf_path', 17:54:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:54:47 INFO - 'tests': ['tp5n']}, 17:54:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:47 INFO - 'talos_options': ['--xperf_path', 17:54:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:54:47 INFO - 'tests': ['tp5n']}}, 17:54:47 INFO - 'talos.zip': {'path': '', 17:54:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:54:47 INFO - Running post-action listener: _resource_record_post_action 17:54:47 INFO - ##### 17:54:47 INFO - ##### Running create-virtualenv step. 17:54:47 INFO - ##### 17:54:47 INFO - Running pre-action listener: _resource_record_pre_action 17:54:47 INFO - Running main action method: create_virtualenv 17:54:47 INFO - Creating virtualenv /builds/slave/test/build/venv 17:54:47 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 17:54:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:54:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:54:47 INFO - Using real prefix '/usr' 17:54:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:54:48 INFO - Installing distribute.............................................................................................................................................................................................done. 17:54:50 INFO - Installing pip.................done. 17:54:50 INFO - Return code: 0 17:54:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:54: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')]} 17:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54: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')]} 17:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:50 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 0x7f6cd1b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc4410>, '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 0xdc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc57a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', '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 17:54:50 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 17:54:50 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 17:54:50 INFO - Using env: {'DISPLAY': ':0', 17:54:50 INFO - 'HOME': '/home/cltbld', 17:54:50 INFO - 'LANG': 'en_US.UTF-8', 17:54:50 INFO - 'LANGUAGE': 'en_US:en', 17:54:50 INFO - 'LOGNAME': 'cltbld', 17:54:50 INFO - 'MAIL': '/var/mail/cltbld', 17:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:50 INFO - 'MOZ_NO_REMOTE': '1', 17:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:50 INFO - 'NO_EM_RESTART': '1', 17:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:50 INFO - 'PWD': '/builds/slave/test', 17:54:50 INFO - 'SHELL': '/bin/bash', 17:54:50 INFO - 'SHLVL': '1', 17:54:50 INFO - 'TERM': 'linux', 17:54:50 INFO - 'TMOUT': '86400', 17:54:50 INFO - 'USER': 'cltbld', 17:54:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', 17:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:50 INFO - '_': '/tools/buildbot/bin/python'} 17:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:50 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 17:54:50 INFO - Cleaning up... 17:54:50 INFO - Return code: 0 17:54:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:54: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')]} 17:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54: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')]} 17:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cd1b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc4410>, '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 0xdc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc57a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', '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 17:54:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:54:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:54:50 INFO - Using env: {'DISPLAY': ':0', 17:54:50 INFO - 'HOME': '/home/cltbld', 17:54:50 INFO - 'LANG': 'en_US.UTF-8', 17:54:50 INFO - 'LANGUAGE': 'en_US:en', 17:54:50 INFO - 'LOGNAME': 'cltbld', 17:54:50 INFO - 'MAIL': '/var/mail/cltbld', 17:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:50 INFO - 'MOZ_NO_REMOTE': '1', 17:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:50 INFO - 'NO_EM_RESTART': '1', 17:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:50 INFO - 'PWD': '/builds/slave/test', 17:54:50 INFO - 'SHELL': '/bin/bash', 17:54:50 INFO - 'SHLVL': '1', 17:54:50 INFO - 'TERM': 'linux', 17:54:50 INFO - 'TMOUT': '86400', 17:54:50 INFO - 'USER': 'cltbld', 17:54:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', 17:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:50 INFO - '_': '/tools/buildbot/bin/python'} 17:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:50 INFO - Downloading/unpacking psutil>=0.7.1 17:54:50 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 17:54:50 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 17:54:50 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 17:54:50 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 17:54:50 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 17:54:50 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 17:54:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:54:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:54:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:54:52 INFO - Installing collected packages: psutil 17:54:52 INFO - Running setup.py install for psutil 17:54:52 INFO - building 'psutil._psutil_linux' extension 17:54:52 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 17:54:52 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 17:54:52 INFO - building 'psutil._psutil_posix' extension 17:54:52 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 17:54:52 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 17:54:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:54:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:54:52 INFO - Successfully installed psutil 17:54:52 INFO - Cleaning up... 17:54:53 INFO - Return code: 0 17:54:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:54:53 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')]} 17:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:53 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')]} 17:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cd1b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc4410>, '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 0xdc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc57a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', '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 17:54:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:54:53 INFO - Using env: {'DISPLAY': ':0', 17:54:53 INFO - 'HOME': '/home/cltbld', 17:54:53 INFO - 'LANG': 'en_US.UTF-8', 17:54:53 INFO - 'LANGUAGE': 'en_US:en', 17:54:53 INFO - 'LOGNAME': 'cltbld', 17:54:53 INFO - 'MAIL': '/var/mail/cltbld', 17:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:53 INFO - 'MOZ_NO_REMOTE': '1', 17:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:53 INFO - 'NO_EM_RESTART': '1', 17:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:53 INFO - 'PWD': '/builds/slave/test', 17:54:53 INFO - 'SHELL': '/bin/bash', 17:54:53 INFO - 'SHLVL': '1', 17:54:53 INFO - 'TERM': 'linux', 17:54:53 INFO - 'TMOUT': '86400', 17:54:53 INFO - 'USER': 'cltbld', 17:54:53 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', 17:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:53 INFO - '_': '/tools/buildbot/bin/python'} 17:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:54:53 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 17:54:53 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 17:54:53 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 17:54:53 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 17:54:53 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 17:54:53 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 17:54:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:54:55 INFO - Installing collected packages: mozsystemmonitor 17:54:55 INFO - Running setup.py install for mozsystemmonitor 17:54:55 INFO - Successfully installed mozsystemmonitor 17:54:55 INFO - Cleaning up... 17:54:55 INFO - Return code: 0 17:54:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:54:55 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')]} 17:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:55 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')]} 17:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:55 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 0x7f6cd1b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc4410>, '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 0xdc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc57a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', '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 17:54:55 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 17:54:55 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 17:54:55 INFO - Using env: {'DISPLAY': ':0', 17:54:55 INFO - 'HOME': '/home/cltbld', 17:54:55 INFO - 'LANG': 'en_US.UTF-8', 17:54:55 INFO - 'LANGUAGE': 'en_US:en', 17:54:55 INFO - 'LOGNAME': 'cltbld', 17:54:55 INFO - 'MAIL': '/var/mail/cltbld', 17:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:55 INFO - 'MOZ_NO_REMOTE': '1', 17:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:55 INFO - 'NO_EM_RESTART': '1', 17:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:55 INFO - 'PWD': '/builds/slave/test', 17:54:55 INFO - 'SHELL': '/bin/bash', 17:54:55 INFO - 'SHLVL': '1', 17:54:55 INFO - 'TERM': 'linux', 17:54:55 INFO - 'TMOUT': '86400', 17:54:55 INFO - 'USER': 'cltbld', 17:54:55 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', 17:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:55 INFO - '_': '/tools/buildbot/bin/python'} 17:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:55 INFO - Downloading/unpacking blobuploader==1.2.4 17:54: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 17:54: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 17:54: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 17:54: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 17:54: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 17:54: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 17:54:57 INFO - Downloading blobuploader-1.2.4.tar.gz 17:54:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:54:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:54: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 17:54: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 17:54: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 17:54: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 17:54: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 17:54: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 17:54:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:54:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:54: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 17:54: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 17:54: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 17:54: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 17:54: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 17:54: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 17:54:58 INFO - Downloading docopt-0.6.1.tar.gz 17:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:54:58 INFO - Installing collected packages: blobuploader, requests, docopt 17:54:58 INFO - Running setup.py install for blobuploader 17:54:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:54:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:54:58 INFO - Running setup.py install for requests 17:54:58 INFO - Running setup.py install for docopt 17:54:58 INFO - Successfully installed blobuploader requests docopt 17:54:58 INFO - Cleaning up... 17:54:58 INFO - Return code: 0 17:54:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:58 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 0x7f6cd1b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc4410>, '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 0xdc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc57a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', '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 17:54:58 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 17:54:58 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 17:54:58 INFO - Using env: {'DISPLAY': ':0', 17:54:58 INFO - 'HOME': '/home/cltbld', 17:54:58 INFO - 'LANG': 'en_US.UTF-8', 17:54:58 INFO - 'LANGUAGE': 'en_US:en', 17:54:58 INFO - 'LOGNAME': 'cltbld', 17:54:58 INFO - 'MAIL': '/var/mail/cltbld', 17:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:58 INFO - 'MOZ_NO_REMOTE': '1', 17:54:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:58 INFO - 'NO_EM_RESTART': '1', 17:54:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:58 INFO - 'PWD': '/builds/slave/test', 17:54:58 INFO - 'SHELL': '/bin/bash', 17:54:58 INFO - 'SHLVL': '1', 17:54:58 INFO - 'TERM': 'linux', 17:54:58 INFO - 'TMOUT': '86400', 17:54:58 INFO - 'USER': 'cltbld', 17:54:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', 17:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:58 INFO - '_': '/tools/buildbot/bin/python'} 17:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:54:59 INFO - Running setup.py (path:/tmp/pip-EveT5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:54:59 INFO - Running setup.py (path:/tmp/pip-m1QxRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:54:59 INFO - Running setup.py (path:/tmp/pip-CdYeZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:54:59 INFO - Running setup.py (path:/tmp/pip-ZINOVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:54:59 INFO - Running setup.py (path:/tmp/pip-bR49zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:54:59 INFO - Running setup.py (path:/tmp/pip-0ZlzlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:54:59 INFO - Running setup.py (path:/tmp/pip-loFkvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:54:59 INFO - Running setup.py (path:/tmp/pip-8hrkHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:54:59 INFO - Running setup.py (path:/tmp/pip-ulABe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:54:59 INFO - Running setup.py (path:/tmp/pip-H8mPkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:54:59 INFO - Running setup.py (path:/tmp/pip-gN3Tin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:54:59 INFO - Running setup.py (path:/tmp/pip-WcE6Iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:54:59 INFO - Running setup.py (path:/tmp/pip-FJumJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:54:59 INFO - Running setup.py (path:/tmp/pip-P6UjNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:00 INFO - Running setup.py (path:/tmp/pip-rdhYO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:55:00 INFO - Running setup.py (path:/tmp/pip-96PUoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:55:00 INFO - Running setup.py (path:/tmp/pip-3lDRwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:55:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:55:00 INFO - Running setup.py install for manifestparser 17:55:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:55:00 INFO - Running setup.py install for mozcrash 17:55:00 INFO - Running setup.py install for mozdebug 17:55:00 INFO - Running setup.py install for mozdevice 17:55:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:55:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:55:00 INFO - Running setup.py install for mozfile 17:55:00 INFO - Running setup.py install for mozhttpd 17:55:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:55:00 INFO - Running setup.py install for mozinfo 17:55:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:55:00 INFO - Running setup.py install for mozInstall 17:55:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:55:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:55:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:55:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:55:01 INFO - Running setup.py install for mozleak 17:55:01 INFO - Running setup.py install for mozlog 17:55:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:55:01 INFO - Running setup.py install for moznetwork 17:55:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:55:01 INFO - Running setup.py install for mozprocess 17:55:01 INFO - Running setup.py install for mozprofile 17:55:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:55:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:55:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:55:01 INFO - Running setup.py install for mozrunner 17:55:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:55:01 INFO - Running setup.py install for mozscreenshot 17:55:01 INFO - Running setup.py install for moztest 17:55:01 INFO - Running setup.py install for mozversion 17:55:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:55:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:55:02 INFO - Cleaning up... 17:55:02 INFO - Return code: 0 17:55:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:55:02 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')]} 17:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:02 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')]} 17:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:02 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 0x7f6cd1b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc4410>, '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 0xdc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc57a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', '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 17:55:02 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 17:55:02 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 17:55:02 INFO - Using env: {'DISPLAY': ':0', 17:55:02 INFO - 'HOME': '/home/cltbld', 17:55:02 INFO - 'LANG': 'en_US.UTF-8', 17:55:02 INFO - 'LANGUAGE': 'en_US:en', 17:55:02 INFO - 'LOGNAME': 'cltbld', 17:55:02 INFO - 'MAIL': '/var/mail/cltbld', 17:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:02 INFO - 'MOZ_NO_REMOTE': '1', 17:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:02 INFO - 'NO_EM_RESTART': '1', 17:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:02 INFO - 'PWD': '/builds/slave/test', 17:55:02 INFO - 'SHELL': '/bin/bash', 17:55:02 INFO - 'SHLVL': '1', 17:55:02 INFO - 'TERM': 'linux', 17:55:02 INFO - 'TMOUT': '86400', 17:55:02 INFO - 'USER': 'cltbld', 17:55:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', 17:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:02 INFO - '_': '/tools/buildbot/bin/python'} 17:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:55:02 INFO - Running setup.py (path:/tmp/pip-fdZh3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:55:02 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)) 17:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:55:02 INFO - Running setup.py (path:/tmp/pip-vSX3Zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:55:02 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)) 17:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:55:02 INFO - Running setup.py (path:/tmp/pip-ighmfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:55:02 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)) 17:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:55:02 INFO - Running setup.py (path:/tmp/pip-GnP_FD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:55:02 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)) 17:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:55:02 INFO - Running setup.py (path:/tmp/pip-4TmKwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:55:02 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)) 17:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:55:02 INFO - Running setup.py (path:/tmp/pip-tDW4Jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:55:02 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)) 17:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:55:02 INFO - Running setup.py (path:/tmp/pip-IJdoNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:55:02 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)) 17:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:55:02 INFO - Running setup.py (path:/tmp/pip-e2Lx8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:55:02 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)) 17:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:55:02 INFO - Running setup.py (path:/tmp/pip-sy80km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:55:02 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)) 17:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:55:02 INFO - Running setup.py (path:/tmp/pip-5tWSYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:55:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:55:03 INFO - Running setup.py (path:/tmp/pip-WbPOyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:55:03 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)) 17:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:55:03 INFO - Running setup.py (path:/tmp/pip-jfHcCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:55:03 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)) 17:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:55:03 INFO - Running setup.py (path:/tmp/pip-q18KnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:55:03 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)) 17:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:55:03 INFO - Running setup.py (path:/tmp/pip-sYdfqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:55:03 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)) 17:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:03 INFO - Running setup.py (path:/tmp/pip-1BnpRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:03 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)) 17:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:55:03 INFO - Running setup.py (path:/tmp/pip-btaurs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:55:03 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)) 17:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:55:03 INFO - Running setup.py (path:/tmp/pip-2Kt993-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:55:03 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)) 17:55:03 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)) 17:55:03 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)) 17:55:03 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)) 17:55:03 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)) 17:55:03 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)) 17:55:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:55:03 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 17:55:03 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 17:55:03 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 17:55:03 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 17:55:03 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 17:55:03 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 17:55:05 INFO - Downloading blessings-1.6.tar.gz 17:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:55:05 INFO - Installing collected packages: blessings 17:55:05 INFO - Running setup.py install for blessings 17:55:05 INFO - Successfully installed blessings 17:55:05 INFO - Cleaning up... 17:55:05 INFO - Return code: 0 17:55:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:55:06 INFO - Reading from file tmpfile_stdout 17:55:06 INFO - Current package versions: 17:55:06 INFO - argparse == 1.2.1 17:55:06 INFO - blessings == 1.6 17:55:06 INFO - blobuploader == 1.2.4 17:55:06 INFO - docopt == 0.6.1 17:55:06 INFO - manifestparser == 1.1 17:55:06 INFO - mozInstall == 1.12 17:55:06 INFO - mozcrash == 0.17 17:55:06 INFO - mozdebug == 0.1 17:55:06 INFO - mozdevice == 0.48 17:55:06 INFO - mozfile == 1.2 17:55:06 INFO - mozhttpd == 0.7 17:55:06 INFO - mozinfo == 0.9 17:55:06 INFO - mozleak == 0.1 17:55:06 INFO - mozlog == 3.1 17:55:06 INFO - moznetwork == 0.27 17:55:06 INFO - mozprocess == 0.22 17:55:06 INFO - mozprofile == 0.28 17:55:06 INFO - mozrunner == 6.11 17:55:06 INFO - mozscreenshot == 0.1 17:55:06 INFO - mozsystemmonitor == 0.0 17:55:06 INFO - moztest == 0.7 17:55:06 INFO - mozversion == 1.4 17:55:06 INFO - psutil == 3.1.1 17:55:06 INFO - requests == 1.2.3 17:55:06 INFO - wsgiref == 0.1.2 17:55:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cd1b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc4410>, '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 0xdc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc57a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', '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 17:55:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:55:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:55:06 INFO - Using env: {'DISPLAY': ':0', 17:55:06 INFO - 'HOME': '/home/cltbld', 17:55:06 INFO - 'LANG': 'en_US.UTF-8', 17:55:06 INFO - 'LANGUAGE': 'en_US:en', 17:55:06 INFO - 'LOGNAME': 'cltbld', 17:55:06 INFO - 'MAIL': '/var/mail/cltbld', 17:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:06 INFO - 'MOZ_NO_REMOTE': '1', 17:55:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:06 INFO - 'NO_EM_RESTART': '1', 17:55:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:06 INFO - 'PWD': '/builds/slave/test', 17:55:06 INFO - 'SHELL': '/bin/bash', 17:55:06 INFO - 'SHLVL': '1', 17:55:06 INFO - 'TERM': 'linux', 17:55:06 INFO - 'TMOUT': '86400', 17:55:06 INFO - 'USER': 'cltbld', 17:55:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', 17:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:06 INFO - '_': '/tools/buildbot/bin/python'} 17:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:06 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)) 17:55:06 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)) 17:55:06 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)) 17:55:06 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)) 17:55:06 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)) 17:55:06 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)) 17:55:06 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)) 17:55:06 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)) 17:55:06 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)) 17:55:06 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)) 17:55:06 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)) 17:55:06 INFO - Cleaning up... 17:55:06 INFO - Return code: 0 17:55:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:06 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 0x7f6cd1b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc4410>, '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 0xdc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc57a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', '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 17:55:06 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 17:55:06 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 17:55:06 INFO - Using env: {'DISPLAY': ':0', 17:55:06 INFO - 'HOME': '/home/cltbld', 17:55:06 INFO - 'LANG': 'en_US.UTF-8', 17:55:06 INFO - 'LANGUAGE': 'en_US:en', 17:55:06 INFO - 'LOGNAME': 'cltbld', 17:55:06 INFO - 'MAIL': '/var/mail/cltbld', 17:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:06 INFO - 'MOZ_NO_REMOTE': '1', 17:55:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:06 INFO - 'NO_EM_RESTART': '1', 17:55:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:06 INFO - 'PWD': '/builds/slave/test', 17:55:06 INFO - 'SHELL': '/bin/bash', 17:55:06 INFO - 'SHLVL': '1', 17:55:06 INFO - 'TERM': 'linux', 17:55:06 INFO - 'TMOUT': '86400', 17:55:06 INFO - 'USER': 'cltbld', 17:55:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', 17:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:06 INFO - '_': '/tools/buildbot/bin/python'} 17:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:06 INFO - Downloading/unpacking jsonschema 17:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:55:08 INFO - Downloading/unpacking functools32 (from jsonschema) 17:55:08 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 17:55:08 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 17:55:08 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 17:55:08 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 17:55:08 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 17:55:08 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 17:55:08 INFO - Downloading functools32-3.2.3-2.tar.gz 17:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:55:08 INFO - warning: no files found matching '*.txt' 17:55:08 INFO - no previously-included directories found matching 'build' 17:55:08 INFO - no previously-included directories found matching 'dist' 17:55:08 INFO - no previously-included directories found matching '.git*' 17:55:08 INFO - Installing collected packages: jsonschema, functools32 17:55:08 INFO - Running setup.py install for functools32 17:55:08 INFO - warning: no files found matching '*.txt' 17:55:08 INFO - no previously-included directories found matching 'build' 17:55:08 INFO - no previously-included directories found matching 'dist' 17:55:08 INFO - no previously-included directories found matching '.git*' 17:55:08 INFO - Successfully installed jsonschema functools32 17:55:08 INFO - Cleaning up... 17:55:08 INFO - Return code: 0 17:55:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:08 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 0x7f6cd1b88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc4410>, '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 0xdc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc57a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', '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 17:55:08 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 17:55:08 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 17:55:08 INFO - Using env: {'DISPLAY': ':0', 17:55:08 INFO - 'HOME': '/home/cltbld', 17:55:08 INFO - 'LANG': 'en_US.UTF-8', 17:55:08 INFO - 'LANGUAGE': 'en_US:en', 17:55:08 INFO - 'LOGNAME': 'cltbld', 17:55:08 INFO - 'MAIL': '/var/mail/cltbld', 17:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:08 INFO - 'MOZ_NO_REMOTE': '1', 17:55:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:08 INFO - 'NO_EM_RESTART': '1', 17:55:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:08 INFO - 'PWD': '/builds/slave/test', 17:55:08 INFO - 'SHELL': '/bin/bash', 17:55:08 INFO - 'SHLVL': '1', 17:55:08 INFO - 'TERM': 'linux', 17:55:08 INFO - 'TMOUT': '86400', 17:55:08 INFO - 'USER': 'cltbld', 17:55:08 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', 17:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:08 INFO - '_': '/tools/buildbot/bin/python'} 17:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:09 INFO - Downloading/unpacking flake8 17:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:55:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:55:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:55:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:55:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:55:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:55:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:55:11 INFO - no previously-included directories found matching 'docs/_build' 17:55:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:55:11 INFO - Running setup.py install for pep8 17:55:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:55:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:55:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:55:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:55:11 INFO - no previously-included directories found matching 'docs/_build' 17:55:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:55:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:55:11 INFO - Cleaning up... 17:55:11 INFO - Return code: 0 17:55:11 INFO - Running post-action listener: _resource_record_post_action 17:55:11 INFO - Running post-action listener: _start_resource_monitoring 17:55:11 INFO - Starting resource monitoring. 17:55:11 INFO - ##### 17:55:11 INFO - ##### Running install step. 17:55:11 INFO - ##### 17:55:11 INFO - Running pre-action listener: _resource_record_pre_action 17:55:11 INFO - Running main action method: install 17:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:55:12 INFO - Reading from file tmpfile_stdout 17:55:12 INFO - Detecting whether we're running mozinstall >=1.0... 17:55:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:55:12 INFO - Reading from file tmpfile_stdout 17:55:12 INFO - Output received: 17:55:12 INFO - Usage: mozinstall [options] installer 17:55:12 INFO - Options: 17:55:12 INFO - -h, --help show this help message and exit 17:55:12 INFO - -d DEST, --destination=DEST 17:55:12 INFO - Directory to install application into. [default: 17:55:12 INFO - "/builds/slave/test"] 17:55:12 INFO - --app=APP Application being installed. [default: firefox] 17:55:12 INFO - mkdir: /builds/slave/test/build/application 17:55:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:55:27 INFO - Reading from file tmpfile_stdout 17:55:27 INFO - Output received: 17:55:27 INFO - /builds/slave/test/build/application/firefox/firefox 17:55:27 INFO - Running post-action listener: _resource_record_post_action 17:55:27 INFO - ##### 17:55:27 INFO - ##### Running run-tests step. 17:55:27 INFO - ##### 17:55:27 INFO - Running pre-action listener: _resource_record_pre_action 17:55:27 INFO - Running main action method: run_tests 17:55:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:55:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:55:27 INFO - Python 2.7.3 17:55:27 INFO - Return code: 0 17:55:27 INFO - grabbing minidump binary from tooltool 17:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc4410>, '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 0xdc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc57a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:55:27 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 17:55:27 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 17:55:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:55:27 INFO - Return code: 0 17:55:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:55:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:55:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:55:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:55:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:55:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:55:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:55:28 INFO - Return code: 0 17:55:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:55:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:55:28 INFO - Using env: {'DISPLAY': ':0', 17:55:28 INFO - 'HOME': '/home/cltbld', 17:55:28 INFO - 'LANG': 'en_US.UTF-8', 17:55:28 INFO - 'LANGUAGE': 'en_US:en', 17:55:28 INFO - 'LOGNAME': 'cltbld', 17:55:28 INFO - 'MAIL': '/var/mail/cltbld', 17:55:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:55:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:28 INFO - 'MOZ_NO_REMOTE': '1', 17:55:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:55:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:28 INFO - 'NO_EM_RESTART': '1', 17:55:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:28 INFO - 'PWD': '/builds/slave/test', 17:55:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:55:28 INFO - 'SHELL': '/bin/bash', 17:55:28 INFO - 'SHLVL': '1', 17:55:28 INFO - 'TERM': 'linux', 17:55:28 INFO - 'TMOUT': '86400', 17:55:28 INFO - 'USER': 'cltbld', 17:55:28 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110', 17:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:28 INFO - '_': '/tools/buildbot/bin/python'} 17:55:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:55:29 INFO - mozversion application_buildid: 20160407170648 17:55:29 INFO - mozversion application_changeset: bb1926280d496c73c43f89db6b7b5f8f9165504c 17:55:29 INFO - mozversion application_display_name: Nightly 17:55:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:55:29 INFO - mozversion application_name: Firefox 17:55:29 INFO - mozversion application_remotingname: firefox 17:55:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:55:29 INFO - mozversion application_vendor: Mozilla 17:55:29 INFO - mozversion application_version: 48.0a1 17:55:29 INFO - mozversion platform_buildid: 20160407170648 17:55:29 INFO - mozversion platform_changeset: bb1926280d496c73c43f89db6b7b5f8f9165504c 17:55:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:55:29 INFO - mozversion platform_version: 48.0a1 17:55:29 INFO - using testdate: 1460076929 17:55:29 INFO - actual date: 1460076929 17:55:29 INFO - starting webserver on 'localhost:47596' 17:55:29 INFO - SUITE-START | Running 2 tests 17:55:29 INFO - TEST-START | dromaeo_css 17:55:29 INFO - operating with platform_type : linux_ 17:55:29 INFO - Initialising browser for dromaeo_css test... 17:55:29 INFO - TEST-INFO | started process 7743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0gm5PY/profile http://localhost:47596/getInfo.html) 17:55:32 INFO - PROCESS | 7743 | 17:55:32 INFO - PROCESS | 7743 | (process:7811): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:55:33 INFO - PROCESS | 7743 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 17:55:33 INFO - PROCESS | 7743 | __metrics Screen width/height:1600/1200 17:55:33 INFO - PROCESS | 7743 | colorDepth:24 17:55:33 INFO - PROCESS | 7743 | Browser inner width/height: 1024/697 17:55:33 INFO - PROCESS | 7743 | __metrics 17:55:34 ERROR - PROCESS | 7743 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 17:55:35 INFO - TEST-INFO | 7743: exit 0 17:55:35 INFO - Browser initialized. 17:55:35 INFO - Running cycle 1/1 for dromaeo_css test... 17:55:35 INFO - TEST-INFO | started process 7862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0gm5PY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:55:37 INFO - PROCESS | 7862 | 17:55:37 INFO - PROCESS | 7862 | (process:7920): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:55:47 INFO - PROCESS | 7862 | RSS: Main: 164081664 17:55:47 INFO - PROCESS | 7862 | 17:56:36 INFO - PROCESS | 7862 | 1460076996955 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] 17:58:48 INFO - PROCESS | 7862 | Cycle 1(1): loaded http://localhost:47596/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47596/tests/dromaeo/cssquery-ext.html) 17:58:49 INFO - PROCESS | 7862 | RSS: Main: 169230336 17:58:49 INFO - PROCESS | 7862 | 18:01:51 INFO - PROCESS | 7862 | Cycle 1(1): loaded http://localhost:47596/tests/dromaeo/cssquery-ext.html (next: http://localhost:47596/tests/dromaeo/cssquery-jquery.html) 18:01:52 INFO - PROCESS | 7862 | RSS: Main: 165486592 18:01:52 INFO - PROCESS | 7862 | 18:04:54 INFO - PROCESS | 7862 | Cycle 1(1): loaded http://localhost:47596/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47596/tests/dromaeo/cssquery-mootools.html) 18:04:54 INFO - PROCESS | 7862 | RSS: Main: 166473728 18:04:54 INFO - PROCESS | 7862 | 18:07:56 INFO - PROCESS | 7862 | Cycle 1(1): loaded http://localhost:47596/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47596/tests/dromaeo/cssquery-prototype.html) 18:07:57 INFO - PROCESS | 7862 | RSS: Main: 164438016 18:07:57 INFO - PROCESS | 7862 | 18:10:59 INFO - PROCESS | 7862 | Cycle 1(1): loaded http://localhost:47596/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47596/tests/dromaeo/cssquery-yui.html) 18:11:00 INFO - PROCESS | 7862 | RSS: Main: 165634048 18:11:00 INFO - PROCESS | 7862 | 18:14:03 INFO - PROCESS | 7862 | Cycle 1(1): loaded http://localhost:47596/tests/dromaeo/cssquery-yui.html (next: http://localhost:47596/tests/dromaeo/cssquery-dojo.html) 18:14:03 INFO - PROCESS | 7862 | RSS: Main: 168022016 18:14:03 INFO - PROCESS | 7862 | 18:14:03 INFO - PROCESS | 7862 | __start_tp_report 18:14:03 INFO - PROCESS | 7862 | _x_x_mozilla_page_load 18:14:03 INFO - PROCESS | 7862 | _x_x_mozilla_page_load_details 18:14:03 INFO - PROCESS | 7862 | |i|pagename|runs| 18:14:03 INFO - PROCESS | 7862 | |0;dojo.html;2622.2002289301763;2703.270117068391;2734.2070799468156;2735.5076086304457;2750.0787236275846;4635.721856688601;4652.092841895832;4665.673402861797;4675.532446755331;4717.599004084657;4584.266517357215;4647.512011238813;4650.604698600615;4653.674242803005;4665.136949664315;4251.48982122145;4379.868603941887;4380.627646650023;4434.467863856342;4457.064016556527;4333.956660433387;4387.890302742425;4395.934060989088;4411.448568928884;4412.75729834859;3991.181807729423;4336.046069864625;4336.804843782037;4351.108022855307;4376.934345984812;4331.97834010828;4340.240457919883;4353.717008394444;4386.385905973167;4395.582419670126;4215.662746980234;4268.9786551067045;4319.43847299849;4341.913161736779;4373.497047839507;4651.930221046687;4658.906821863544;4680.485146633868;4683.812647494096;4728.858134255978;5121.539061484485;5128.538431541179;5130.4356520782685;5144.254083157921;5165.896682066375;4876.926846097312;5123.666961647518;5140.768665410065;5157.432682404932;5223.268742376071;4785.736784476887;4799.808007679723;4814.6870453420415;4841.8547443576745;4855.75721213945;5249.763760630781;5259.894802103937;5264.473552644705;5267.394249661262;5283.260343551906;4881.658283920092;4973.079980203674;5009.524095210949;5045.142325804622;5071.112555302807;5124.615653825978;5129.9230511542355;5137.717425541631;5137.974310128426;5151.25306830515;5086.23706444029;5094.261332106824;5095.082885080721;5097.796088156507;5135.974320128375;4863.051704917507;4867.829625963145;5058.317127187856;5125.154349532286;5148;4356.085222103394;4374.059577190919;4387.714798538085;4461.486929003207;4469.754163521037;3818.026403267149;3827.808609569566;3845.8461661533224;3847.480590120354;3908;4287.335463003239;4296.3125899856495;4340.131973605292;4362.563743625676;4411.492678341968;5083.974580127149;5110.591152707774;5124.897502049938;5135.409427915837;5178.896422071537;4344.761038142932;4386.780660966939;4400.383946247528;4421.557844215553;4450.443694538183;4637.489876113625;4684.4378674559275;4685.601723853442;4713.528647135259;4731.526847315241;4799.448063472675;4826.469088400203;4833.250846118787;4847.5394837490385;4881.365422495124;4950.381202349707;5048.848534543969;5074.6194035448225;5151.768170432414;5197.324347834909;4846.5638092571835;4851.248056551241;4863.708177509361;4879.707217566957;4928.531789479994;5042.008441506741;5063.1898896176435;5063.620228482952;5063.772130254074;5125.308083408692;4950.45544990058;5069.6197785167;5118.616103792156;5131.025105229995;5171.456997015259;4881.585065269492;4889.193283108248;4916.557509824133;4918.336024636771;4967.379077615298;4913.828016019422;4915.410150781929;4932.605391568738;4933.55597996182;4955;4749.833755818668;4905.8037678492465;4910.508949105061;4938.913439043405;5000.649954503296;4872.098661747588;4946.258061290835;5007.148784706682;5012.498750125104;5066.594672426123;4813.989062296817;4822.662413631152;4823.083614113307;4827.131116399082;4867.70793752376 18:14:03 INFO - PROCESS | 7862 | |1;ext.html;573.4007961680046;604.5707547641175;623.034296839898;626.1609443345917;657.7073202424923;32475.67524324759;33096.50355244673;33126.503102453426;33196;33199.170020749465;38479.80760096203;39261.80369098158;39370.40944385836;39466.60533394665;39494.802525987405;7787.260210280015;7938.841223175533;7983.920160798405;8016.438849280553;8022.19778022196;7822.100458447295;7926.28663420292;7933.563653999027;7936.484128531656;7950.6422211000645;7890;7948.403869709795;7983.800404989864;7997.040355157389;7999.440039197259;7863.37093032556;7877.251661092187;7889.408294377916;7901;7912.841743165133;7747.186545412706;7866.370690344816;7868.488548244403;7871.370290376756;7878.960605196995;35796.64203357959;35932.28135437303;36052.459213111826;36292.455613165825;36331;2534.5437821192177;3081.1372815611667;3159.4470967580583;3223.9516407253677;3279.754018448626;24844.3788905277;24994.875025624937;25430.36424089394;25431.364215894566;25463.23610291694;3265.6407795142513;3318.5354050432957;3362.4451965425674;3373.4602463605706;3373.814440205788;209055;210538;210909.9454502733;212421;213181;33457;48695.756521217874;49396;49485.01029979452;49644.50355496471;33022.17444563857;33202;33282.3343533128;33360;33412.1646958828;13345.132566383154;13614;13659.248741319323;13678;13682.110662806886;10524.894751052545;10586.364818110938;10592.15262778976;10593.84109238362;10619.20355973305;8008.119106898236;8059.959700201579;8066.878996815052;8153.103158652543;8188.918110818816;3202.838084293093;3220.710136087763;3227.919302017421;3232.531282963957;3276.5904261967253;846.8856704344958;873.5937788928179;897.2552781191596;982.931194816356;997.1125698128672;26759.464810703677;27504.58743118855;27585;27676.446471070467;28054.298642533693;976.2531663277598;994.8010397920444;1013.159077965287;1052.3265110329396;1090.5310716391868;14450.638734031734;14861.365249822511;14868.330925108396;15047.623809404853;15147.394104235707;336328;339403;339879;340852;341148;45972.54027459749;46995.06009879783;47147.52852471431;47174.764126179834;47521;1241.118805647982;1250.8936740376987;1261.8675039120944;1267.1889990406148;1270.453704906899;26266.212013639622;26957.326066848487;27137.457250855266;27214;27726.44547109087;40330.1933961325;40390.39414408845;40442;40493.19013619652;40743.7962810184;299168;302592;304149;305114;306262;24880.75119248784;25286;37746.62253377541;38660.80669596634;38849.417258741705;36008;36703.632963670025;36938.44592331171;37126.628733712314;37153.81423092867;31122.844385777928;31307.686923131387;31398.372032558764;31798.682013180496;31880.5217921736;30598.847005765718;30664.540031899985;31006.84496577593;31143.53284700686;31219.687803122586;33761.324773503904;34569;35036.47445288374;35734.64265357313;35893.64106358903;27854.3036424091;31161.957819339073;35349.64650353567;35489.645103549665;35658.46512302369;23522.529549409257;24521.87739061293;24584.385390364667;24764.628530572416;25576.488470230863 18:14:03 INFO - PROCESS | 7862 | |2;jquery.html;369.56022333423226;370.4128955605365;374.25896724485517;375.75162718300277;386.281516379534;15817.130057846829;15937.920310398446;16467.83532164678;16576.336946522155;16603.252853621587;15175.317110730017;16345.101019443926;17081.658366832657;17091.40180093697;17092.145392730345;4991.500849915015;5150.098732721777;5195.766190521435;5195.896082078356;5202.4277329493725;3698.1124530112847;5092.28707980883;5588.748506317225;5927.585069045169;5942.9108563371365;5819.709014549277;5824.650520968734;5841.620294680833;5854.473097421232;5884.823455296348;5565.777368905239;5926.940730592682;5927.9407205928255;5941.494972927307;5954.345022047572;4434.312681534368;5205.297284866532;5226.817061402832;5240.292560504321;5244.1871509915645;11301.926316999872;11431;11529.250598711056;11536;11567.305961642243;1789.6599646067205;1789.8568114550806;1946.783260462211;1956.5402130499322;2045.877247365163;8319.918410606582;8442.915570844274;8475.95762021192;8804.207621314112;8868.467891926504;1581.9841801581952;1651.9091449970247;1696.6097797506643;1705.4372057221087;1744.2151032035636;64286;65232.673836630514;65292.67353663249;65618;66671.99992000172;9344.205742511962;9476.194523465583;9664.855027174457;9721.222302215805;9838.409695418297;12887.291198984145;12987.870121298665;13073.869261307265;13095.279759613313;13144.737105257842;6690.632015239111;7035.401990830836;7069.187043490065;7153.96423017892;7193.604351760703;6661.2006559213205;6690.498212634072;6743.831404214934;6799.150106236721;6851.3491218334175;4033.5361433435532;4035.4552135461336;4075.898102547401;4094.406311084876;4105.527864295585;1675.5559776659195;1705.6929752644394;1722.6726921884801;1781.1361489677497;1800.306881850497;905.7961958559272;928.7863791328033;931.1479995803899;946.8485042393185;958.7746879483316;16046.197690115447;16540.007599544067;16772.58068548296;16847;17058.573535661708;843.3801156150224;849.1932663969254;865.8095219051798;895.4000819450983;902.6118768929292;9123.77190570241;9380.390274632127;9421.38760980534;9470.195033422098;9612.99063598326;381004;383780;385393;395645;396953;71404.2859571408;72529.27470725331;74299.62850185715;74810.25189748142;74942;970.3838062830154;975.7024107647236;976.8778902637313;997.6558087459815;1009.9849651100596;15228.543143705707;15683.607909802346;15697.686046278783;15809.920950395175;15851.445199417965;34077.318453630294;34767.82616086904;34900.9529714109;36009.81995090008;36276.63723362733;42515.57484425116;44632.10735785201;46216.30675539802;47825.521744782105;49434.25848612202;4613;4763.333133361401;6579.243387010363;6714.4292735116105;6801.2178599461695;9682.806343873224;10034.29759916828;10757.569697212024;10966.890331096905;11306.717332066435;9574.521273936414;9639.373440726331;9682.128608425275;9789.363691360039;9794.069563391466;9007.189352958265;9766.951165244413;9809.901900981184;9850.802983940424;9951.502424878872;9822.116009559173;9860.85208721884;9890.653827116017;9968.950155249177;10012.249081319076;6532.477401807939;6619.66901654925;6759.053732477359;6806.217285012287;10604.204684648836;9868.457234851865;9993.972332508185;9994.500274986367;10033.247506437192;10603.257771955889 18:14:03 INFO - PROCESS | 7862 | |3;mootools.html;1387.833459984802;1435.124574009854;1511.1990644958175;1767.8939263644174;1792.0054369824743;6807.795766127012;7601.8479630407355;7740.4968677036095;7839.49043312185;7869.173736757637;7735.497192682472;7739.767806965786;7740.148583655808;7770.1064377596595;7805.804854878616;2197.5824593327256;2221.7889300516426;2225.3657707553352;2234.3855439754116;2238.3956331790405;2152.591007708538;2195.4401627584944;2218.201447478906;2230.654248591471;2246.168917500519;2211.436083798629;2236.2173239366252;2238.3173132194675;2240.843140980132;2262.2986874069093;2173.2067795254775;2176.3688530326185;2187.125149940021;2188.485705859122;2194;2169.9240526581493;2174.282486779359;2177.8366622503218;2178.0852042142337;2181.6182168120517;7891;7942.523448593103;7943.602819859042;7945.12603613602;7951.801204969865;4473.9552604473865;4572.405587273666;4572.839950601713;4580.725156490588;4598.793054312564;2774.722527747209;2860.556613724876;2873.2385917731817;2877.5252083406212;2897.9275518112217;884.6947803007952;926.7127190570877;929.8791157149595;936.798588303518;943.0522325063336;10176.94911525445;10444.529996150191;10459.843102353394;10466.05805477503;10482.633107841266;3888.844446222176;3933.4886464759397;4019.256437559061;4031.294523458383;4085.4893138357706;8192.75421737349;8197.46716463428;8220.794480138044;8222.13667564909;8228.83542329162;4485.349624304457;4516.119356725407;4528.230200865861;4560.293154561048;4570.200214962369;3705.55533335996;4223.915521689611;4225.9788701056295;4226.598473145046;4336.891577710519;3760.5863355030924;3816.580176180618;3896.980515097406;3907.5897030811925;3910.2570511602703;1250.893674037717;1259.3262604506544;1272.0332547264145;1287.2726909296218;1288.7358091591202;1212.381685340465;1239.9814002789965;1256.434604428011;1262.6338361874953;1273.0324953035574;7153.070100886852;7377.413856020874;7381.630918454163;7397.26027397256;7480.326770590673;1058.9735256618646;1066.2855886556026;1081.2755453845941;1083.685731137977;1101.581399068349;5651.717414129277;5799.072148456226;5816.796412125555;5822.796202132905;5832.096025116114;8655.394122411497;8888.822223555622;9194;9259.907400926038;9278.953605232065;9289.396189247813;9301.860472092923;9324.95337523308;9347.252219822398;9347.813043739086;7268.527545709512;7392.96303518479;7564.962175189089;7570.697172113054;7621.314081732781;7178;7318.414526837733;7333.303336183054;7345.742898998509;7583.469157158946;8479.872801908099;8530.10433904431;8586.055533891142;8705.390622656354;8712.433691810013;8580.14198580137;8682.218600326001;9009.774755631162;9014.368994170345;9028.322875784212;6166.2600487939935;6468.708908099241;6557.9344206559235;6598.307177746267;6787.185537735503;7596.772096837104;7662.540247585162;7663.540187588539;7691;7753.1859154787935;6626;6764.797056088325;6793.320667933167;6816.2842901496615;7015.824604384727;6656.7337306509135;6668.199816022108;6726.630035348103;6824.4199243064895;6845.863082738218;7194.532355396883;7213.386862116569;7240.348368646847;7266.890996634949;7343.1555371133;6429.7749578764515;6483.967580162069;6528.67356632176;6550.541462097607;6572.671366431564;6546.41082302576;6553.311902250195;6554.180727409074;6569.540132190701;6630.535862489773 18:14:03 INFO - PROCESS | 7862 | |4;prototype.html;291.37209313928486;298.76696176981955;302.7517435702723;320.97432205423553;321.29956694406184;5215.400228973669;5290.603204759644;5298.4701529847;5311.867203319919;5353.892922141555;5209.609279304058;5222.582193424527;5222.817201397952;5225.9025604623075;5245.4754524547525;4111.588841115887;4122.113745544707;4124.525679546846;4126.690498212631;4132.359484279941;4023.135025969416;4107.322291821846;4132.442120313749;4162.583741625828;4172.16556688662;4092.6494256895153;4093.488313960755;4108.760725404647;4110.876673699794;4115.8765237042935;3871.593482684306;4085.346344584867;4091.284025295576;4121.093359460944;4126.896827579305;3471.479278108279;3575.8902247673736;3582.247727977128;3604.0809593553477;3605.152789094561;5051.545360917498;5067.0879241736475;5074.112030394666;5084.186530155194;5104.285400043997;4605.332226827091;4666.4633567139535;4709.246520556729;4717.174494463455;4721.386219791405;5451.754671039813;5482.122860342366;5558.555315574744;5559.358620103839;5573.665580065169;3849.615038496156;3864.265789499986;3877.612238776128;3888.319544079803;3899.2396482685886;5672.205891175238;5765.942340576583;5813.941860581383;5815.534757219412;5844.4739973402175;4102.343625019982;4107.116969851496;4114.341705327133;4129.29801933666;4131.5455299916985;4135.152293779768;4135.937960930589;4146.481689788777;4150.813213405404;4154.169166166779;4729.172394830891;4738.573528382462;4745;4749.762511874393;4762.714237145782;5483.643563168382;5522.641028333226;5556.416576259435;5584.413636568183;5585.664860108406;1398.1541167593664;1419.7302512522795;1436.367998080841;1438.9064710793764;1448.819212341938;971.4851128901694;987.5161171026289;991.7371896447447;993.7416271769248;1005.994005994006;4847.151748444078;4868.563773686771;4877.6341774367065;4888.560029597282;4896.681715688469;5676.914846277309;5699.800506982236;5709.51469125129;5712.371639119693;5718.25662663851;4667.393238878924;4850.393700787402;4855.247436647325;4905.779239934212;4931.728754918442;2948.3071478202605;2991.551267309921;3083.383323335342;3083.4758091124563;3092.2887735820436;5431.972840135774;5455.318085239345;5466.508014278734;5488.533474654699;5520.889582208413;5781.161731548986;5911.674857882857;5926.733297001645;5938.554608404301;5961.076033214858;5407.756650950795;5430.13117901134;5452.863678408072;5463.153211252262;5467.835964921059;5713.514351280188;5717.22817419643;5754.741036653277;5757.942420575908;5759.337676167127;5408.37803652585;5632.436756324335;5650.943490565041;5653.547716182778;5679.545636349165;5446.972765136149;5451.536619387238;5452.57360474585;5458.263134476795;5473.808416705396;3955.6044395560216;3998.620131087542;4000.4599379084616;4020.4170395293104;4023.4769479967417;5703.505331169665;5717.683743428885;5726.312842458931;5730.5129064030025;5801.82594522165;5545.7781688732;5546.58400619947;5557.44425557441;5580.972095139498;5590.496855283044;5299.814506492255;5528.834134975958;5574.804881829116;5580.609357344947;5592.5525957922455;5500.862478438071;5502.2296878437855;5528.612997090165;5530.198121272312;5552.361478430033;5631.549476041825;5640.012997725464;5643.915341269966;5658.717064146694;5685.516731077904;5190.662606930538;5490.286262785812;5494.5054945055135;5497.092979658311;5497.972510137423 18:14:03 INFO - PROCESS | 7862 | |5;yui.html;604.4801470735168;714.4855703893195;716.5378330976523;730.7077169132347;744.7505085796256;12027.879721202786;12324.876751232485;12336.383180840967;12346.691332716686;12377.62867113987;11668.533258669664;11688.883111168885;11711.5900943467;11740.647780566596;11741.354225517593;646.7703965092395;786.5988345943553;796.34699546372;806.2985202873508;810.6109067647533;782.4522834016211;799.8200404908907;800.8998875140608;803.586153131138;809.6639894443799;814.7392834293029;840.2018082821344;840.7561807075971;848.3128665780706;848.6308455821707;803.9276465118138;830.2776584371575;837.5644664774344;837.8366218587347;840.6511297811401;591.5681552466681;620.9348018458043;622.9065640153968;624.017172952597;625.2278436131375;11694.824577631342;11751.882481175164;11761.705957351049;11793.941030294794;11830.349330786803;13194.340282985811;13282.3358832058;13307.800382994263;13594.38825252866;13776.173429594257;10225.284230103896;10248.846267305997;10273.486325683685;10280.845787313196;10469.005444482762;3345.1469875181674;3385.1706331948585;3428.297199074209;3436.7937923724407;3440.17435815405;48513.27230091516;48520;48700;48860.02279954417;50091.74954125242;9838.409695418297;9872.35829671069;9924.15644670211;10195.337303075275;10217.284790064772;16408.589785255463;16757.1621418931;16790.916045419694;16867.325306987583;16953.915230424016;6752.358525940028;6768.357006084414;6776.322367763283;6808.6255255960405;7038.542494737826;3610.891673249807;3692.9446058309145;3699.2231631357176;3788.299164654548;3791.1848952474797;2742.2184677366854;2826.109775420777;2835.815671981356;2837.90067347646;2845.5304874695858;516.354556803995;521.389973730736;524.7428759907694;527.1012922966333;527.1276038156857;499.93500844889934;501.8369030065243;599.2030599303004;608.9117078023751;624.2945471617044;7759.534427934342;7810.765677029698;7893.565853878092;8163.469374490639;8204.630791614392;477.75634426442764;485.45386440254714;552.6435449135365;560.0451230651729;569.1576466829116;3548.716102711777;3631.9276391478597;3657.524521812147;3708.351038568294;3766.924661506809;48385.5161448388;48902.266466003035;49469.752651236515;49622;49823;45338.54661453409;45776.99999999933;45831;45943.770281149045;46239.537604623525;36234.8188259057;39907.00929906986;41254;42147;43196.3520547192;7736.961315193388;7888;8044.798880028046;8145.551994640352;8151.310067677534;22299.219527316465;23362.532749344577;25775.226743197734;26280.73719262783;26456.867715661298;34029.48955765616;34818.65181348154;36268.63731362758;36436.27127457489;36895.631043689216;10853.837192441963;10888;10971.561137554727;11177.497012634614;11217.55129794799;11930;12189.268643881041;12193.390330483262;12200.694982625506;12233.938830306148;10812.67561973142;10882.347059176474;10919.744229413402;11098.2786118902;11623.244489108181;11205.327680339205;11500.53997840077;11798.823017654913;11825.994790442564;11890.16768826174;10760.89239107599;11276.492557834754;11346.829797553208;11406;11448.599299024494;9321.394109382869;9487.241020718464;9581.664641737505;9805.85291220618;9835.16401105914;9782.315237933277;9856.605735770489;9952.601895924083;9980.950095249478;10083.949580252345 18:14:03 INFO - PROCESS | 7862 | __end_tp_report 18:14:03 INFO - PROCESS | 7862 | __start_cc_report 18:14:03 INFO - PROCESS | 7862 | _x_x_mozilla_cycle_collect,372 18:14:03 INFO - PROCESS | 7862 | __end_cc_report 18:14:03 INFO - PROCESS | 7862 | __startTimestamp1460078043270__endTimestamp 18:14:03 INFO - PROCESS | 7862 | 18:14:03 INFO - PROCESS | 7862 | ------- Summary: start ------- 18:14:03 INFO - PROCESS | 7862 | Number of tests: 6 18:14:03 INFO - PROCESS | 7862 | 18:14:03 INFO - PROCESS | 7862 | [#0] dojo.html Cycles:165 Average:4706.57 Median:4846.56 stddev:490.12 (10.1%) stddev-sans-first:463.55 18:14:03 INFO - PROCESS | 7862 | Values: 2622.2 2703.3 2734.2 2735.5 2750.1 4635.7 4652.1 4665.7 4675.5 4717.6 4584.3 4647.5 4650.6 4653.7 4665.1 4251.5 4379.9 4380.6 4434.5 4457.1 4334.0 4387.9 4395.9 4411.4 4412.8 3991.2 4336.0 4336.8 4351.1 4376.9 4332.0 4340.2 4353.7 4386.4 4395.6 4215.7 4269.0 4319.4 4341.9 4373.5 4651.9 4658.9 4680.5 4683.8 4728.9 5121.5 5128.5 5130.4 5144.3 5165.9 4876.9 5123.7 5140.8 5157.4 5223.3 4785.7 4799.8 4814.7 4841.9 4855.8 5249.8 5259.9 5264.5 5267.4 5283.3 4881.7 4973.1 5009.5 5045.1 5071.1 5124.6 5129.9 5137.7 5138.0 5151.3 5086.2 5094.3 5095.1 5097.8 5136.0 4863.1 4867.8 5058.3 5125.2 5148.0 4356.1 4374.1 4387.7 4461.5 4469.8 3818.0 3827.8 3845.8 3847.5 3908.0 4287.3 4296.3 4340.1 4362.6 4411.5 5084.0 5110.6 5124.9 5135.4 5178.9 4344.8 4386.8 4400.4 4421.6 4450.4 4637.5 4684.4 4685.6 4713.5 4731.5 4799.4 4826.5 4833.3 4847.5 4881.4 4950.4 5048.8 5074.6 5151.8 5197.3 4846.6 4851.2 4863.7 4879.7 4928.5 5042.0 5063.2 5063.6 5063.8 5125.3 4950.5 5069.6 5118.6 5131.0 5171.5 4881.6 4889.2 4916.6 4918.3 4967.4 4913.8 4915.4 4932.6 4933.6 4955.0 4749.8 4905.8 4910.5 4938.9 5000.6 4872.1 4946.3 5007.1 5012.5 5066.6 4814.0 4822.7 4823.1 4827.1 4867.7 18:14:03 INFO - PROCESS | 7862 | 18:14:03 INFO - PROCESS | 7862 | [#1] ext.html Cycles:180 Average:42619.75 Median:169845.22 stddev:76238.09 (44.9%) stddev-sans-first:76386.60 18:14:03 INFO - PROCESS | 7862 | Values: 573.4 604.6 623.0 626.2 657.7 32475.7 33096.5 33126.5 33196.0 33199.2 38479.8 39261.8 39370.4 39466.6 39494.8 7787.3 7938.8 7983.9 8016.4 8022.2 7822.1 7926.3 7933.6 7936.5 7950.6 7890.0 7948.4 7983.8 7997.0 7999.4 7863.4 7877.3 7889.4 7901.0 7912.8 7747.2 7866.4 7868.5 7871.4 7879.0 35796.6 35932.3 36052.5 36292.5 36331.0 2534.5 3081.1 3159.4 3224.0 3279.8 24844.4 24994.9 25430.4 25431.4 25463.2 3265.6 3318.5 3362.4 3373.5 3373.8 209055.0 210538.0 210909.9 212421.0 213181.0 33457.0 48695.8 49396.0 49485.0 49644.5 33022.2 33202.0 33282.3 33360.0 33412.2 13345.1 13614.0 13659.2 13678.0 13682.1 10524.9 10586.4 10592.2 10593.8 10619.2 8008.1 8060.0 8066.9 8153.1 8188.9 3202.8 3220.7 3227.9 3232.5 3276.6 846.9 873.6 897.3 982.9 997.1 26759.5 27504.6 27585.0 27676.4 28054.3 976.3 994.8 1013.2 1052.3 1090.5 14450.6 14861.4 14868.3 15047.6 15147.4 336328.0 339403.0 339879.0 340852.0 341148.0 45972.5 46995.1 47147.5 47174.8 47521.0 1241.1 1250.9 1261.9 1267.2 1270.5 26266.2 26957.3 27137.5 27214.0 27726.4 40330.2 40390.4 40442.0 40493.2 40743.8 299168.0 302592.0 304149.0 305114.0 306262.0 24880.8 25286.0 37746.6 38660.8 38849.4 36008.0 36703.6 36938.4 37126.6 37153.8 31122.8 31307.7 31398.4 31798.7 31880.5 30598.8 30664.5 31006.8 31143.5 31219.7 33761.3 34569.0 35036.5 35734.6 35893.6 27854.3 31162.0 35349.6 35489.6 35658.5 23522.5 24521.9 24584.4 24764.6 25576.5 18:14:03 INFO - PROCESS | 7862 | 18:14:03 INFO - PROCESS | 7862 | [#2] jquery.html Cycles:180 Average:23415.32 Median:5233.55 stddev:64043.58 (1223.7%) stddev-sans-first:64199.86 18:14:03 INFO - PROCESS | 7862 | Values: 369.6 370.4 374.3 375.8 386.3 15817.1 15937.9 16467.8 16576.3 16603.3 15175.3 16345.1 17081.7 17091.4 17092.1 4991.5 5150.1 5195.8 5195.9 5202.4 3698.1 5092.3 5588.7 5927.6 5942.9 5819.7 5824.7 5841.6 5854.5 5884.8 5565.8 5926.9 5927.9 5941.5 5954.3 4434.3 5205.3 5226.8 5240.3 5244.2 11301.9 11431.0 11529.3 11536.0 11567.3 1789.7 1789.9 1946.8 1956.5 2045.9 8319.9 8442.9 8476.0 8804.2 8868.5 1582.0 1651.9 1696.6 1705.4 1744.2 64286.0 65232.7 65292.7 65618.0 66672.0 9344.2 9476.2 9664.9 9721.2 9838.4 12887.3 12987.9 13073.9 13095.3 13144.7 6690.6 7035.4 7069.2 7154.0 7193.6 6661.2 6690.5 6743.8 6799.2 6851.3 4033.5 4035.5 4075.9 4094.4 4105.5 1675.6 1705.7 1722.7 1781.1 1800.3 905.8 928.8 931.1 946.8 958.8 16046.2 16540.0 16772.6 16847.0 17058.6 843.4 849.2 865.8 895.4 902.6 9123.8 9380.4 9421.4 9470.2 9613.0 381004.0 383780.0 385393.0 395645.0 396953.0 71404.3 72529.3 74299.6 74810.3 74942.0 970.4 975.7 976.9 997.7 1010.0 15228.5 15683.6 15697.7 15809.9 15851.4 34077.3 34767.8 34901.0 36009.8 36276.6 42515.6 44632.1 46216.3 47825.5 49434.3 4613.0 4763.3 6579.2 6714.4 6801.2 9682.8 10034.3 10757.6 10966.9 11306.7 9574.5 9639.4 9682.1 9789.4 9794.1 9007.2 9767.0 9809.9 9850.8 9951.5 9822.1 9860.9 9890.7 9969.0 10012.2 6532.5 6619.7 6759.1 6806.2 10604.2 9868.5 9994.0 9994.5 10033.2 10603.3 18:14:03 INFO - PROCESS | 7862 | 18:14:03 INFO - PROCESS | 7862 | [#3] mootools.html Cycles:180 Average:5412.54 Median:6548.48 stddev:2806.50 (42.9%) stddev-sans-first:2798.07 18:14:03 INFO - PROCESS | 7862 | Values: 1387.8 1435.1 1511.2 1767.9 1792.0 6807.8 7601.8 7740.5 7839.5 7869.2 7735.5 7739.8 7740.1 7770.1 7805.8 2197.6 2221.8 2225.4 2234.4 2238.4 2152.6 2195.4 2218.2 2230.7 2246.2 2211.4 2236.2 2238.3 2240.8 2262.3 2173.2 2176.4 2187.1 2188.5 2194.0 2169.9 2174.3 2177.8 2178.1 2181.6 7891.0 7942.5 7943.6 7945.1 7951.8 4474.0 4572.4 4572.8 4580.7 4598.8 2774.7 2860.6 2873.2 2877.5 2897.9 884.7 926.7 929.9 936.8 943.1 10176.9 10444.5 10459.8 10466.1 10482.6 3888.8 3933.5 4019.3 4031.3 4085.5 8192.8 8197.5 8220.8 8222.1 8228.8 4485.3 4516.1 4528.2 4560.3 4570.2 3705.6 4223.9 4226.0 4226.6 4336.9 3760.6 3816.6 3897.0 3907.6 3910.3 1250.9 1259.3 1272.0 1287.3 1288.7 1212.4 1240.0 1256.4 1262.6 1273.0 7153.1 7377.4 7381.6 7397.3 7480.3 1059.0 1066.3 1081.3 1083.7 1101.6 5651.7 5799.1 5816.8 5822.8 5832.1 8655.4 8888.8 9194.0 9259.9 9279.0 9289.4 9301.9 9325.0 9347.3 9347.8 7268.5 7393.0 7565.0 7570.7 7621.3 7178.0 7318.4 7333.3 7345.7 7583.5 8479.9 8530.1 8586.1 8705.4 8712.4 8580.1 8682.2 9009.8 9014.4 9028.3 6166.3 6468.7 6557.9 6598.3 6787.2 7596.8 7662.5 7663.5 7691.0 7753.2 6626.0 6764.8 6793.3 6816.3 7015.8 6656.7 6668.2 6726.6 6824.4 6845.9 7194.5 7213.4 7240.3 7266.9 7343.2 6429.8 6484.0 6528.7 6550.5 6572.7 6546.4 6553.3 6554.2 6569.5 6630.5 18:14:03 INFO - PROCESS | 7862 | 18:14:03 INFO - PROCESS | 7862 | [#4] prototype.html Cycles:180 Average:4617.33 Median:5224.36 stddev:1347.22 (25.8%) stddev-sans-first:1311.29 18:14:03 INFO - PROCESS | 7862 | Values: 291.4 298.8 302.8 321.0 321.3 5215.4 5290.6 5298.5 5311.9 5353.9 5209.6 5222.6 5222.8 5225.9 5245.5 4111.6 4122.1 4124.5 4126.7 4132.4 4023.1 4107.3 4132.4 4162.6 4172.2 4092.6 4093.5 4108.8 4110.9 4115.9 3871.6 4085.3 4091.3 4121.1 4126.9 3471.5 3575.9 3582.2 3604.1 3605.2 5051.5 5067.1 5074.1 5084.2 5104.3 4605.3 4666.5 4709.2 4717.2 4721.4 5451.8 5482.1 5558.6 5559.4 5573.7 3849.6 3864.3 3877.6 3888.3 3899.2 5672.2 5765.9 5813.9 5815.5 5844.5 4102.3 4107.1 4114.3 4129.3 4131.5 4135.2 4135.9 4146.5 4150.8 4154.2 4729.2 4738.6 4745.0 4749.8 4762.7 5483.6 5522.6 5556.4 5584.4 5585.7 1398.2 1419.7 1436.4 1438.9 1448.8 971.5 987.5 991.7 993.7 1006.0 4847.2 4868.6 4877.6 4888.6 4896.7 5676.9 5699.8 5709.5 5712.4 5718.3 4667.4 4850.4 4855.2 4905.8 4931.7 2948.3 2991.6 3083.4 3083.5 3092.3 5432.0 5455.3 5466.5 5488.5 5520.9 5781.2 5911.7 5926.7 5938.6 5961.1 5407.8 5430.1 5452.9 5463.2 5467.8 5713.5 5717.2 5754.7 5757.9 5759.3 5408.4 5632.4 5650.9 5653.5 5679.5 5447.0 5451.5 5452.6 5458.3 5473.8 3955.6 3998.6 4000.5 4020.4 4023.5 5703.5 5717.7 5726.3 5730.5 5801.8 5545.8 5546.6 5557.4 5581.0 5590.5 5299.8 5528.8 5574.8 5580.6 5592.6 5500.9 5502.2 5528.6 5530.2 5552.4 5631.5 5640.0 5643.9 5658.7 5685.5 5190.7 5490.3 5494.5 5497.1 5498.0 18:14:03 INFO - PROCESS | 7862 | 18:14:03 INFO - PROCESS | 7862 | [#5] yui.html Cycles:180 Average:12515.74 Median:41700.50 stddev:13972.84 (33.5%) stddev-sans-first:13983.40 18:14:03 INFO - PROCESS | 7862 | Values: 604.5 714.5 716.5 730.7 744.8 12027.9 12324.9 12336.4 12346.7 12377.6 11668.5 11688.9 11711.6 11740.6 11741.4 646.8 786.6 796.3 806.3 810.6 782.5 799.8 800.9 803.6 809.7 814.7 840.2 840.8 848.3 848.6 803.9 830.3 837.6 837.8 840.7 591.6 620.9 622.9 624.0 625.2 11694.8 11751.9 11761.7 11793.9 11830.3 13194.3 13282.3 13307.8 13594.4 13776.2 10225.3 10248.8 10273.5 10280.8 10469.0 3345.1 3385.2 3428.3 3436.8 3440.2 48513.3 48520.0 48700.0 48860.0 50091.7 9838.4 9872.4 9924.2 10195.3 10217.3 16408.6 16757.2 16790.9 16867.3 16953.9 6752.4 6768.4 6776.3 6808.6 7038.5 3610.9 3692.9 3699.2 3788.3 3791.2 2742.2 2826.1 2835.8 2837.9 2845.5 516.4 521.4 524.7 527.1 527.1 499.9 501.8 599.2 608.9 624.3 7759.5 7810.8 7893.6 8163.5 8204.6 477.8 485.5 552.6 560.0 569.2 3548.7 3631.9 3657.5 3708.4 3766.9 48385.5 48902.3 49469.8 49622.0 49823.0 45338.5 45777.0 45831.0 45943.8 46239.5 36234.8 39907.0 41254.0 42147.0 43196.4 7737.0 7888.0 8044.8 8145.6 8151.3 22299.2 23362.5 25775.2 26280.7 26456.9 34029.5 34818.7 36268.6 36436.3 36895.6 10853.8 10888.0 10971.6 11177.5 11217.6 11930.0 12189.3 12193.4 12200.7 12233.9 10812.7 10882.3 10919.7 11098.3 11623.2 11205.3 11500.5 11798.8 11826.0 11890.2 10760.9 11276.5 11346.8 11406.0 11448.6 9321.4 9487.2 9581.7 9805.9 9835.2 9782.3 9856.6 9952.6 9981.0 10083.9 18:14:03 INFO - PROCESS | 7862 | -------- Summary: end -------- 18:14:03 INFO - PROCESS | 7862 | 18:14:03 INFO - TEST-INFO | 7862: exit 0 18:14:03 INFO - TEST-OK | dromaeo_css | took 1114850ms 18:14:03 INFO - TEST-START | kraken 18:14:03 INFO - operating with platform_type : linux_ 18:14:03 INFO - Initialising browser for kraken test... 18:14:03 INFO - TEST-INFO | started process 8093 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp47L7RO/profile http://localhost:47596/getInfo.html) 18:14:07 INFO - PROCESS | 8093 | 18:14:07 INFO - PROCESS | 8093 | (process:8162): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:14:08 INFO - PROCESS | 8093 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 18:14:08 INFO - PROCESS | 8093 | __metrics Screen width/height:1600/1200 18:14:08 INFO - PROCESS | 8093 | colorDepth:24 18:14:08 INFO - PROCESS | 8093 | Browser inner width/height: 1024/697 18:14:08 INFO - PROCESS | 8093 | __metrics 18:14:09 ERROR - PROCESS | 8093 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 18:14:10 INFO - TEST-INFO | 8093: exit 0 18:14:10 INFO - Browser initialized. 18:14:10 INFO - Running cycle 1/1 for kraken test... 18:14:10 INFO - TEST-INFO | started process 8213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp47L7RO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:14:12 INFO - PROCESS | 8213 | 18:14:12 INFO - PROCESS | 8213 | (process:8274): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:14:22 INFO - PROCESS | 8213 | RSS: Main: 163983360 18:14:22 INFO - PROCESS | 8213 | 18:14:24 INFO - PROCESS | 8213 | Cycle 1(1): loaded http://localhost:47596/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47596/tests/kraken/driver.html?testName=audio-beat-detection) 18:14:25 INFO - PROCESS | 8213 | RSS: Main: 168304640 18:14:25 INFO - PROCESS | 8213 | 18:14:28 INFO - PROCESS | 8213 | Cycle 1(1): loaded http://localhost:47596/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47596/tests/kraken/driver.html?testName=audio-dft) 18:14:28 INFO - PROCESS | 8213 | RSS: Main: 171634688 18:14:28 INFO - PROCESS | 8213 | 18:14:31 INFO - PROCESS | 8213 | Cycle 1(1): loaded http://localhost:47596/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47596/tests/kraken/driver.html?testName=audio-fft) 18:14:32 INFO - PROCESS | 8213 | RSS: Main: 163213312 18:14:32 INFO - PROCESS | 8213 | 18:14:34 INFO - PROCESS | 8213 | Cycle 1(1): loaded http://localhost:47596/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47596/tests/kraken/driver.html?testName=audio-oscillator) 18:14:35 INFO - PROCESS | 8213 | RSS: Main: 163106816 18:14:35 INFO - PROCESS | 8213 | 18:14:37 INFO - PROCESS | 8213 | Cycle 1(1): loaded http://localhost:47596/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47596/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:14:37 INFO - PROCESS | 8213 | RSS: Main: 163901440 18:14:37 INFO - PROCESS | 8213 | 18:14:41 INFO - PROCESS | 8213 | Cycle 1(1): loaded http://localhost:47596/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47596/tests/kraken/driver.html?testName=imaging-darkroom) 18:14:41 INFO - PROCESS | 8213 | RSS: Main: 164098048 18:14:41 INFO - PROCESS | 8213 | 18:14:45 INFO - PROCESS | 8213 | Cycle 1(1): loaded http://localhost:47596/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47596/tests/kraken/driver.html?testName=imaging-desaturate) 18:14:45 INFO - PROCESS | 8213 | RSS: Main: 163782656 18:14:45 INFO - PROCESS | 8213 | 18:14:48 INFO - PROCESS | 8213 | Cycle 1(1): loaded http://localhost:47596/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47596/tests/kraken/driver.html?testName=json-parse-financial) 18:14:49 INFO - PROCESS | 8213 | RSS: Main: 164810752 18:14:49 INFO - PROCESS | 8213 | 18:14:51 INFO - PROCESS | 8213 | Cycle 1(1): loaded http://localhost:47596/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47596/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:14:51 INFO - PROCESS | 8213 | RSS: Main: 164741120 18:14:51 INFO - PROCESS | 8213 | 18:14:53 INFO - PROCESS | 8213 | Cycle 1(1): loaded http://localhost:47596/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47596/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:14:54 INFO - PROCESS | 8213 | RSS: Main: 164847616 18:14:54 INFO - PROCESS | 8213 | 18:14:56 INFO - PROCESS | 8213 | Cycle 1(1): loaded http://localhost:47596/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47596/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:14:57 INFO - PROCESS | 8213 | RSS: Main: 165371904 18:14:57 INFO - PROCESS | 8213 | 18:14:59 INFO - PROCESS | 8213 | Cycle 1(1): loaded http://localhost:47596/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:15:00 INFO - PROCESS | 8213 | RSS: Main: 165498880 18:15:00 INFO - PROCESS | 8213 | 18:15:03 INFO - PROCESS | 8213 | Cycle 1(1): loaded http://localhost:47596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:15:04 INFO - PROCESS | 8213 | RSS: Main: 165208064 18:15:04 INFO - PROCESS | 8213 | 18:15:05 INFO - PROCESS | 8213 | Cycle 1(1): loaded http://localhost:47596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47596/tests/kraken/driver.html?testName=ai-astar) 18:15:06 INFO - PROCESS | 8213 | RSS: Main: 166531072 18:15:06 INFO - PROCESS | 8213 | 18:15:06 INFO - PROCESS | 8213 | __start_tp_report 18:15:06 INFO - PROCESS | 8213 | _x_x_mozilla_page_load 18:15:06 INFO - PROCESS | 8213 | _x_x_mozilla_page_load_details 18:15:06 INFO - PROCESS | 8213 | |i|pagename|runs| 18:15:06 INFO - PROCESS | 8213 | |0;ai-astar;114;108;113;115;115;129;115;115;114;115 18:15:06 INFO - PROCESS | 8213 | |1;audio-beat-detection;157;131;159;177;142;165;161;138;171;132 18:15:06 INFO - PROCESS | 8213 | |2;audio-dft;169;165;165;162;165;168;166;164;166;163 18:15:06 INFO - PROCESS | 8213 | |3;audio-fft;74;74;74;74;73;78;78;140;77;76 18:15:06 INFO - PROCESS | 8213 | |4;audio-oscillator;93;94;142;94;94;95;130;94;95;133 18:15:06 INFO - PROCESS | 8213 | |5;imaging-gaussian-blur;117;117;117;118;117;118;119;118;119;117 18:15:06 INFO - PROCESS | 8213 | |6;imaging-darkroom;148;148;147;148;148;150;147;147;148;147 18:15:06 INFO - PROCESS | 8213 | |7;imaging-desaturate;97;96;96;96;96;96;96;96;96;96 18:15:06 INFO - PROCESS | 8213 | |8;json-parse-financial;68;66;69;65;67;67;66;67;66;67 18:15:06 INFO - PROCESS | 8213 | |9;json-stringify-tinderbox;63;65;64;64;65;65;64;64;65;64 18:15:06 INFO - PROCESS | 8213 | |10;stanford-crypto-aes;90;87;88;93;95;93;89;86;86;87 18:15:06 INFO - PROCESS | 8213 | |11;stanford-crypto-ccm;145;141;144;146;142;150;147;149;149;142 18:15:06 INFO - PROCESS | 8213 | |12;stanford-crypto-pbkdf2;173;175;184;173;172;173;190;170;176;169 18:15:06 INFO - PROCESS | 8213 | |13;stanford-crypto-sha256-iterative;72;72;73;74;73;73;71;73;73;71 18:15:06 INFO - PROCESS | 8213 | __end_tp_report 18:15:06 INFO - PROCESS | 8213 | __start_cc_report 18:15:06 INFO - PROCESS | 8213 | _x_x_mozilla_cycle_collect,913 18:15:06 INFO - PROCESS | 8213 | __end_cc_report 18:15:06 INFO - PROCESS | 8213 | __startTimestamp1460078106100__endTimestamp 18:15:06 INFO - PROCESS | 8213 | 18:15:06 INFO - PROCESS | 8213 | ------- Summary: start ------- 18:15:06 INFO - PROCESS | 8213 | Number of tests: 14 18:15:06 INFO - PROCESS | 8213 | 18:15:06 INFO - PROCESS | 8213 | [#0] ai-astar Cycles:10 Average:115.30 Median:115.00 stddev:5.27 (4.6%) stddev-sans-first:5.57 18:15:06 INFO - PROCESS | 8213 | Values: 114.0 108.0 113.0 115.0 115.0 129.0 115.0 115.0 114.0 115.0 18:15:06 INFO - PROCESS | 8213 | 18:15:06 INFO - PROCESS | 8213 | [#1] audio-beat-detection Cycles:10 Average:153.30 Median:160.00 stddev:16.43 (10.3%) stddev-sans-first:17.37 18:15:06 INFO - PROCESS | 8213 | Values: 157.0 131.0 159.0 177.0 142.0 165.0 161.0 138.0 171.0 132.0 18:15:06 INFO - PROCESS | 8213 | 18:15:06 INFO - PROCESS | 8213 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.50 stddev:2.11 (1.3%) stddev-sans-first:1.76 18:15:06 INFO - PROCESS | 8213 | Values: 169.0 165.0 165.0 162.0 165.0 168.0 166.0 164.0 166.0 163.0 18:15:06 INFO - PROCESS | 8213 | 18:15:06 INFO - PROCESS | 8213 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:20.53 (27.4%) stddev-sans-first:21.58 18:15:06 INFO - PROCESS | 8213 | Values: 74.0 74.0 74.0 74.0 73.0 78.0 78.0 140.0 77.0 76.0 18:15:06 INFO - PROCESS | 8213 | 18:15:06 INFO - PROCESS | 8213 | [#4] audio-oscillator Cycles:10 Average:106.40 Median:94.00 stddev:19.96 (21.2%) stddev-sans-first:20.58 18:15:06 INFO - PROCESS | 8213 | Values: 93.0 94.0 142.0 94.0 94.0 95.0 130.0 94.0 95.0 133.0 18:15:06 INFO - PROCESS | 8213 | 18:15:06 INFO - PROCESS | 8213 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 18:15:06 INFO - PROCESS | 8213 | Values: 117.0 117.0 117.0 118.0 117.0 118.0 119.0 118.0 119.0 117.0 18:15:06 INFO - PROCESS | 8213 | 18:15:06 INFO - PROCESS | 8213 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 18:15:06 INFO - PROCESS | 8213 | Values: 148.0 148.0 147.0 148.0 148.0 150.0 147.0 147.0 148.0 147.0 18:15:06 INFO - PROCESS | 8213 | 18:15:06 INFO - PROCESS | 8213 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 18:15:06 INFO - PROCESS | 8213 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 18:15:06 INFO - PROCESS | 8213 | 18:15:06 INFO - PROCESS | 8213 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.12 18:15:06 INFO - PROCESS | 8213 | Values: 68.0 66.0 69.0 65.0 67.0 67.0 66.0 67.0 66.0 67.0 18:15:06 INFO - PROCESS | 8213 | 18:15:06 INFO - PROCESS | 8213 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.53 18:15:06 INFO - PROCESS | 8213 | Values: 63.0 65.0 64.0 64.0 65.0 65.0 64.0 64.0 65.0 64.0 18:15:06 INFO - PROCESS | 8213 | 18:15:06 INFO - PROCESS | 8213 | [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:89.50 stddev:3.24 (3.6%) stddev-sans-first:3.43 18:15:06 INFO - PROCESS | 8213 | Values: 90.0 87.0 88.0 93.0 95.0 93.0 89.0 86.0 86.0 87.0 18:15:06 INFO - PROCESS | 8213 | 18:15:06 INFO - PROCESS | 8213 | [#11] stanford-crypto-ccm Cycles:10 Average:145.50 Median:146.50 stddev:3.24 (2.2%) stddev-sans-first:3.43 18:15:06 INFO - PROCESS | 8213 | Values: 145.0 141.0 144.0 146.0 142.0 150.0 147.0 149.0 149.0 142.0 18:15:06 INFO - PROCESS | 8213 | 18:15:06 INFO - PROCESS | 8213 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:174.00 stddev:6.55 (3.8%) stddev-sans-first:6.89 18:15:06 INFO - PROCESS | 8213 | Values: 173.0 175.0 184.0 173.0 172.0 173.0 190.0 170.0 176.0 169.0 18:15:06 INFO - PROCESS | 8213 | 18:15:06 INFO - PROCESS | 8213 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:73.00 stddev:0.97 (1.3%) stddev-sans-first:1.01 18:15:06 INFO - PROCESS | 8213 | Values: 72.0 72.0 73.0 74.0 73.0 73.0 71.0 73.0 73.0 71.0 18:15:06 INFO - PROCESS | 8213 | -------- Summary: end -------- 18:15:06 INFO - PROCESS | 8213 | 18:15:07 INFO - TEST-INFO | 8213: exit 0 18:15:07 INFO - TEST-OK | kraken | took 63142ms 18:15:07 INFO - SUITE-END | took 1177s 18:15:07 INFO - Completed test suite (00:19:38) 18:15:07 INFO - javascript benchmark 18:15:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2622.2002289301763, 2703.270117068391, 2734.2070799468156, 2735.5076086304457, 2750.0787236275846, 4635.721856688601, 4652.092841895832, 4665.673402861797, 4675.532446755331, 4717.599004084657, 4584.266517357215, 4647.512011238813, 4650.604698600615, 4653.674242803005, 4665.136949664315, 4251.48982122145, 4379.868603941887, 4380.627646650023, 4434.467863856342, 4457.064016556527, 4333.956660433387, 4387.890302742425, 4395.934060989088, 4411.448568928884, 4412.75729834859, 3991.181807729423, 4336.046069864625, 4336.804843782037, 4351.108022855307, 4376.934345984812, 4331.97834010828, 4340.240457919883, 4353.717008394444, 4386.385905973167, 4395.582419670126, 4215.662746980234, 4268.9786551067045, 4319.43847299849, 4341.913161736779, 4373.497047839507, 4651.930221046687, 4658.906821863544, 4680.485146633868, 4683.812647494096, 4728.858134255978, 5121.539061484485, 5128.538431541179, 5130.4356520782685, 5144.254083157921, 5165.896682066375, 4876.926846097312, 5123.666961647518, 5140.768665410065, 5157.432682404932, 5223.268742376071, 4785.736784476887, 4799.808007679723, 4814.6870453420415, 4841.8547443576745, 4855.75721213945, 5249.763760630781, 5259.894802103937, 5264.473552644705, 5267.394249661262, 5283.260343551906, 4881.658283920092, 4973.079980203674, 5009.524095210949, 5045.142325804622, 5071.112555302807, 5124.615653825978, 5129.9230511542355, 5137.717425541631, 5137.974310128426, 5151.25306830515, 5086.23706444029, 5094.261332106824, 5095.082885080721, 5097.796088156507, 5135.974320128375, 4863.051704917507, 4867.829625963145, 5058.317127187856, 5125.154349532286, 5148.0, 4356.085222103394, 4374.059577190919, 4387.714798538085, 4461.486929003207, 4469.754163521037, 3818.026403267149, 3827.808609569566, 3845.8461661533224, 3847.480590120354, 3908.0, 4287.335463003239, 4296.3125899856495, 4340.131973605292, 4362.563743625676, 4411.492678341968, 5083.974580127149, 5110.591152707774, 5124.897502049938, 5135.409427915837, 5178.896422071537, 4344.761038142932, 4386.780660966939, 4400.383946247528, 4421.557844215553, 4450.443694538183, 4637.489876113625, 4684.4378674559275, 4685.601723853442, 4713.528647135259, 4731.526847315241, 4799.448063472675, 4826.469088400203, 4833.250846118787, 4847.5394837490385, 4881.365422495124, 4950.381202349707, 5048.848534543969, 5074.6194035448225, 5151.768170432414, 5197.324347834909, 4846.5638092571835, 4851.248056551241, 4863.708177509361, 4879.707217566957, 4928.531789479994, 5042.008441506741, 5063.1898896176435, 5063.620228482952, 5063.772130254074, 5125.308083408692, 4950.45544990058, 5069.6197785167, 5118.616103792156, 5131.025105229995, 5171.456997015259, 4881.585065269492, 4889.193283108248, 4916.557509824133, 4918.336024636771, 4967.379077615298, 4913.828016019422, 4915.410150781929, 4932.605391568738, 4933.55597996182, 4955.0, 4749.833755818668, 4905.8037678492465, 4910.508949105061, 4938.913439043405, 5000.649954503296, 4872.098661747588, 4946.258061290835, 5007.148784706682, 5012.498750125104, 5066.594672426123, 4813.989062296817, 4822.662413631152, 4823.083614113307, 4827.131116399082, 4867.70793752376], "value": 4676.08782105876, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.4007961680046, 604.5707547641175, 623.034296839898, 626.1609443345917, 657.7073202424923, 32475.67524324759, 33096.50355244673, 33126.503102453426, 33196.0, 33199.170020749465, 38479.80760096203, 39261.80369098158, 39370.40944385836, 39466.60533394665, 39494.802525987405, 7787.260210280015, 7938.841223175533, 7983.920160798405, 8016.438849280553, 8022.19778022196, 7822.100458447295, 7926.28663420292, 7933.563653999027, 7936.484128531656, 7950.6422211000645, 7890.0, 7948.403869709795, 7983.800404989864, 7997.040355157389, 7999.440039197259, 7863.37093032556, 7877.251661092187, 7889.408294377916, 7901.0, 7912.841743165133, 7747.186545412706, 7866.370690344816, 7868.488548244403, 7871.370290376756, 7878.960605196995, 35796.64203357959, 35932.28135437303, 36052.459213111826, 36292.455613165825, 36331.0, 2534.5437821192177, 3081.1372815611667, 3159.4470967580583, 3223.9516407253677, 3279.754018448626, 24844.3788905277, 24994.875025624937, 25430.36424089394, 25431.364215894566, 25463.23610291694, 3265.6407795142513, 3318.5354050432957, 3362.4451965425674, 3373.4602463605706, 3373.814440205788, 209055.0, 210538.0, 210909.9454502733, 212421.0, 213181.0, 33457.0, 48695.756521217874, 49396.0, 49485.01029979452, 49644.50355496471, 33022.17444563857, 33202.0, 33282.3343533128, 33360.0, 33412.1646958828, 13345.132566383154, 13614.0, 13659.248741319323, 13678.0, 13682.110662806886, 10524.894751052545, 10586.364818110938, 10592.15262778976, 10593.84109238362, 10619.20355973305, 8008.119106898236, 8059.959700201579, 8066.878996815052, 8153.103158652543, 8188.918110818816, 3202.838084293093, 3220.710136087763, 3227.919302017421, 3232.531282963957, 3276.5904261967253, 846.8856704344958, 873.5937788928179, 897.2552781191596, 982.931194816356, 997.1125698128672, 26759.464810703677, 27504.58743118855, 27585.0, 27676.446471070467, 28054.298642533693, 976.2531663277598, 994.8010397920444, 1013.159077965287, 1052.3265110329396, 1090.5310716391868, 14450.638734031734, 14861.365249822511, 14868.330925108396, 15047.623809404853, 15147.394104235707, 336328.0, 339403.0, 339879.0, 340852.0, 341148.0, 45972.54027459749, 46995.06009879783, 47147.52852471431, 47174.764126179834, 47521.0, 1241.118805647982, 1250.8936740376987, 1261.8675039120944, 1267.1889990406148, 1270.453704906899, 26266.212013639622, 26957.326066848487, 27137.457250855266, 27214.0, 27726.44547109087, 40330.1933961325, 40390.39414408845, 40442.0, 40493.19013619652, 40743.7962810184, 299168.0, 302592.0, 304149.0, 305114.0, 306262.0, 24880.75119248784, 25286.0, 37746.62253377541, 38660.80669596634, 38849.417258741705, 36008.0, 36703.632963670025, 36938.44592331171, 37126.628733712314, 37153.81423092867, 31122.844385777928, 31307.686923131387, 31398.372032558764, 31798.682013180496, 31880.5217921736, 30598.847005765718, 30664.540031899985, 31006.84496577593, 31143.53284700686, 31219.687803122586, 33761.324773503904, 34569.0, 35036.47445288374, 35734.64265357313, 35893.64106358903, 27854.3036424091, 31161.957819339073, 35349.64650353567, 35489.645103549665, 35658.46512302369, 23522.529549409257, 24521.87739061293, 24584.385390364667, 24764.628530572416, 25576.488470230863], "value": 16042.414332126076, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.56022333423226, 370.4128955605365, 374.25896724485517, 375.75162718300277, 386.281516379534, 15817.130057846829, 15937.920310398446, 16467.83532164678, 16576.336946522155, 16603.252853621587, 15175.317110730017, 16345.101019443926, 17081.658366832657, 17091.40180093697, 17092.145392730345, 4991.500849915015, 5150.098732721777, 5195.766190521435, 5195.896082078356, 5202.4277329493725, 3698.1124530112847, 5092.28707980883, 5588.748506317225, 5927.585069045169, 5942.9108563371365, 5819.709014549277, 5824.650520968734, 5841.620294680833, 5854.473097421232, 5884.823455296348, 5565.777368905239, 5926.940730592682, 5927.9407205928255, 5941.494972927307, 5954.345022047572, 4434.312681534368, 5205.297284866532, 5226.817061402832, 5240.292560504321, 5244.1871509915645, 11301.926316999872, 11431.0, 11529.250598711056, 11536.0, 11567.305961642243, 1789.6599646067205, 1789.8568114550806, 1946.783260462211, 1956.5402130499322, 2045.877247365163, 8319.918410606582, 8442.915570844274, 8475.95762021192, 8804.207621314112, 8868.467891926504, 1581.9841801581952, 1651.9091449970247, 1696.6097797506643, 1705.4372057221087, 1744.2151032035636, 64286.0, 65232.673836630514, 65292.67353663249, 65618.0, 66671.99992000172, 9344.205742511962, 9476.194523465583, 9664.855027174457, 9721.222302215805, 9838.409695418297, 12887.291198984145, 12987.870121298665, 13073.869261307265, 13095.279759613313, 13144.737105257842, 6690.632015239111, 7035.401990830836, 7069.187043490065, 7153.96423017892, 7193.604351760703, 6661.2006559213205, 6690.498212634072, 6743.831404214934, 6799.150106236721, 6851.3491218334175, 4033.5361433435532, 4035.4552135461336, 4075.898102547401, 4094.406311084876, 4105.527864295585, 1675.5559776659195, 1705.6929752644394, 1722.6726921884801, 1781.1361489677497, 1800.306881850497, 905.7961958559272, 928.7863791328033, 931.1479995803899, 946.8485042393185, 958.7746879483316, 16046.197690115447, 16540.007599544067, 16772.58068548296, 16847.0, 17058.573535661708, 843.3801156150224, 849.1932663969254, 865.8095219051798, 895.4000819450983, 902.6118768929292, 9123.77190570241, 9380.390274632127, 9421.38760980534, 9470.195033422098, 9612.99063598326, 381004.0, 383780.0, 385393.0, 395645.0, 396953.0, 71404.2859571408, 72529.27470725331, 74299.62850185715, 74810.25189748142, 74942.0, 970.3838062830154, 975.7024107647236, 976.8778902637313, 997.6558087459815, 1009.9849651100596, 15228.543143705707, 15683.607909802346, 15697.686046278783, 15809.920950395175, 15851.445199417965, 34077.318453630294, 34767.82616086904, 34900.9529714109, 36009.81995090008, 36276.63723362733, 42515.57484425116, 44632.10735785201, 46216.30675539802, 47825.521744782105, 49434.25848612202, 4613.0, 4763.333133361401, 6579.243387010363, 6714.4292735116105, 6801.2178599461695, 9682.806343873224, 10034.29759916828, 10757.569697212024, 10966.890331096905, 11306.717332066435, 9574.521273936414, 9639.373440726331, 9682.128608425275, 9789.363691360039, 9794.069563391466, 9007.189352958265, 9766.951165244413, 9809.901900981184, 9850.802983940424, 9951.502424878872, 9822.116009559173, 9860.85208721884, 9890.653827116017, 9968.950155249177, 10012.249081319076, 6532.477401807939, 6619.66901654925, 6759.053732477359, 6806.217285012287, 10604.204684648836, 9868.457234851865, 9993.972332508185, 9994.500274986367, 10033.247506437192, 10603.257771955889], "value": 7850.386312830197, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.833459984802, 1435.124574009854, 1511.1990644958175, 1767.8939263644174, 1792.0054369824743, 6807.795766127012, 7601.8479630407355, 7740.4968677036095, 7839.49043312185, 7869.173736757637, 7735.497192682472, 7739.767806965786, 7740.148583655808, 7770.1064377596595, 7805.804854878616, 2197.5824593327256, 2221.7889300516426, 2225.3657707553352, 2234.3855439754116, 2238.3956331790405, 2152.591007708538, 2195.4401627584944, 2218.201447478906, 2230.654248591471, 2246.168917500519, 2211.436083798629, 2236.2173239366252, 2238.3173132194675, 2240.843140980132, 2262.2986874069093, 2173.2067795254775, 2176.3688530326185, 2187.125149940021, 2188.485705859122, 2194.0, 2169.9240526581493, 2174.282486779359, 2177.8366622503218, 2178.0852042142337, 2181.6182168120517, 7891.0, 7942.523448593103, 7943.602819859042, 7945.12603613602, 7951.801204969865, 4473.9552604473865, 4572.405587273666, 4572.839950601713, 4580.725156490588, 4598.793054312564, 2774.722527747209, 2860.556613724876, 2873.2385917731817, 2877.5252083406212, 2897.9275518112217, 884.6947803007952, 926.7127190570877, 929.8791157149595, 936.798588303518, 943.0522325063336, 10176.94911525445, 10444.529996150191, 10459.843102353394, 10466.05805477503, 10482.633107841266, 3888.844446222176, 3933.4886464759397, 4019.256437559061, 4031.294523458383, 4085.4893138357706, 8192.75421737349, 8197.46716463428, 8220.794480138044, 8222.13667564909, 8228.83542329162, 4485.349624304457, 4516.119356725407, 4528.230200865861, 4560.293154561048, 4570.200214962369, 3705.55533335996, 4223.915521689611, 4225.9788701056295, 4226.598473145046, 4336.891577710519, 3760.5863355030924, 3816.580176180618, 3896.980515097406, 3907.5897030811925, 3910.2570511602703, 1250.893674037717, 1259.3262604506544, 1272.0332547264145, 1287.2726909296218, 1288.7358091591202, 1212.381685340465, 1239.9814002789965, 1256.434604428011, 1262.6338361874953, 1273.0324953035574, 7153.070100886852, 7377.413856020874, 7381.630918454163, 7397.26027397256, 7480.326770590673, 1058.9735256618646, 1066.2855886556026, 1081.2755453845941, 1083.685731137977, 1101.581399068349, 5651.717414129277, 5799.072148456226, 5816.796412125555, 5822.796202132905, 5832.096025116114, 8655.394122411497, 8888.822223555622, 9194.0, 9259.907400926038, 9278.953605232065, 9289.396189247813, 9301.860472092923, 9324.95337523308, 9347.252219822398, 9347.813043739086, 7268.527545709512, 7392.96303518479, 7564.962175189089, 7570.697172113054, 7621.314081732781, 7178.0, 7318.414526837733, 7333.303336183054, 7345.742898998509, 7583.469157158946, 8479.872801908099, 8530.10433904431, 8586.055533891142, 8705.390622656354, 8712.433691810013, 8580.14198580137, 8682.218600326001, 9009.774755631162, 9014.368994170345, 9028.322875784212, 6166.2600487939935, 6468.708908099241, 6557.9344206559235, 6598.307177746267, 6787.185537735503, 7596.772096837104, 7662.540247585162, 7663.540187588539, 7691.0, 7753.1859154787935, 6626.0, 6764.797056088325, 6793.320667933167, 6816.2842901496615, 7015.824604384727, 6656.7337306509135, 6668.199816022108, 6726.630035348103, 6824.4199243064895, 6845.863082738218, 7194.532355396883, 7213.386862116569, 7240.348368646847, 7266.890996634949, 7343.1555371133, 6429.7749578764515, 6483.967580162069, 6528.67356632176, 6550.541462097607, 6572.671366431564, 6546.41082302576, 6553.311902250195, 6554.180727409074, 6569.540132190701, 6630.535862489773], "value": 4445.111430823121, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.37209313928486, 298.76696176981955, 302.7517435702723, 320.97432205423553, 321.29956694406184, 5215.400228973669, 5290.603204759644, 5298.4701529847, 5311.867203319919, 5353.892922141555, 5209.609279304058, 5222.582193424527, 5222.817201397952, 5225.9025604623075, 5245.4754524547525, 4111.588841115887, 4122.113745544707, 4124.525679546846, 4126.690498212631, 4132.359484279941, 4023.135025969416, 4107.322291821846, 4132.442120313749, 4162.583741625828, 4172.16556688662, 4092.6494256895153, 4093.488313960755, 4108.760725404647, 4110.876673699794, 4115.8765237042935, 3871.593482684306, 4085.346344584867, 4091.284025295576, 4121.093359460944, 4126.896827579305, 3471.479278108279, 3575.8902247673736, 3582.247727977128, 3604.0809593553477, 3605.152789094561, 5051.545360917498, 5067.0879241736475, 5074.112030394666, 5084.186530155194, 5104.285400043997, 4605.332226827091, 4666.4633567139535, 4709.246520556729, 4717.174494463455, 4721.386219791405, 5451.754671039813, 5482.122860342366, 5558.555315574744, 5559.358620103839, 5573.665580065169, 3849.615038496156, 3864.265789499986, 3877.612238776128, 3888.319544079803, 3899.2396482685886, 5672.205891175238, 5765.942340576583, 5813.941860581383, 5815.534757219412, 5844.4739973402175, 4102.343625019982, 4107.116969851496, 4114.341705327133, 4129.29801933666, 4131.5455299916985, 4135.152293779768, 4135.937960930589, 4146.481689788777, 4150.813213405404, 4154.169166166779, 4729.172394830891, 4738.573528382462, 4745.0, 4749.762511874393, 4762.714237145782, 5483.643563168382, 5522.641028333226, 5556.416576259435, 5584.413636568183, 5585.664860108406, 1398.1541167593664, 1419.7302512522795, 1436.367998080841, 1438.9064710793764, 1448.819212341938, 971.4851128901694, 987.5161171026289, 991.7371896447447, 993.7416271769248, 1005.994005994006, 4847.151748444078, 4868.563773686771, 4877.6341774367065, 4888.560029597282, 4896.681715688469, 5676.914846277309, 5699.800506982236, 5709.51469125129, 5712.371639119693, 5718.25662663851, 4667.393238878924, 4850.393700787402, 4855.247436647325, 4905.779239934212, 4931.728754918442, 2948.3071478202605, 2991.551267309921, 3083.383323335342, 3083.4758091124563, 3092.2887735820436, 5431.972840135774, 5455.318085239345, 5466.508014278734, 5488.533474654699, 5520.889582208413, 5781.161731548986, 5911.674857882857, 5926.733297001645, 5938.554608404301, 5961.076033214858, 5407.756650950795, 5430.13117901134, 5452.863678408072, 5463.153211252262, 5467.835964921059, 5713.514351280188, 5717.22817419643, 5754.741036653277, 5757.942420575908, 5759.337676167127, 5408.37803652585, 5632.436756324335, 5650.943490565041, 5653.547716182778, 5679.545636349165, 5446.972765136149, 5451.536619387238, 5452.57360474585, 5458.263134476795, 5473.808416705396, 3955.6044395560216, 3998.620131087542, 4000.4599379084616, 4020.4170395293104, 4023.4769479967417, 5703.505331169665, 5717.683743428885, 5726.312842458931, 5730.5129064030025, 5801.82594522165, 5545.7781688732, 5546.58400619947, 5557.44425557441, 5580.972095139498, 5590.496855283044, 5299.814506492255, 5528.834134975958, 5574.804881829116, 5580.609357344947, 5592.5525957922455, 5500.862478438071, 5502.2296878437855, 5528.612997090165, 5530.198121272312, 5552.361478430033, 5631.549476041825, 5640.012997725464, 5643.915341269966, 5658.717064146694, 5685.516731077904, 5190.662606930538, 5490.286262785812, 5494.5054945055135, 5497.092979658311, 5497.972510137423], "value": 4186.154972054742, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.4801470735168, 714.4855703893195, 716.5378330976523, 730.7077169132347, 744.7505085796256, 12027.879721202786, 12324.876751232485, 12336.383180840967, 12346.691332716686, 12377.62867113987, 11668.533258669664, 11688.883111168885, 11711.5900943467, 11740.647780566596, 11741.354225517593, 646.7703965092395, 786.5988345943553, 796.34699546372, 806.2985202873508, 810.6109067647533, 782.4522834016211, 799.8200404908907, 800.8998875140608, 803.586153131138, 809.6639894443799, 814.7392834293029, 840.2018082821344, 840.7561807075971, 848.3128665780706, 848.6308455821707, 803.9276465118138, 830.2776584371575, 837.5644664774344, 837.8366218587347, 840.6511297811401, 591.5681552466681, 620.9348018458043, 622.9065640153968, 624.017172952597, 625.2278436131375, 11694.824577631342, 11751.882481175164, 11761.705957351049, 11793.941030294794, 11830.349330786803, 13194.340282985811, 13282.3358832058, 13307.800382994263, 13594.38825252866, 13776.173429594257, 10225.284230103896, 10248.846267305997, 10273.486325683685, 10280.845787313196, 10469.005444482762, 3345.1469875181674, 3385.1706331948585, 3428.297199074209, 3436.7937923724407, 3440.17435815405, 48513.27230091516, 48520.0, 48700.0, 48860.02279954417, 50091.74954125242, 9838.409695418297, 9872.35829671069, 9924.15644670211, 10195.337303075275, 10217.284790064772, 16408.589785255463, 16757.1621418931, 16790.916045419694, 16867.325306987583, 16953.915230424016, 6752.358525940028, 6768.357006084414, 6776.322367763283, 6808.6255255960405, 7038.542494737826, 3610.891673249807, 3692.9446058309145, 3699.2231631357176, 3788.299164654548, 3791.1848952474797, 2742.2184677366854, 2826.109775420777, 2835.815671981356, 2837.90067347646, 2845.5304874695858, 516.354556803995, 521.389973730736, 524.7428759907694, 527.1012922966333, 527.1276038156857, 499.93500844889934, 501.8369030065243, 599.2030599303004, 608.9117078023751, 624.2945471617044, 7759.534427934342, 7810.765677029698, 7893.565853878092, 8163.469374490639, 8204.630791614392, 477.75634426442764, 485.45386440254714, 552.6435449135365, 560.0451230651729, 569.1576466829116, 3548.716102711777, 3631.9276391478597, 3657.524521812147, 3708.351038568294, 3766.924661506809, 48385.5161448388, 48902.266466003035, 49469.752651236515, 49622.0, 49823.0, 45338.54661453409, 45776.99999999933, 45831.0, 45943.770281149045, 46239.537604623525, 36234.8188259057, 39907.00929906986, 41254.0, 42147.0, 43196.3520547192, 7736.961315193388, 7888.0, 8044.798880028046, 8145.551994640352, 8151.310067677534, 22299.219527316465, 23362.532749344577, 25775.226743197734, 26280.73719262783, 26456.867715661298, 34029.48955765616, 34818.65181348154, 36268.63731362758, 36436.27127457489, 36895.631043689216, 10853.837192441963, 10888.0, 10971.561137554727, 11177.497012634614, 11217.55129794799, 11930.0, 12189.268643881041, 12193.390330483262, 12200.694982625506, 12233.938830306148, 10812.67561973142, 10882.347059176474, 10919.744229413402, 11098.2786118902, 11623.244489108181, 11205.327680339205, 11500.53997840077, 11798.823017654913, 11825.994790442564, 11890.16768826174, 10760.89239107599, 11276.492557834754, 11346.829797553208, 11406.0, 11448.599299024494, 9321.394109382869, 9487.241020718464, 9581.664641737505, 9805.85291220618, 9835.16401105914, 9782.315237933277, 9856.605735770489, 9952.601895924083, 9980.950095249478, 10083.949580252345], "value": 5874.555721066623, "unit": "score"}], "name": "dromaeo_css", "value": 6330.809396386288, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 113.0, 115.0, 115.0, 129.0, 115.0, 115.0, 114.0, 115.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 131.0, 159.0, 177.0, 142.0, 165.0, 161.0, 138.0, 171.0, 132.0], "value": 153.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 165.0, 162.0, 165.0, 168.0, 166.0, 164.0, 166.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 74.0, 73.0, 78.0, 78.0, 140.0, 77.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 142.0, 94.0, 94.0, 95.0, 130.0, 94.0, 95.0, 133.0], "value": 106.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 119.0, 118.0, 119.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 148.0, 150.0, 147.0, 147.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 69.0, 65.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 88.0, 93.0, 95.0, 93.0, 89.0, 86.0, 86.0, 87.0], "value": 89.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 141.0, 144.0, 146.0, 142.0, 150.0, 147.0, 149.0, 149.0, 142.0], "value": 145.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 184.0, 173.0, 172.0, 173.0, 190.0, 170.0, 176.0, 169.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 74.0, 73.0, 73.0, 71.0, 73.0, 73.0, 71.0], "value": 72.5, "unit": "score"}], "name": "kraken", "value": 1597.7000000000003, "alertThreshold": 2.0}]} 18:15:07 INFO - Return code: 0 18:15:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:15:07 ERROR - # TBPL SUCCESS # 18:15:07 INFO - Running post-action listener: _resource_record_post_action 18:15:07 INFO - Running post-run listener: _resource_record_post_run 18:15:08 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 519778304; Read time: 176; Write time: 424388 18:15:08 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 190357504; Read time: 0; Write time: 198656 18:15:08 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 280420352; Read time: 176; Write time: 210944 18:15:08 INFO - Running post-run listener: _upload_blobber_files 18:15:08 INFO - Blob upload gear active. 18:15:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:15:08 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 18:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:15:08 INFO - (blobuploader) - INFO - Open directory for files ... 18:15:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:15:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:15:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:15:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:15:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:15:09 INFO - (blobuploader) - INFO - Done attempting. 18:15:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:15:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:15:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:15:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:15:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:15:10 INFO - (blobuploader) - INFO - Done attempting. 18:15:10 INFO - (blobuploader) - INFO - Iteration through files over. 18:15:10 INFO - Return code: 0 18:15:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:15:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:15:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/635b61a455c89fd106c286b7a85f9c9db3f388d0e65963d90427804415a101eb31f4c5a51269b4677c6f8830b7e388d57caffbdca4e6cfdba13b53aaf59ebe9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/968dade29010993a338f115e4e8c92fd5da9f9c3457f79bca1d9e0fbb833d1248be4eac6e84d4db9321106a086ad186b983272ced01f5173865d7e05c2cba501"} 18:15:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:15:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:15:10 INFO - Contents: 18:15:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/635b61a455c89fd106c286b7a85f9c9db3f388d0e65963d90427804415a101eb31f4c5a51269b4677c6f8830b7e388d57caffbdca4e6cfdba13b53aaf59ebe9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/968dade29010993a338f115e4e8c92fd5da9f9c3457f79bca1d9e0fbb833d1248be4eac6e84d4db9321106a086ad186b983272ced01f5173865d7e05c2cba501"} 18:15:10 INFO - Running post-run listener: copy_logs_to_upload_dir 18:15:10 INFO - Copying logs to upload dir... 18:15:10 INFO - mkdir: /builds/slave/test/build/upload/logs 18:15:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.389623 ========= master_lag: 0.72 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-04-07 18:15:11.306350) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 18:15:11.310628) ========= 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=03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/635b61a455c89fd106c286b7a85f9c9db3f388d0e65963d90427804415a101eb31f4c5a51269b4677c6f8830b7e388d57caffbdca4e6cfdba13b53aaf59ebe9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/968dade29010993a338f115e4e8c92fd5da9f9c3457f79bca1d9e0fbb833d1248be4eac6e84d4db9321106a086ad186b983272ced01f5173865d7e05c2cba501"} build_url:https://queue.taskcluster.net/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011362 build_url: 'https://queue.taskcluster.net/v1/task/IiFI1CL7SNylLjbRUYPhfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/635b61a455c89fd106c286b7a85f9c9db3f388d0e65963d90427804415a101eb31f4c5a51269b4677c6f8830b7e388d57caffbdca4e6cfdba13b53aaf59ebe9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/968dade29010993a338f115e4e8c92fd5da9f9c3457f79bca1d9e0fbb833d1248be4eac6e84d4db9321106a086ad186b983272ced01f5173865d7e05c2cba501"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 18:15:11.335059) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 18:15:11.338401) ========= 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=03627c79f6bb3d1578c4a402000001ba-1460076697.647792-1482578110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 18:15:11.387813) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 18:15:11.388117) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 18:15:11.388688) ========= ========= Total master_lag: 1.03 =========