builder: larch_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1464898752.22 results: success (0) buildid: 20160602120934 builduid: feb8c1a733ac4924ac5ba5efd48c7d79 revision: a9283215c0028b76ec0d2e2689ddc3ad626cb4a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 13:19:12.220409) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 13:19:12.220857) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 13:19:12.221130) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 13:19:12.244096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:19:12.244366) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 13:19:12-- 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% 210M=0s 2016-06-02 13:19:12 (210 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131478 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:19:12.389634) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:19:12.389921) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018902 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:19:12.446622) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 13:19:12.446971) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev a9283215c0028b76ec0d2e2689ddc3ad626cb4a7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev a9283215c0028b76ec0d2e2689ddc3ad626cb4a7 --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=97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 13:19:12,867 truncating revision to first 12 chars 2016-06-02 13:19:12,867 Setting DEBUG logging. 2016-06-02 13:19:12,868 attempt 1/10 2016-06-02 13:19:12,868 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/a9283215c002?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 13:19:13,798 unpacking tar archive at: larch-a9283215c002/testing/mozharness/ program finished with exit code 0 elapsedTime=1.248095 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 13:19:13.717524) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 13:19:13.717813) ========= script_repo_revision: a9283215c0028b76ec0d2e2689ddc3ad626cb4a7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 13:19:13.718176) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 13:19:13.718439) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 13:19:13.726119) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-02 13:19:13.726401) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-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', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-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=97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:19:14 INFO - MultiFileLogger online at 20160602 13:19:14 in /builds/slave/test 13:19:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 13:19:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:19:14 INFO - {'append_to_log': False, 13:19:14 INFO - 'base_work_dir': '/builds/slave/test', 13:19:14 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 13:19:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:19:14 INFO - 'branch': 'Larch-Non-PGO', 13:19:14 INFO - 'buildbot_json_path': 'buildprops.json', 13:19:14 INFO - 'config_files': ('talos/linux_config.py',), 13:19:14 INFO - 'default_actions': ('clobber', 13:19:14 INFO - 'read-buildbot-config', 13:19:14 INFO - 'download-and-extract', 13:19:14 INFO - 'populate-webroot', 13:19:14 INFO - 'create-virtualenv', 13:19:14 INFO - 'install', 13:19:14 INFO - 'run-tests'), 13:19:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:19:14 INFO - 'download_minidump_stackwalk': True, 13:19:14 INFO - 'download_symbols': 'ondemand', 13:19:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:19:14 INFO - 'tooltool.py': '/tools/tooltool.py', 13:19:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:19:14 INFO - '/tools/misc-python/virtualenv.py')}, 13:19:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:19:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:19:14 INFO - 'installer_path': 'installer.exe', 13:19:14 INFO - 'log_level': 'info', 13:19:14 INFO - 'log_name': 'talos', 13:19:14 INFO - 'log_to_console': True, 13:19:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:19:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:19:14 INFO - 'opt_config_files': (), 13:19:14 INFO - 'pip_index': False, 13:19:14 INFO - 'sps_profile': False, 13:19:14 INFO - 'sps_profile_interval': 0, 13:19:14 INFO - 'suite': 'dromaeojs-e10s', 13:19:14 INFO - 'system_bits': '32', 13:19:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:19:14 INFO - 'title': 'talos-linux64-ix-068', 13:19:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:19:14 INFO - 'use_talos_json': True, 13:19:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:19:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:19:14 INFO - 'work_dir': 'build'} 13:19:14 INFO - ##### 13:19:14 INFO - ##### Running clobber step. 13:19:14 INFO - ##### 13:19:14 INFO - Running pre-action listener: _resource_record_pre_action 13:19:14 INFO - Running main action method: clobber 13:19:14 INFO - rmtree: /builds/slave/test/build 13:19:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:19:14 INFO - Running post-action listener: _resource_record_post_action 13:19:14 INFO - ##### 13:19:14 INFO - ##### Finished clobber step (success) 13:19:14 INFO - ##### 13:19:14 INFO - ##### 13:19:14 INFO - ##### Running read-buildbot-config step. 13:19:14 INFO - ##### 13:19:14 INFO - Running pre-action listener: _resource_record_pre_action 13:19:14 INFO - Running main action method: read_buildbot_config 13:19:14 INFO - Using buildbot properties: 13:19:14 INFO - { 13:19:14 INFO - "project": "", 13:19:14 INFO - "product": "firefox", 13:19:14 INFO - "script_repo_revision": "production", 13:19:14 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs-e10s", 13:19:14 INFO - "repository": "", 13:19:14 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs-e10s", 13:19:14 INFO - "buildid": "20160602120934", 13:19:14 INFO - "pgo_build": "False", 13:19:14 INFO - "basedir": "/builds/slave/test", 13:19:14 INFO - "buildnumber": 2, 13:19:14 INFO - "slavename": "talos-linux64-ix-068", 13:19:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:19:14 INFO - "platform": "ubuntu64_hw", 13:19:14 INFO - "scheduler": "tests-larch-linux64-talos", 13:19:14 INFO - "branch": "larch", 13:19:14 INFO - "repo_path": "projects/larch", 13:19:14 INFO - "revision": "a9283215c0028b76ec0d2e2689ddc3ad626cb4a7", 13:19:14 INFO - "stage_platform": "linux64", 13:19:14 INFO - "builduid": "feb8c1a733ac4924ac5ba5efd48c7d79", 13:19:14 INFO - "slavebuilddir": "test" 13:19:14 INFO - } 13:19:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:19:14 INFO - Running post-action listener: _resource_record_post_action 13:19:14 INFO - ##### 13:19:14 INFO - ##### Finished read-buildbot-config step (success) 13:19:14 INFO - ##### 13:19:14 INFO - ##### 13:19:14 INFO - ##### Running download-and-extract step. 13:19:14 INFO - ##### 13:19:14 INFO - Running pre-action listener: _resource_record_pre_action 13:19:14 INFO - Running main action method: download_and_extract 13:19:14 INFO - mkdir: /builds/slave/test/build/tests 13:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:14 INFO - https://queue.taskcluster.net/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:19:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:19:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:19:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:19:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:19:26 INFO - Downloaded 1361 bytes. 13:19:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:19:26 INFO - Using the following test package requirements: 13:19:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:19:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:19:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:19:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:19:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:19:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:19:26 INFO - u'jsshell-linux-x86_64.zip'], 13:19:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:19:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:19:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:19:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:19:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:19:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:19:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:19:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:19:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:19:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:19:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:19:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:26 INFO - https://queue.taskcluster.net/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:19:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:19:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:19:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:19:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:19:29 INFO - Downloaded 22850307 bytes. 13:19:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:19:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:19:30 INFO - Return code: 0 13:19:30 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:19:30 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')]} 13:19:30 INFO - https://queue.taskcluster.net/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:19:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:19:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:19:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:19:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:19:36 INFO - Downloaded 22850307 bytes. 13:19:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:19:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:19:37 INFO - Return code: 0 13:19:37 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')]} 13:19:37 INFO - https://queue.taskcluster.net/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:19:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:19:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:19:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:19:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:19:38 INFO - Downloaded 10834063 bytes. 13:19:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:19:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:19:38 INFO - Return code: 0 13:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:38 INFO - https://queue.taskcluster.net/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:19:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:19:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:19:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:19:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:19:40 INFO - Downloaded 55179926 bytes. 13:19:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:19:40 INFO - mkdir: /builds/slave/test/properties 13:19:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:19:40 INFO - Writing to file /builds/slave/test/properties/build_url 13:19:40 INFO - Contents: 13:19:40 INFO - build_url:https://queue.taskcluster.net/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:19:40 INFO - Running post-action listener: _resource_record_post_action 13:19:40 INFO - Running post-action listener: set_extra_try_arguments 13:19:40 INFO - ##### 13:19:40 INFO - ##### Finished download-and-extract step (success) 13:19:40 INFO - ##### 13:19:40 INFO - ##### 13:19:40 INFO - ##### Running populate-webroot step. 13:19:40 INFO - ##### 13:19:40 INFO - Running pre-action listener: _resource_record_pre_action 13:19:40 INFO - Running main action method: populate_webroot 13:19:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:19:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:19:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:19:40 INFO - '--tppagecycles', 13:19:40 INFO - '7'], 13:19:40 INFO - 'tests': ['tsvgm']}}, 13:19:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:19:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:19:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:19:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:19:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:19:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:19:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:40 INFO - 'talos_options': ['--disable-e10s'], 13:19:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:19:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:19:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:40 INFO - 'talos_options': ['--disable-e10s'], 13:19:40 INFO - 'tests': ['damp', 'tps']}, 13:19:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:40 INFO - 'tests': ['damp', 'tps']}, 13:19:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:19:40 INFO - 'tests': ['dromaeo_dom']}, 13:19:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:19:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:19:40 INFO - 'tests': ['a11yr', 13:19:40 INFO - 'ts_paint', 13:19:40 INFO - 'tpaint', 13:19:40 INFO - 'sessionrestore', 13:19:40 INFO - 'sessionrestore_no_auto_restore', 13:19:40 INFO - 'tabpaint']}, 13:19:40 INFO - 'other-e10s': {'tests': ['a11yr', 13:19:40 INFO - 'ts_paint', 13:19:40 INFO - 'tpaint', 13:19:40 INFO - 'sessionrestore', 13:19:40 INFO - 'sessionrestore_no_auto_restore', 13:19:40 INFO - 'tabpaint']}, 13:19:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:19:40 INFO - 'ts_paint', 13:19:40 INFO - 'tpaint', 13:19:40 INFO - 'sessionrestore', 13:19:40 INFO - 'sessionrestore_no_auto_restore', 13:19:40 INFO - 'tabpaint']}, 13:19:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:19:40 INFO - 'ts_paint', 13:19:40 INFO - 'tpaint', 13:19:40 INFO - 'sessionrestore', 13:19:40 INFO - 'sessionrestore_no_auto_restore', 13:19:40 INFO - 'tabpaint']}, 13:19:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:19:40 INFO - 'tests': ['a11yr', 13:19:40 INFO - 'ts_paint', 13:19:40 INFO - 'tpaint', 13:19:40 INFO - 'sessionrestore', 13:19:40 INFO - 'sessionrestore_no_auto_restore', 13:19:40 INFO - 'tabpaint']}, 13:19:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:19:40 INFO - 'tests': ['a11yr', 13:19:40 INFO - 'ts_paint', 13:19:40 INFO - 'tpaint', 13:19:40 INFO - 'sessionrestore', 13:19:40 INFO - 'sessionrestore_no_auto_restore', 13:19:40 INFO - 'tabpaint']}, 13:19:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:19:40 INFO - 'tests': ['tsvgx', 13:19:40 INFO - 'tsvgr_opacity', 13:19:40 INFO - 'tart', 13:19:40 INFO - 'tscrollx', 13:19:40 INFO - 'cart']}, 13:19:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:19:40 INFO - 'tsvgr_opacity', 13:19:40 INFO - 'tart', 13:19:40 INFO - 'tscrollx', 13:19:40 INFO - 'cart']}, 13:19:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:40 INFO - 'talos_options': ['--disable-e10s'], 13:19:40 INFO - 'tests': ['tp5o']}, 13:19:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:40 INFO - 'tests': ['tp5o']}, 13:19:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:40 INFO - 'talos_options': ['--disable-e10s', 13:19:40 INFO - '--xperf_path', 13:19:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:19:40 INFO - 'tests': ['tp5n']}, 13:19:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:40 INFO - 'talos_options': ['--xperf_path', 13:19:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:19:40 INFO - 'tests': ['tp5n']}}, 13:19:40 INFO - 'talos.zip': {'path': '', 13:19:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:19:40 INFO - Running post-action listener: _resource_record_post_action 13:19:40 INFO - ##### 13:19:40 INFO - ##### Finished populate-webroot step (success) 13:19:40 INFO - ##### 13:19:40 INFO - ##### 13:19:40 INFO - ##### Running create-virtualenv step. 13:19:40 INFO - ##### 13:19:40 INFO - Running pre-action listener: _resource_record_pre_action 13:19:40 INFO - Running main action method: create_virtualenv 13:19:40 INFO - Creating virtualenv /builds/slave/test/build/venv 13:19:40 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 13:19:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:19:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:19:41 INFO - Using real prefix '/usr' 13:19:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:19:41 INFO - Installing distribute.............................................................................................................................................................................................done. 13:19:43 INFO - Installing pip.................done. 13:19:43 INFO - Return code: 0 13:19:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:19: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')]} 13:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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')]} 13:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:43 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 0x7ff37d17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8a9c0>, '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 0xd8b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8bd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', '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 13:19:43 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 13:19:43 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 13:19:43 INFO - Using env: {'DISPLAY': ':0', 13:19:43 INFO - 'HOME': '/home/cltbld', 13:19:43 INFO - 'LANG': 'en_US.UTF-8', 13:19:43 INFO - 'LANGUAGE': 'en_US:en', 13:19:43 INFO - 'LOGNAME': 'cltbld', 13:19:43 INFO - 'MAIL': '/var/mail/cltbld', 13:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:43 INFO - 'MOZ_NO_REMOTE': '1', 13:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:43 INFO - 'NO_EM_RESTART': '1', 13:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:43 INFO - 'PWD': '/builds/slave/test', 13:19:43 INFO - 'SHELL': '/bin/bash', 13:19:43 INFO - 'SHLVL': '1', 13:19:43 INFO - 'TERM': 'linux', 13:19:43 INFO - 'TMOUT': '86400', 13:19:43 INFO - 'USER': 'cltbld', 13:19:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', 13:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:43 INFO - '_': '/tools/buildbot/bin/python'} 13:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:43 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 13:19:43 INFO - Cleaning up... 13:19:43 INFO - Return code: 0 13:19:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:19: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')]} 13:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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')]} 13:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff37d17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8a9c0>, '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 0xd8b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8bd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', '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 13:19:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:19:43 INFO - Using env: {'DISPLAY': ':0', 13:19:43 INFO - 'HOME': '/home/cltbld', 13:19:43 INFO - 'LANG': 'en_US.UTF-8', 13:19:43 INFO - 'LANGUAGE': 'en_US:en', 13:19:43 INFO - 'LOGNAME': 'cltbld', 13:19:43 INFO - 'MAIL': '/var/mail/cltbld', 13:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:43 INFO - 'MOZ_NO_REMOTE': '1', 13:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:43 INFO - 'NO_EM_RESTART': '1', 13:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:43 INFO - 'PWD': '/builds/slave/test', 13:19:43 INFO - 'SHELL': '/bin/bash', 13:19:43 INFO - 'SHLVL': '1', 13:19:43 INFO - 'TERM': 'linux', 13:19:43 INFO - 'TMOUT': '86400', 13:19:43 INFO - 'USER': 'cltbld', 13:19:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', 13:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:43 INFO - '_': '/tools/buildbot/bin/python'} 13:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:43 INFO - Downloading/unpacking psutil>=3.1.1 13:19:43 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 13:19:43 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 13:19:43 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 13:19:43 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 13:19:43 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 13:19:43 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 13:19:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:19:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:19:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:19:45 INFO - Installing collected packages: psutil 13:19:45 INFO - Running setup.py install for psutil 13:19:45 INFO - building 'psutil._psutil_linux' extension 13:19:45 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 13:19:46 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 13:19:46 INFO - building 'psutil._psutil_posix' extension 13:19:46 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 13:19:46 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 13:19:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:19:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:19:46 INFO - Successfully installed psutil 13:19:46 INFO - Cleaning up... 13:19:46 INFO - Return code: 0 13:19:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:19:46 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')]} 13:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:46 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')]} 13:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff37d17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8a9c0>, '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 0xd8b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8bd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', '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 13:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:19:46 INFO - Using env: {'DISPLAY': ':0', 13:19:46 INFO - 'HOME': '/home/cltbld', 13:19:46 INFO - 'LANG': 'en_US.UTF-8', 13:19:46 INFO - 'LANGUAGE': 'en_US:en', 13:19:46 INFO - 'LOGNAME': 'cltbld', 13:19:46 INFO - 'MAIL': '/var/mail/cltbld', 13:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:46 INFO - 'MOZ_NO_REMOTE': '1', 13:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:46 INFO - 'NO_EM_RESTART': '1', 13:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:46 INFO - 'PWD': '/builds/slave/test', 13:19:46 INFO - 'SHELL': '/bin/bash', 13:19:46 INFO - 'SHLVL': '1', 13:19:46 INFO - 'TERM': 'linux', 13:19:46 INFO - 'TMOUT': '86400', 13:19:46 INFO - 'USER': 'cltbld', 13:19:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', 13:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:46 INFO - '_': '/tools/buildbot/bin/python'} 13:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:19:48 INFO - Installing collected packages: mozsystemmonitor 13:19:48 INFO - Running setup.py install for mozsystemmonitor 13:19:48 INFO - Successfully installed mozsystemmonitor 13:19:48 INFO - Cleaning up... 13:19:48 INFO - Return code: 0 13:19:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:48 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 0x7ff37d17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8a9c0>, '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 0xd8b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8bd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', '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 13:19:48 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 13:19:48 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 13:19:48 INFO - Using env: {'DISPLAY': ':0', 13:19:48 INFO - 'HOME': '/home/cltbld', 13:19:48 INFO - 'LANG': 'en_US.UTF-8', 13:19:48 INFO - 'LANGUAGE': 'en_US:en', 13:19:48 INFO - 'LOGNAME': 'cltbld', 13:19:48 INFO - 'MAIL': '/var/mail/cltbld', 13:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:48 INFO - 'MOZ_NO_REMOTE': '1', 13:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:48 INFO - 'NO_EM_RESTART': '1', 13:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:48 INFO - 'PWD': '/builds/slave/test', 13:19:48 INFO - 'SHELL': '/bin/bash', 13:19:48 INFO - 'SHLVL': '1', 13:19:48 INFO - 'TERM': 'linux', 13:19:48 INFO - 'TMOUT': '86400', 13:19:48 INFO - 'USER': 'cltbld', 13:19:48 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', 13:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:48 INFO - '_': '/tools/buildbot/bin/python'} 13:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:48 INFO - Downloading/unpacking blobuploader==1.2.4 13:19:48 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 13:19:48 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 13:19:48 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 13:19:48 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 13:19:48 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 13:19:48 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 13:19:50 INFO - Downloading blobuploader-1.2.4.tar.gz 13:19:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:19:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:19:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:51 INFO - Downloading docopt-0.6.1.tar.gz 13:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:19:51 INFO - Installing collected packages: blobuploader, requests, docopt 13:19:51 INFO - Running setup.py install for blobuploader 13:19:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:19:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:19:51 INFO - Running setup.py install for requests 13:19:52 INFO - Running setup.py install for docopt 13:19:52 INFO - Successfully installed blobuploader requests docopt 13:19:52 INFO - Cleaning up... 13:19:52 INFO - Return code: 0 13:19:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:52 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')]} 13:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:52 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')]} 13:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:52 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 0x7ff37d17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8a9c0>, '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 0xd8b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8bd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', '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 13:19:52 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 13:19:52 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 13:19:52 INFO - Using env: {'DISPLAY': ':0', 13:19:52 INFO - 'HOME': '/home/cltbld', 13:19:52 INFO - 'LANG': 'en_US.UTF-8', 13:19:52 INFO - 'LANGUAGE': 'en_US:en', 13:19:52 INFO - 'LOGNAME': 'cltbld', 13:19:52 INFO - 'MAIL': '/var/mail/cltbld', 13:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:52 INFO - 'MOZ_NO_REMOTE': '1', 13:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:52 INFO - 'NO_EM_RESTART': '1', 13:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:52 INFO - 'PWD': '/builds/slave/test', 13:19:52 INFO - 'SHELL': '/bin/bash', 13:19:52 INFO - 'SHLVL': '1', 13:19:52 INFO - 'TERM': 'linux', 13:19:52 INFO - 'TMOUT': '86400', 13:19:52 INFO - 'USER': 'cltbld', 13:19:52 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', 13:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:52 INFO - '_': '/tools/buildbot/bin/python'} 13:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:19:52 INFO - Running setup.py (path:/tmp/pip-oW1UhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:19:52 INFO - Running setup.py (path:/tmp/pip-Rk6MLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:19:52 INFO - Running setup.py (path:/tmp/pip-g0PkrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:19:52 INFO - Running setup.py (path:/tmp/pip-pnw9i6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:19:52 INFO - Running setup.py (path:/tmp/pip-bVtxbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:19:52 INFO - Running setup.py (path:/tmp/pip-h3lBZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:19:52 INFO - Running setup.py (path:/tmp/pip-SkZICo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:19:52 INFO - Running setup.py (path:/tmp/pip-68G6oN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:19:52 INFO - Running setup.py (path:/tmp/pip-yuiMue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:19:53 INFO - Running setup.py (path:/tmp/pip-_vlPvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:19:53 INFO - Running setup.py (path:/tmp/pip-ESLuiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:19:53 INFO - Running setup.py (path:/tmp/pip-oldZuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:19:53 INFO - Running setup.py (path:/tmp/pip-auFedM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:19:53 INFO - Running setup.py (path:/tmp/pip-ioP0fO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:53 INFO - Running setup.py (path:/tmp/pip-OHg7wI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:19:53 INFO - Running setup.py (path:/tmp/pip-MNdr5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:19:53 INFO - Running setup.py (path:/tmp/pip-PxrWab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:19:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:19:53 INFO - Running setup.py install for manifestparser 13:19:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:19:53 INFO - Running setup.py install for mozcrash 13:19:53 INFO - Running setup.py install for mozdebug 13:19:53 INFO - Running setup.py install for mozdevice 13:19:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:19:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:19:54 INFO - Running setup.py install for mozfile 13:19:54 INFO - Running setup.py install for mozhttpd 13:19:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:19:54 INFO - Running setup.py install for mozinfo 13:19:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:19:54 INFO - Running setup.py install for mozInstall 13:19:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:19:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:19:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:19:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:19:54 INFO - Running setup.py install for mozleak 13:19:54 INFO - Running setup.py install for mozlog 13:19:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:19:54 INFO - Running setup.py install for moznetwork 13:19:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:19:54 INFO - Running setup.py install for mozprocess 13:19:54 INFO - Running setup.py install for mozprofile 13:19:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:19:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:19:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:19:55 INFO - Running setup.py install for mozrunner 13:19:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:19:55 INFO - Running setup.py install for mozscreenshot 13:19:55 INFO - Running setup.py install for moztest 13:19:55 INFO - Running setup.py install for mozversion 13:19:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:19:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:19:55 INFO - Cleaning up... 13:19:55 INFO - Return code: 0 13:19:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19: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')]} 13:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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')]} 13:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:55 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 0x7ff37d17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8a9c0>, '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 0xd8b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8bd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', '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 13:19:55 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 13:19:55 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 13:19:55 INFO - Using env: {'DISPLAY': ':0', 13:19:55 INFO - 'HOME': '/home/cltbld', 13:19:55 INFO - 'LANG': 'en_US.UTF-8', 13:19:55 INFO - 'LANGUAGE': 'en_US:en', 13:19:55 INFO - 'LOGNAME': 'cltbld', 13:19:55 INFO - 'MAIL': '/var/mail/cltbld', 13:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:55 INFO - 'MOZ_NO_REMOTE': '1', 13:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:55 INFO - 'NO_EM_RESTART': '1', 13:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:55 INFO - 'PWD': '/builds/slave/test', 13:19:55 INFO - 'SHELL': '/bin/bash', 13:19:55 INFO - 'SHLVL': '1', 13:19:55 INFO - 'TERM': 'linux', 13:19:55 INFO - 'TMOUT': '86400', 13:19:55 INFO - 'USER': 'cltbld', 13:19:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', 13:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:55 INFO - '_': '/tools/buildbot/bin/python'} 13:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:19:55 INFO - Running setup.py (path:/tmp/pip-0NXY_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:19:55 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)) 13:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:19:55 INFO - Running setup.py (path:/tmp/pip-3LnkwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:19:55 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)) 13:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:19:55 INFO - Running setup.py (path:/tmp/pip-3qf9nM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:19:55 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)) 13:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:19:55 INFO - Running setup.py (path:/tmp/pip-mz9JRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:19:55 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)) 13:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:19:55 INFO - Running setup.py (path:/tmp/pip-JEYIKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:19:56 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)) 13:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:19:56 INFO - Running setup.py (path:/tmp/pip-RQEuxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:19:56 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)) 13:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:19:56 INFO - Running setup.py (path:/tmp/pip-WFZqwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:19:56 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)) 13:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:19:56 INFO - Running setup.py (path:/tmp/pip-EOAFjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:19:56 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)) 13:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:19:56 INFO - Running setup.py (path:/tmp/pip-ukwfhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:19:56 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)) 13:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:19:56 INFO - Running setup.py (path:/tmp/pip-cRsNDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:19:56 INFO - Running setup.py (path:/tmp/pip-DYmqeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:19:56 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)) 13:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:19:56 INFO - Running setup.py (path:/tmp/pip-OCXRMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:19:56 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)) 13:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:19:56 INFO - Running setup.py (path:/tmp/pip-VUjYuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:19:56 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)) 13:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:19:56 INFO - Running setup.py (path:/tmp/pip-prMsxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:19:56 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)) 13:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:56 INFO - Running setup.py (path:/tmp/pip-3KihFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:56 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)) 13:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:19:56 INFO - Running setup.py (path:/tmp/pip-p6UsaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:19:56 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)) 13:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:19:56 INFO - Running setup.py (path:/tmp/pip-ByXfoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:19:56 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)) 13:19:56 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)) 13:19:56 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)) 13:19:56 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)) 13:19:56 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)) 13:19:56 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)) 13:19:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:58 INFO - Downloading blessings-1.6.tar.gz 13:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:19:58 INFO - Installing collected packages: blessings 13:19:58 INFO - Running setup.py install for blessings 13:19:58 INFO - Successfully installed blessings 13:19:58 INFO - Cleaning up... 13:19:58 INFO - Return code: 0 13:19:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:19:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:19:59 INFO - Reading from file tmpfile_stdout 13:19:59 INFO - Current package versions: 13:19:59 INFO - argparse == 1.2.1 13:19:59 INFO - blessings == 1.6 13:19:59 INFO - blobuploader == 1.2.4 13:19:59 INFO - docopt == 0.6.1 13:19:59 INFO - manifestparser == 1.1 13:19:59 INFO - mozInstall == 1.12 13:19:59 INFO - mozcrash == 0.17 13:19:59 INFO - mozdebug == 0.1 13:19:59 INFO - mozdevice == 0.48 13:19:59 INFO - mozfile == 1.2 13:19:59 INFO - mozhttpd == 0.7 13:19:59 INFO - mozinfo == 0.9 13:19:59 INFO - mozleak == 0.1 13:19:59 INFO - mozlog == 3.2 13:19:59 INFO - moznetwork == 0.27 13:19:59 INFO - mozprocess == 0.22 13:19:59 INFO - mozprofile == 0.28 13:19:59 INFO - mozrunner == 6.11 13:19:59 INFO - mozscreenshot == 0.1 13:19:59 INFO - mozsystemmonitor == 0.3 13:19:59 INFO - moztest == 0.7 13:19:59 INFO - mozversion == 1.4 13:19:59 INFO - psutil == 3.1.1 13:19:59 INFO - requests == 1.2.3 13:19:59 INFO - wsgiref == 0.1.2 13:19:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:59 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 0x7ff37d17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8a9c0>, '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 0xd8b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8bd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', '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 13:19:59 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 13:19:59 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 13:19:59 INFO - Using env: {'DISPLAY': ':0', 13:19:59 INFO - 'HOME': '/home/cltbld', 13:19:59 INFO - 'LANG': 'en_US.UTF-8', 13:19:59 INFO - 'LANGUAGE': 'en_US:en', 13:19:59 INFO - 'LOGNAME': 'cltbld', 13:19:59 INFO - 'MAIL': '/var/mail/cltbld', 13:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:59 INFO - 'MOZ_NO_REMOTE': '1', 13:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:59 INFO - 'NO_EM_RESTART': '1', 13:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:59 INFO - 'PWD': '/builds/slave/test', 13:19:59 INFO - 'SHELL': '/bin/bash', 13:19:59 INFO - 'SHLVL': '1', 13:19:59 INFO - 'TERM': 'linux', 13:19:59 INFO - 'TMOUT': '86400', 13:19:59 INFO - 'USER': 'cltbld', 13:19:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', 13:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:59 INFO - '_': '/tools/buildbot/bin/python'} 13:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:59 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)) 13:19:59 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)) 13:19:59 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)) 13:19:59 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)) 13:19:59 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)) 13:19:59 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)) 13:19:59 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)) 13:19:59 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)) 13:19:59 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)) 13:19:59 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)) 13:19:59 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)) 13:19:59 INFO - Cleaning up... 13:19:59 INFO - Return code: 0 13:19:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff37d17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8a9c0>, '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 0xd8b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8bd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', '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 13:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:19:59 INFO - Using env: {'DISPLAY': ':0', 13:19:59 INFO - 'HOME': '/home/cltbld', 13:19:59 INFO - 'LANG': 'en_US.UTF-8', 13:19:59 INFO - 'LANGUAGE': 'en_US:en', 13:19:59 INFO - 'LOGNAME': 'cltbld', 13:19:59 INFO - 'MAIL': '/var/mail/cltbld', 13:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:59 INFO - 'MOZ_NO_REMOTE': '1', 13:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:59 INFO - 'NO_EM_RESTART': '1', 13:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:59 INFO - 'PWD': '/builds/slave/test', 13:19:59 INFO - 'SHELL': '/bin/bash', 13:19:59 INFO - 'SHLVL': '1', 13:19:59 INFO - 'TERM': 'linux', 13:19:59 INFO - 'TMOUT': '86400', 13:19:59 INFO - 'USER': 'cltbld', 13:19:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', 13:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:59 INFO - '_': '/tools/buildbot/bin/python'} 13:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:59 INFO - Downloading/unpacking jsonschema 13:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:20:01 INFO - Downloading/unpacking functools32 (from jsonschema) 13:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:01 INFO - Downloading functools32-3.2.3-2.tar.gz 13:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:20:01 INFO - warning: no files found matching '*.txt' 13:20:01 INFO - no previously-included directories found matching 'build' 13:20:01 INFO - no previously-included directories found matching 'dist' 13:20:01 INFO - no previously-included directories found matching '.git*' 13:20:01 INFO - Installing collected packages: jsonschema, functools32 13:20:01 INFO - Running setup.py install for functools32 13:20:01 INFO - warning: no files found matching '*.txt' 13:20:01 INFO - no previously-included directories found matching 'build' 13:20:01 INFO - no previously-included directories found matching 'dist' 13:20:01 INFO - no previously-included directories found matching '.git*' 13:20:01 INFO - Successfully installed jsonschema functools32 13:20:01 INFO - Cleaning up... 13:20:02 INFO - Return code: 0 13:20:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:20: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')]} 13:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20: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')]} 13:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:02 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 0x7ff37d17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8a9c0>, '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 0xd8b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8bd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', '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 13:20:02 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 13:20:02 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 13:20:02 INFO - Using env: {'DISPLAY': ':0', 13:20:02 INFO - 'HOME': '/home/cltbld', 13:20:02 INFO - 'LANG': 'en_US.UTF-8', 13:20:02 INFO - 'LANGUAGE': 'en_US:en', 13:20:02 INFO - 'LOGNAME': 'cltbld', 13:20:02 INFO - 'MAIL': '/var/mail/cltbld', 13:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:02 INFO - 'MOZ_NO_REMOTE': '1', 13:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:02 INFO - 'NO_EM_RESTART': '1', 13:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:02 INFO - 'PWD': '/builds/slave/test', 13:20:02 INFO - 'SHELL': '/bin/bash', 13:20:02 INFO - 'SHLVL': '1', 13:20:02 INFO - 'TERM': 'linux', 13:20:02 INFO - 'TMOUT': '86400', 13:20:02 INFO - 'USER': 'cltbld', 13:20:02 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', 13:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:02 INFO - '_': '/tools/buildbot/bin/python'} 13:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:02 INFO - Downloading/unpacking flake8 13:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:20:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:20:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:20:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:20:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:20:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:20:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:20:04 INFO - no previously-included directories found matching 'docs/_build' 13:20:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:20:04 INFO - Running setup.py install for pep8 13:20:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:20:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:20:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:20:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:20:05 INFO - no previously-included directories found matching 'docs/_build' 13:20:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:20:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:20:05 INFO - Cleaning up... 13:20:05 INFO - Return code: 0 13:20:05 INFO - Running post-action listener: _resource_record_post_action 13:20:05 INFO - Running post-action listener: _start_resource_monitoring 13:20:05 INFO - Starting resource monitoring. 13:20:05 INFO - ##### 13:20:05 INFO - ##### Finished create-virtualenv step (success) 13:20:05 INFO - ##### 13:20:05 INFO - ##### 13:20:05 INFO - ##### Running install step. 13:20:05 INFO - ##### 13:20:05 INFO - Running pre-action listener: _resource_record_pre_action 13:20:05 INFO - Running main action method: install 13:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:20:05 INFO - Reading from file tmpfile_stdout 13:20:05 INFO - Detecting whether we're running mozinstall >=1.0... 13:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:20:05 INFO - Reading from file tmpfile_stdout 13:20:05 INFO - Output received: 13:20:05 INFO - Usage: mozinstall [options] installer 13:20:05 INFO - Options: 13:20:05 INFO - -h, --help show this help message and exit 13:20:05 INFO - -d DEST, --destination=DEST 13:20:05 INFO - Directory to install application into. [default: 13:20:05 INFO - "/builds/slave/test"] 13:20:05 INFO - --app=APP Application being installed. [default: firefox] 13:20:05 INFO - mkdir: /builds/slave/test/build/application 13:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:20:21 INFO - Reading from file tmpfile_stdout 13:20:21 INFO - Output received: 13:20:21 INFO - /builds/slave/test/build/application/firefox/firefox 13:20:21 INFO - Running post-action listener: _resource_record_post_action 13:20:21 INFO - ##### 13:20:21 INFO - ##### Finished install step (success) 13:20:21 INFO - ##### 13:20:21 INFO - ##### 13:20:21 INFO - ##### Running run-tests step. 13:20:21 INFO - ##### 13:20:21 INFO - Running pre-action listener: _resource_record_pre_action 13:20:21 INFO - Running main action method: run_tests 13:20:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:20:21 INFO - Python 2.7.3 13:20:21 INFO - Return code: 0 13:20:21 INFO - grabbing minidump binary from tooltool 13:20:21 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')]} 13:20:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8a9c0>, '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 0xd8b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8bd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:20:21 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 13:20:21 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 13:20:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:20:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:20:21 INFO - Return code: 0 13:20:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:20:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:20:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:20:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:20:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:20:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:20:22 INFO - Return code: 0 13:20:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 13:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 13:20:22 INFO - Using env: {'DISPLAY': ':0', 13:20:22 INFO - 'HOME': '/home/cltbld', 13:20:22 INFO - 'LANG': 'en_US.UTF-8', 13:20:22 INFO - 'LANGUAGE': 'en_US:en', 13:20:22 INFO - 'LOGNAME': 'cltbld', 13:20:22 INFO - 'MAIL': '/var/mail/cltbld', 13:20:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:20:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:22 INFO - 'MOZ_NO_REMOTE': '1', 13:20:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:22 INFO - 'NO_EM_RESTART': '1', 13:20:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:22 INFO - 'PWD': '/builds/slave/test', 13:20:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:20:22 INFO - 'SHELL': '/bin/bash', 13:20:22 INFO - 'SHLVL': '1', 13:20:22 INFO - 'TERM': 'linux', 13:20:22 INFO - 'TMOUT': '86400', 13:20:22 INFO - 'USER': 'cltbld', 13:20:22 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045', 13:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:22 INFO - '_': '/tools/buildbot/bin/python'} 13:20:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 13:20:22 INFO - mozversion application_buildid: 20160602120934 13:20:22 INFO - mozversion application_changeset: a9283215c0028b76ec0d2e2689ddc3ad626cb4a7 13:20:22 INFO - mozversion application_display_name: Nightly 13:20:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:20:22 INFO - mozversion application_name: Firefox 13:20:22 INFO - mozversion application_remotingname: firefox 13:20:22 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 13:20:22 INFO - mozversion application_vendor: Mozilla 13:20:22 INFO - mozversion application_version: 49.0a1 13:20:22 INFO - mozversion platform_buildid: 20160602120934 13:20:22 INFO - mozversion platform_changeset: a9283215c0028b76ec0d2e2689ddc3ad626cb4a7 13:20:22 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 13:20:22 INFO - mozversion platform_version: 49.0a1 13:20:22 INFO - using testdate: 1464898822 13:20:22 INFO - actual date: 1464898822 13:20:22 INFO - starting webserver on 'localhost:59000' 13:20:22 INFO - SUITE-START | Running 2 tests 13:20:22 INFO - TEST-START | dromaeo_css 13:20:22 INFO - operating with platform_type : linux_ 13:20:22 INFO - Initialising browser for dromaeo_css test... 13:20:22 INFO - TEST-INFO | started process 8252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGo6_6z/profile http://localhost:59000/getInfo.html) 13:20:27 INFO - PROCESS | 8252 | __metrics Screen width/height:1600/1200 13:20:27 INFO - PROCESS | 8252 | colorDepth:24 13:20:27 INFO - PROCESS | 8252 | Browser inner width/height: 1024/697 13:20:27 INFO - PROCESS | 8252 | __metrics 13:20:28 ERROR - PROCESS | 8252 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 13:20:29 INFO - TEST-INFO | 8252: exit 0 13:20:29 INFO - Browser initialized. 13:20:29 INFO - Running cycle 1/1 for dromaeo_css test... 13:20:29 INFO - TEST-INFO | started process 8371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGo6_6z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:20:41 INFO - PROCESS | 8371 | RSS: Main: 168427520 13:20:41 INFO - PROCESS | 8371 | 13:21:30 INFO - PROCESS | 8371 | 1464898890814 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] 13:23:41 INFO - PROCESS | 8371 | Cycle 1(1): loaded http://localhost:59000/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59000/tests/dromaeo/cssquery-ext.html) 13:23:42 INFO - PROCESS | 8371 | RSS: Main: 171171840 13:23:42 INFO - PROCESS | 8371 | 13:26:44 INFO - PROCESS | 8371 | Cycle 1(1): loaded http://localhost:59000/tests/dromaeo/cssquery-ext.html (next: http://localhost:59000/tests/dromaeo/cssquery-jquery.html) 13:26:45 INFO - PROCESS | 8371 | RSS: Main: 170258432 13:26:45 INFO - PROCESS | 8371 | 13:29:47 INFO - PROCESS | 8371 | Cycle 1(1): loaded http://localhost:59000/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59000/tests/dromaeo/cssquery-mootools.html) 13:29:48 INFO - PROCESS | 8371 | RSS: Main: 171298816 13:29:48 INFO - PROCESS | 8371 | 13:32:50 INFO - PROCESS | 8371 | Cycle 1(1): loaded http://localhost:59000/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59000/tests/dromaeo/cssquery-prototype.html) 13:32:50 INFO - PROCESS | 8371 | RSS: Main: 168861696 13:32:50 INFO - PROCESS | 8371 | 13:35:53 INFO - PROCESS | 8371 | Cycle 1(1): loaded http://localhost:59000/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59000/tests/dromaeo/cssquery-yui.html) 13:35:54 INFO - PROCESS | 8371 | RSS: Main: 171053056 13:35:54 INFO - PROCESS | 8371 | 13:38:56 INFO - PROCESS | 8371 | Cycle 1(1): loaded http://localhost:59000/tests/dromaeo/cssquery-yui.html (next: http://localhost:59000/tests/dromaeo/cssquery-dojo.html) 13:38:56 INFO - PROCESS | 8371 | RSS: Main: 172027904 13:38:56 INFO - PROCESS | 8371 | 13:38:56 INFO - PROCESS | 8371 | __start_tp_report 13:38:56 INFO - PROCESS | 8371 | _x_x_mozilla_page_load 13:38:56 INFO - PROCESS | 8371 | _x_x_mozilla_page_load_details 13:38:56 INFO - PROCESS | 8371 | |i|pagename|runs| 13:38:56 INFO - PROCESS | 8371 | |0;dojo.html;2594.5459544579708;2601.9739802601975;2604.4791041791636;2616.856072915989;2617.2410001099684;4456.777161141946;4566.497685254623;4574.7255164690105;4613.515580864003;4628.745419001953;4529.048899731052;4614.307853821929;4630.583247507724;4684.906301873961;4716;4267.231898258305;4359.411479450281;4377.387165796791;4381.3208952612395;4410.09593033429;544.4623578975581;4321.697481176319;4363.759993200372;4419.580139886722;4443.400140980959;4317.309230523133;4327.5239723630375;4329.523752387235;4366.366876802877;4368.213721530124;4272.786360681954;4277.572242775728;4321.416608757809;4329.5453977332245;4371.060222052274;4266.402703621496;4273.743575385487;4322.697411181219;4343.19650864591;4360.585744354281;4677.275022371504;4683.906321873577;4689.95310046902;4713.269443236304;4728.4798672146035;5043.36957880265;5123.436421993578;5146.253793200002;5148.691078535262;5149.6910185389;5170.121079416471;5170.767315470813;5180.222966555009;5184.27420161174;5194.662346947474;4694.0611877624615;4698.741569213692;4716.268978308368;4718.4337879454;4748.9525104748855;5091.261767043758;5152.562032227228;5212.609054320941;5233.110371236899;5236.136037553761;4991.226359914146;5014.623903207274;5022.84931452057;5035;5068.847934561969;5091.465396133427;5102.948970510248;5119.87200319995;5127;5127.948720512822;4858.97961428097;5000.524950129732;5047.268146118866;5053.267276244997;5068.189089745623;4837.201861692852;4996.2505624156665;5009.774560144802;5021.824236151717;5071.2139618359215;4295.269804133305;4315.029118448324;4332.523422423531;4376.846810361686;4380.189664912002;3673.8897833064516;3715.2198038412234;3746;3763.5483741950593;3769.321522125989;4392.253316936129;4408.096340250241;4419.160359531678;4451.465824101128;4457.264551349056;5077.695338279715;5097.643164978416;5101;5114.43741188469;5133.383993920754;4400.625946794495;4414.404055452537;4424.491183513873;4454.331850222427;4458.888527786767;4575.359449677047;4576.496585375606;4591.219492686185;4606.677532572688;4656.511066338054;4707.199776038082;4743.217369134054;4749.715017098985;4836.951630483721;4857.077155340474;5047.066292735855;5048.167052436307;5049.065922804146;5049.141645920129;5051.62112841531;4743.667943244078;4754.500777418321;4759.357486739246;4759.452662943667;4798.376211092535;4895.241237608177;5003.924941125813;5026.070177017264;5072.061668591323;5084.694918304914;5137.897242055213;5140.511651393112;5143.948560514496;5152.845414637567;5226.63413561047;4826.276058591239;4989.201727723546;4992.750362481934;4994.350734404504;5000.724960127228;4862.343583616166;4885.218365061573;4919.3604831371695;4926.310316555757;4942.8022879085875;4726.952730472652;4827.08285425782;4842.031593681349;4873.147199240189;4896.167651499325;4821.421429428491;4991.051700176955;4996.000799840119;5011.148104822262;5042.042012017705;4835.8065677372515;4857.6599638025;4901.58336541398;4915.705057696549;4925.1873440881855 13:38:56 INFO - PROCESS | 8371 | |1;ext.html;552.8734610865939;585.7715490958526;597.9790707325242;599.8620317327016;611.5352332227511;34980.82509587452;39173.41239881397;39515.407268890915;39698.40452393213;39856.80071599642;40374;40671.59328406715;41266;41367.793161034155;41389.37915931256;7607.4294427917985;7779.260970207822;7822.139564647884;7842.333401660866;7846.489978151402;7729.845403091935;7844.2155784421675;7847.215278472164;7848.843023139534;7848.882266766003;7781.2996830285265;7827.5519028979825;7858.1356050834365;7866.646000929972;7880.960595197016;7766.417518686093;7841.843163136706;7855.6464959076975;7878.290953814156;7880.448368614142;7600.581967991759;7605.277498637621;7632.465727399084;7661.387089032864;7663.3486153677;29800.40399192026;34979.82510087459;35136.64863351359;35148;35244.118897027525;3064.5709600655928;3132.937341253185;3222.9033129006166;3348.2131699050706;3479.0780443182325;27844.443111137865;30058;30225.69774302251;30257.546136807967;30281.848590757127;3493.3188028334484;3573.749837511375;3578.248567800739;3609.187932715144;3619.475176099451;266123;272414;277333;277632;278287.99999999796;60612.39387606156;61291;61438.38561614416;61743.6912815433;61802.381976180564;34204.65795342065;35449.645503544634;35631.82184089063;63406.68296658487;63723.36276637267;15878.744857304226;15901.284442200129;15931.840681593036;15944.521664350088;16018.75971860423;10619.94690026545;10659.573617055386;10680.893191068146;10711;10733.141348692243;19679.508012299808;19887;19921.402357929284;19931.900340498203;20047;7428.591427471541;7513.069902737937;7545.811354716176;7629.46593738433;7663.540187588763;742.7623160588668;842.9157084291644;887.3921363865772;1009.8232809258351;1077.4612693653173;28528.714712852605;28622;28726.281842954093;28990.42019159605;29332.266693332836;871.3464901324007;991.7024892532212;1024.5543188712934;1041.7447725307347;1065.3394895165047;15089.170095644626;15143.621409464851;15343.616409589626;15521.223938803014;15543;397957;437648;451995;452468;745295;51480;52143.73928130335;52444.475555244724;52743.20885186725;52749;1223.1926928227326;1223.969400764988;1233.4264566976399;1234.4013153620488;1234.73453207559;27443.451130976868;28800;29421.411571768018;29615.703842962157;29645;43018.35472467978;43298;43739.34390984201;43890;44007;384157;386823;387297;387810;388283;25766.227013189633;25985.22044338673;26138.73861261363;26186.476270474865;26583.734162658126;41858;42360.576394235664;42591.36112958246;42685.57314426816;43091.35362969495;36288.27423451569;36396.636033639326;37126.25747484981;37186.442203367515;37190.03755016247;35871;36190.63809361873;36261.81869090637;36355.818220908724;36750.8162459186;35138.648613513535;35384;35598;35830.64169358377;36130.8193459031;31279.218019549695;32363.19092022624;32466;32601;32899.835500822344;25161.370965726004;25272.873635631706;25419.110331138323;25578.360540986625;25825.483490329712 13:38:56 INFO - PROCESS | 8371 | |2;jquery.html;374.58046987374144;376.7814667492854;386.40181836149833;396.11073140798914;398.5635728876879;15348.69302613947;16857.49427517175;17300.913495432505;17460.38888638898;17499.91250043748;15144.848551514482;16057.437989670363;16803.32786688534;17038.74441883373;17041.233144508496;4520.208963431394;4720;4724.4094488188975;4729.077829823186;4748.477667456577;3493.8253087345656;5098.388193416795;5355.892882142355;5401.540869026137;5421.783128674848;5446.7276636168235;5453;5456.836294911139;5460.453954604528;5475;5095.6178286628465;5392.137258038734;5398.676079435227;5409.540189083933;5449.754761035763;4640.373549570799;5296.867578310535;5297.894042119136;5303.284056652341;5313.0967735485065;11875.940620296844;11928.880711192864;12103.515859365614;12125.636230913087;12144.453499592539;1766.8851524650856;1775.866809989256;1831.9816801831944;1923.086533896402;2247.606668832948;8942.418742781763;8952.239059679934;8965.193132618031;9303.674371397035;9346.719598412059;1631.6491954229898;1671.7826682531315;1685.1995302231342;1686.7216909209965;1698.592337838922;67095.66452167757;67682.64634707278;68224.6588767058;70019;70552.647236764;9985.950070249748;10031.648892288735;10065.69802905914;10148.441835699108;10162.4918754062;13726;13851.445942162401;13876.4449422024;13878;13887.722245555033;7137.607431591208;7301.671424785897;7363.190049094595;7385.187629360766;7424.517406368569;6878.69045892936;6884.690188941509;6925.6190909499455;6997.090378250897;7008.088948436671;4325.091730736518;4347.500037495665;4362.149380870763;4372.213001659732;4415.779211039435;1624.7644091606887;1641.8932769369953;1760.9735853962202;1782.3939860447251;1784.5717027913208;871.7515508080166;917.6742256498981;920.4799288402031;954.8997355277596;969.1277849934974;16516.42192523256;16677.833221667628;16770.58073548171;16844.494665160066;17046.659066818593;866.5320726807579;872.0799556467987;878.912108789116;923.9907600924039;941.7051554113094;9372.39079459833;9485;9707.514624268899;9723.367981081206;9855;340183;348275;350296;351279;352291;74712.25287747053;75441.24558754452;76483.61758191173;77013;77790.61104694441;913.9314551408671;916.0335845682736;926.092429419173;929.256594724218;932.8973812880578;13994.790078149039;14610.269486525418;14912.850871491146;15048.699026019638;15659.765103523228;29272;29565;34288.485672715426;36667.44998824967;36844;47946.280805788636;49441.25838112359;50080.48631732541;50103;50516.49483505265;7552.6223688816435;7667.961660191663;7753.263439973193;7763.14605393395;7867.567283799446;7984.20157984197;9910.851337229804;11152.275102118336;11235.550577977116;11581.073514119018;8550.657973680984;9204.079592040742;9371.671991480538;9456.763580910532;9582.568784404857;9885.950570247103;9895.851562226717;9956.352837065568;9985.800283994426;10117.544710487899;9183.494907780136;9357.485338306458;9388.812223755624;9418.152366287068;9686.70939871805;7021.68402421882;7074;7147.53541019832;7174;7281.199068102399;8723.389362744547;9324.372617535073;9353.906460935576;9394.906050939677;9672.903270967201 13:38:56 INFO - PROCESS | 8371 | |3;mootools.html;1404.33294185262;1419.340006896793;1524.2074121456842;1696.5843368374735;1742.1202292842113;6483.805485835433;7077.6461176941075;7130.393916517096;7654.846903061943;7654.923450765497;7080.39816615587;7318.597477138768;7387;7421.109466863971;7428.331450169484;2141.1649456711893;2170.739511258651;2175.4561359660083;2179.9455013624706;2183.858049226803;2114.7885211478883;2152.3758110148037;2192.9232476863313;2192.967105493419;2203.3389983005036;2154.450615093149;2155.9461013474634;2165.2421652421604;2177.8366622503377;2187.1907394264144;2043.4891277180704;2051.4973831411326;2053.4763635273057;2057.7222075019904;2061.5464597788464;2059.4748339173416;2113.1019316790303;2113.9788602113936;2120.756113047004;2125.362391282609;7255;7255.528390654644;7299.854002919912;7310.744123955636;7333;4191.140816132685;4220.092680073799;4222.5566315536735;4283.271843786564;4300.569943005706;2791.092894809175;2870.3828676834582;2990.147807874767;3011.3525591997604;3014;904.3262769236895;929.159111004542;949.2690628216304;951.6241084771476;961.9182369498601;9424.670136545188;9566.043395660448;9593.616255349847;9602.327837051409;9656.90343096567;4004.6395824375945;4087.4481944937647;4145.709800313949;4167.291560434734;4181.038361176947;8173.468724532886;8195.631196596167;8229.177082291722;8240.62917168729;8299.377546683902;4245.0448649053715;4273.615374616237;4296.2481565725875;4299.204647140289;4315.633171180422;3416.333814906119;3825;3959.604039596075;3965.6629186519467;3976.76139431635;3578.7673801202836;3639.7442882205596;3675;3719.1260053887313;3723.94414083789;1217.3000524698334;1219.1283232488636;1222.7798996180595;1230.2311055590255;1242.031215651793;685.1948959972013;736.5617457612711;823.7528741377563;839.8110425154291;842.6292431330195;5075;5125.103106956268;5154.484551544891;5167.870803229949;5210.114280572312;396.0988750592425;398.88631739954553;402.47276068350556;403.22983102274515;416.3421793566158;3431.4166591679473;3620.963790362063;3624.909377265537;3645.9817700911326;3674.356987527172;8499.277561407225;8712.39013269065;8803.207711306013;8812.206901378906;8822.161894620001;8659.826803464022;8669.263112635497;8683.56582170889;8756.824863502694;8794.42836215644;6515.54391192612;6798.898016529756;6800.931990680129;6931.861362772817;6949.999999999899;5060.51925067118;5147.9227811582105;5236.63343565962;5239.266502689703;5248.3701955765555;8308.584570771558;8467.153284671484;8475.74572762818;8495;8566.957165214135;7954.164812694584;8365.121662225622;8365.205305495969;8556.443831150955;8558;5910.143029260819;6144.262688477412;6317.6209427434505;6329.968350158219;6437.806865794034;7182.748603798842;7202.063731714844;7241.710331586678;7295.671694773854;7315.085614298213;6258.906116408167;6530.575512591857;6592;6632.071509988509;6736.5958042517605;6231.75072997075;6305.274893387135;6306.028435830296;6442.420182183626;6533.216014078151;6197.194364732556;6253.437190652863;6266.122742815918;6279.466245369194;6286.6856657166045;4238.533761286318;4332.176886391576;4361.607455328909;4401.163778882003;4432.82268709248;4252.829886804493;4474.485434175112;4537.977310113428;4575.9771201143785;4600.355950166912 13:38:56 INFO - PROCESS | 8371 | |4;prototype.html;280.38455589980003;285.2924746628362;291.3430214865478;293.05197685487457;294.75829819547965;4878.121938051149;4886.731229782361;5048.697078175312;5084.186530155176;5100.285959965608;4905.460399356068;4928.654994150411;4944.629152813544;4983.900321993558;4993.950060499394;3872.3029854626157;3880.5343358796986;3898.3957486589484;3904.219156168763;3904.6876249900083;3716.535433070866;3883.7475564088386;3885.1064255221318;3890.502156669674;3899.415087736834;3878;3887.7667339959553;3890.7860067696265;3891.0661441254038;3898.8635397761086;3888.4361767543833;3900.161465284963;3906.726529142961;3909.3354129798004;3915.6897430515846;3424.9657503424896;3436.914077148066;3452.723782097426;3488.127968007998;3496.947545786815;4582.495925448198;4867.269909513566;4879.341288925985;4914.680545764514;4920.8031678732805;4452.220861349283;4457.9108417831785;4479.126570318789;4485.102979404132;4485.641148708096;5214.478552144793;5244.134717771563;5281.0758117329315;5322.7072511011875;5333.306670132897;3670.1925576373155;3708.332500149972;3726.5341832270965;3756.1173124315765;3756.69946404287;5507.862303442446;5544.944550554484;5554.527865131468;5558.526455727203;5560.525566123077;3821.426785982125;3828.904277393032;3842.193139440749;3846.442265871433;3848.5766565677754;3800.25894950482;3880.5925377835483;3898.493195884517;3901.453796468497;3921.941170882439;4356.799816092853;4369.71596846204;4370.366296886934;4382.9342559861625;4388.846390376321;5210.895782084337;5213.488088454382;5227.242049902743;5248.422673505911;5261.316028916216;1259.508791571288;1325.8541560428346;1351.2500562187884;1352.263016655925;1356.403182599653;849.7833052571555;852.26705033671;858.3648100405654;869.7825543614097;879.7316818370458;4040.6261870964013;4059.2287465381482;4064.4919385076864;4103.261412945639;4171.770552619574;4719.292106184032;4775.95224047762;4779.617630589614;4782.904341913142;4833.879153021203;4117.3618089196225;4132.297509423345;4135.875923722293;4136.751794892316;4198.328267477189;2610.7911367090587;2705.742954419327;2935.398243360106;2946.7495262902466;2963.881444742229;5180.740962951837;5203.479652034766;5205.453427390145;5205.7397130143345;5228.869278268074;5390.595705322116;5616.157576363578;5621.747021384048;5628.324601047819;5648.435156484319;5197.920831667363;5217.695576106049;5228.92156617651;5233.738313084331;5238.371395432497;5460.863478413072;5483.7258137092185;5491.505764481216;5511.779528818803;5564.91652625219;5179.741012949413;5354.411014788292;5357.410684824744;5388.332775276107;5389.86525336854;5122.1804511278015;5150.768215430389;5164.1995490699;5168.3539557555305;5186.507281808223;3751.474793528963;3788.6400791924725;3791.241751649736;3794.051487128218;3800.3349413853016;5359.732013399393;5373.382061063028;5510.752016159202;5543.390227074938;5558.055130627722;5277.815276465305;5292.179712144623;5311.946880531145;5315.050147168358;5372.5433338166695;5207.609429292743;5233.738313084406;5273.259824257909;5314.362276526842;5377.650452720561;5032.3206367139965;5250.553702935294;5256.553192978639;5277.604179686462;5286.841394758163;5289.7355132244;5303.090887280653;5330.7877230948725;5368.677879327252;5384.488473595002;5186.507281808223;5190.584753219658;5214.374275087014;5214.556762675215;5227 13:38:56 INFO - PROCESS | 8371 | |5;yui.html;594.7977687586222;618.072890664004;629.1789215074328;638.2659941067772;693.5214701855716;10390.324628899125;11595.24630898991;12110;12246.326452045134;12319.384030798468;11711.355875426849;11822;11875.109366797504;11925;12547;603.2278683285401;758.5183408535578;778.1518145221708;784.5645666655004;784.5880912520915;746.3879618712658;771.3674786674928;772.3782355204058;780.886771418144;784.9293563579276;813.1015228172872;815.4210510537525;816.2042009041197;818.8280461103176;819.7212947597816;803.7267329108131;805.2591615713528;807.4025221336199;807.64059993303;809.8137428391474;587.4243241623191;587.547588356967;591.0248090650462;591.2904514582518;592.7747455966748;11821.94089029558;11919;11932.522699092026;11960.820587691192;11975.940120299343;12213.572524961584;12551.686207844878;12710.555130570385;12941.676458088528;13181.86818131816;9848.212143028612;9907.603695852158;10075.949620251926;10170.644027459004;10221;3318.784279021856;3320.286138480238;3337.6495467975756;3338.21551935295;3375.0887260439545;59978.40021599772;60357.6982115091;60946.69526652383;61329.38670613326;61439.385606144264;9996.550155243032;10080.647177348905;10091.798164036825;10095.596176153018;10310.793784124275;18334.724979125323;18433.446996590123;18438.723419148722;18440.907795461204;18489.90755046243;6529.537075378061;6542.214934207926;6592.30780768022;6613.27254002069;6777.593344399352;3367.865285388557;3447.4484082547174;3482.21650128719;3486.8430920608635;3513.350030244413;2741.12284069096;2830.150954713578;2831.971680283212;2841.105051908642;2847.3024109093403;476.8283417969528;483.5937812237737;484.40176382167994;497.9676321039121;502.3143409246425;427.20539795979454;438.02320824561406;473.6613321475162;566.9773209071674;634.3086036220542;7874.72438464651;8163.428560000862;8190.590470476572;8222.671093156207;8375.329973602098;564.1565859040678;582.0948425198771;587.806024012075;594.3640304873744;607.0742118269674;3880.8835734927998;3893.610638936084;3905.628965248297;4066.6340029397497;4088.9182216355507;82881.58559207286;83646;84145;87063;87353;80081.39430239944;80363.19636803673;81088.59455702684;81432.18567814365;82521;67988;69742;72275;72948.27051729521;73322.6333868338;6906.93093069083;7652.885206722015;7664.578448185403;7775.611219439119;7872.527648341118;41002.384964226156;42236.577634223264;43125.78437107794;43464;43660;37114.25771484609;61401;62847.6857615709;62906.37093629005;63039;9395.15443610051;9536.380135291462;10249.590016399261;10338;11135.498902549243;12335.876641233473;12432.378381080729;12490.562830300896;12524.436400362189;12590.937045314715;11885.46515406826;12010.459529321377;12067.155299128977;12307.138500305251;12442.37788110609;11107.278026928223;11222.7755444889;11372.260803047775;11538;11834.349110798988;11225.270357426742;11865.406729663655;11975.940120299343;12049.216800908263;12169.209001415235;9146.954265228898;9189.540522973959;9256.72229833106;9535.904640953502;9620;10173.644348995169;10256.230782691178;10317.535710893178;10346.5344059516;10374.533146008296 13:38:56 INFO - PROCESS | 8371 | __end_tp_report 13:38:56 INFO - PROCESS | 8371 | __start_cc_report 13:38:56 INFO - PROCESS | 8371 | _x_x_mozilla_cycle_collect,406 13:38:56 INFO - PROCESS | 8371 | __end_cc_report 13:38:56 INFO - PROCESS | 8371 | __startTimestamp1464899936949__endTimestamp 13:38:56 INFO - PROCESS | 8371 | 13:38:56 INFO - PROCESS | 8371 | ------- Summary: start ------- 13:38:56 INFO - PROCESS | 8371 | Number of tests: 6 13:38:56 INFO - PROCESS | 8371 | 13:38:56 INFO - PROCESS | 8371 | [#0] dojo.html Cycles:165 Average:4659.27 Median:4798.38 stddev:596.00 (12.4%) stddev-sans-first:575.40 13:38:56 INFO - PROCESS | 8371 | Values: 2594.5 2602.0 2604.5 2616.9 2617.2 4456.8 4566.5 4574.7 4613.5 4628.7 4529.0 4614.3 4630.6 4684.9 4716.0 4267.2 4359.4 4377.4 4381.3 4410.1 544.5 4321.7 4363.8 4419.6 4443.4 4317.3 4327.5 4329.5 4366.4 4368.2 4272.8 4277.6 4321.4 4329.5 4371.1 4266.4 4273.7 4322.7 4343.2 4360.6 4677.3 4683.9 4690.0 4713.3 4728.5 5043.4 5123.4 5146.3 5148.7 5149.7 5170.1 5170.8 5180.2 5184.3 5194.7 4694.1 4698.7 4716.3 4718.4 4749.0 5091.3 5152.6 5212.6 5233.1 5236.1 4991.2 5014.6 5022.8 5035.0 5068.8 5091.5 5102.9 5119.9 5127.0 5127.9 4859.0 5000.5 5047.3 5053.3 5068.2 4837.2 4996.3 5009.8 5021.8 5071.2 4295.3 4315.0 4332.5 4376.8 4380.2 3673.9 3715.2 3746.0 3763.5 3769.3 4392.3 4408.1 4419.2 4451.5 4457.3 5077.7 5097.6 5101.0 5114.4 5133.4 4400.6 4414.4 4424.5 4454.3 4458.9 4575.4 4576.5 4591.2 4606.7 4656.5 4707.2 4743.2 4749.7 4837.0 4857.1 5047.1 5048.2 5049.1 5049.1 5051.6 4743.7 4754.5 4759.4 4759.5 4798.4 4895.2 5003.9 5026.1 5072.1 5084.7 5137.9 5140.5 5143.9 5152.8 5226.6 4826.3 4989.2 4992.8 4994.4 5000.7 4862.3 4885.2 4919.4 4926.3 4942.8 4727.0 4827.1 4842.0 4873.1 4896.2 4821.4 4991.1 4996.0 5011.1 5042.0 4835.8 4857.7 4901.6 4915.7 4925.2 13:38:56 INFO - PROCESS | 8371 | 13:38:56 INFO - PROCESS | 8371 | [#1] ext.html Cycles:180 Average:53260.60 Median:36226.23 stddev:107394.14 (296.5%) stddev-sans-first:107622.50 13:38:56 INFO - PROCESS | 8371 | Values: 552.9 585.8 598.0 599.9 611.5 34980.8 39173.4 39515.4 39698.4 39856.8 40374.0 40671.6 41266.0 41367.8 41389.4 7607.4 7779.3 7822.1 7842.3 7846.5 7729.8 7844.2 7847.2 7848.8 7848.9 7781.3 7827.6 7858.1 7866.6 7881.0 7766.4 7841.8 7855.6 7878.3 7880.4 7600.6 7605.3 7632.5 7661.4 7663.3 29800.4 34979.8 35136.6 35148.0 35244.1 3064.6 3132.9 3222.9 3348.2 3479.1 27844.4 30058.0 30225.7 30257.5 30281.8 3493.3 3573.7 3578.2 3609.2 3619.5 266123.0 272414.0 277333.0 277632.0 278288.0 60612.4 61291.0 61438.4 61743.7 61802.4 34204.7 35449.6 35631.8 63406.7 63723.4 15878.7 15901.3 15931.8 15944.5 16018.8 10619.9 10659.6 10680.9 10711.0 10733.1 19679.5 19887.0 19921.4 19931.9 20047.0 7428.6 7513.1 7545.8 7629.5 7663.5 742.8 842.9 887.4 1009.8 1077.5 28528.7 28622.0 28726.3 28990.4 29332.3 871.3 991.7 1024.6 1041.7 1065.3 15089.2 15143.6 15343.6 15521.2 15543.0 397957.0 437648.0 451995.0 452468.0 745295.0 51480.0 52143.7 52444.5 52743.2 52749.0 1223.2 1224.0 1233.4 1234.4 1234.7 27443.5 28800.0 29421.4 29615.7 29645.0 43018.4 43298.0 43739.3 43890.0 44007.0 384157.0 386823.0 387297.0 387810.0 388283.0 25766.2 25985.2 26138.7 26186.5 26583.7 41858.0 42360.6 42591.4 42685.6 43091.4 36288.3 36396.6 37126.3 37186.4 37190.0 35871.0 36190.6 36261.8 36355.8 36750.8 35138.6 35384.0 35598.0 35830.6 36130.8 31279.2 32363.2 32466.0 32601.0 32899.8 25161.4 25272.9 25419.1 25578.4 25825.5 13:38:56 INFO - PROCESS | 8371 | 13:38:56 INFO - PROCESS | 8371 | [#2] jquery.html Cycles:180 Average:22551.32 Median:5334.49 stddev:57844.00 (1084.3%) stddev-sans-first:57982.30 13:38:56 INFO - PROCESS | 8371 | Values: 374.6 376.8 386.4 396.1 398.6 15348.7 16857.5 17300.9 17460.4 17499.9 15144.8 16057.4 16803.3 17038.7 17041.2 4520.2 4720.0 4724.4 4729.1 4748.5 3493.8 5098.4 5355.9 5401.5 5421.8 5446.7 5453.0 5456.8 5460.5 5475.0 5095.6 5392.1 5398.7 5409.5 5449.8 4640.4 5296.9 5297.9 5303.3 5313.1 11875.9 11928.9 12103.5 12125.6 12144.5 1766.9 1775.9 1832.0 1923.1 2247.6 8942.4 8952.2 8965.2 9303.7 9346.7 1631.6 1671.8 1685.2 1686.7 1698.6 67095.7 67682.6 68224.7 70019.0 70552.6 9986.0 10031.6 10065.7 10148.4 10162.5 13726.0 13851.4 13876.4 13878.0 13887.7 7137.6 7301.7 7363.2 7385.2 7424.5 6878.7 6884.7 6925.6 6997.1 7008.1 4325.1 4347.5 4362.1 4372.2 4415.8 1624.8 1641.9 1761.0 1782.4 1784.6 871.8 917.7 920.5 954.9 969.1 16516.4 16677.8 16770.6 16844.5 17046.7 866.5 872.1 878.9 924.0 941.7 9372.4 9485.0 9707.5 9723.4 9855.0 340183.0 348275.0 350296.0 351279.0 352291.0 74712.3 75441.2 76483.6 77013.0 77790.6 913.9 916.0 926.1 929.3 932.9 13994.8 14610.3 14912.9 15048.7 15659.8 29272.0 29565.0 34288.5 36667.4 36844.0 47946.3 49441.3 50080.5 50103.0 50516.5 7552.6 7668.0 7753.3 7763.1 7867.6 7984.2 9910.9 11152.3 11235.6 11581.1 8550.7 9204.1 9371.7 9456.8 9582.6 9886.0 9895.9 9956.4 9985.8 10117.5 9183.5 9357.5 9388.8 9418.2 9686.7 7021.7 7074.0 7147.5 7174.0 7281.2 8723.4 9324.4 9353.9 9394.9 9672.9 13:38:56 INFO - PROCESS | 8371 | 13:38:56 INFO - PROCESS | 8371 | [#3] mootools.html Cycles:180 Average:4854.41 Median:5188.99 stddev:2630.30 (50.7%) stddev-sans-first:2624.90 13:38:56 INFO - PROCESS | 8371 | Values: 1404.3 1419.3 1524.2 1696.6 1742.1 6483.8 7077.6 7130.4 7654.8 7654.9 7080.4 7318.6 7387.0 7421.1 7428.3 2141.2 2170.7 2175.5 2179.9 2183.9 2114.8 2152.4 2192.9 2193.0 2203.3 2154.5 2155.9 2165.2 2177.8 2187.2 2043.5 2051.5 2053.5 2057.7 2061.5 2059.5 2113.1 2114.0 2120.8 2125.4 7255.0 7255.5 7299.9 7310.7 7333.0 4191.1 4220.1 4222.6 4283.3 4300.6 2791.1 2870.4 2990.1 3011.4 3014.0 904.3 929.2 949.3 951.6 961.9 9424.7 9566.0 9593.6 9602.3 9656.9 4004.6 4087.4 4145.7 4167.3 4181.0 8173.5 8195.6 8229.2 8240.6 8299.4 4245.0 4273.6 4296.2 4299.2 4315.6 3416.3 3825.0 3959.6 3965.7 3976.8 3578.8 3639.7 3675.0 3719.1 3723.9 1217.3 1219.1 1222.8 1230.2 1242.0 685.2 736.6 823.8 839.8 842.6 5075.0 5125.1 5154.5 5167.9 5210.1 396.1 398.9 402.5 403.2 416.3 3431.4 3621.0 3624.9 3646.0 3674.4 8499.3 8712.4 8803.2 8812.2 8822.2 8659.8 8669.3 8683.6 8756.8 8794.4 6515.5 6798.9 6800.9 6931.9 6950.0 5060.5 5147.9 5236.6 5239.3 5248.4 8308.6 8467.2 8475.7 8495.0 8567.0 7954.2 8365.1 8365.2 8556.4 8558.0 5910.1 6144.3 6317.6 6330.0 6437.8 7182.7 7202.1 7241.7 7295.7 7315.1 6258.9 6530.6 6592.0 6632.1 6736.6 6231.8 6305.3 6306.0 6442.4 6533.2 6197.2 6253.4 6266.1 6279.5 6286.7 4238.5 4332.2 4361.6 4401.2 4432.8 4252.8 4474.5 4538.0 4576.0 4600.4 13:38:56 INFO - PROCESS | 8371 | 13:38:56 INFO - PROCESS | 8371 | [#4] prototype.html Cycles:180 Average:4335.21 Median:4910.07 stddev:1282.74 (26.1%) stddev-sans-first:1249.71 13:38:56 INFO - PROCESS | 8371 | Values: 280.4 285.3 291.3 293.1 294.8 4878.1 4886.7 5048.7 5084.2 5100.3 4905.5 4928.7 4944.6 4983.9 4994.0 3872.3 3880.5 3898.4 3904.2 3904.7 3716.5 3883.7 3885.1 3890.5 3899.4 3878.0 3887.8 3890.8 3891.1 3898.9 3888.4 3900.2 3906.7 3909.3 3915.7 3425.0 3436.9 3452.7 3488.1 3496.9 4582.5 4867.3 4879.3 4914.7 4920.8 4452.2 4457.9 4479.1 4485.1 4485.6 5214.5 5244.1 5281.1 5322.7 5333.3 3670.2 3708.3 3726.5 3756.1 3756.7 5507.9 5544.9 5554.5 5558.5 5560.5 3821.4 3828.9 3842.2 3846.4 3848.6 3800.3 3880.6 3898.5 3901.5 3921.9 4356.8 4369.7 4370.4 4382.9 4388.8 5210.9 5213.5 5227.2 5248.4 5261.3 1259.5 1325.9 1351.3 1352.3 1356.4 849.8 852.3 858.4 869.8 879.7 4040.6 4059.2 4064.5 4103.3 4171.8 4719.3 4776.0 4779.6 4782.9 4833.9 4117.4 4132.3 4135.9 4136.8 4198.3 2610.8 2705.7 2935.4 2946.7 2963.9 5180.7 5203.5 5205.5 5205.7 5228.9 5390.6 5616.2 5621.7 5628.3 5648.4 5197.9 5217.7 5228.9 5233.7 5238.4 5460.9 5483.7 5491.5 5511.8 5564.9 5179.7 5354.4 5357.4 5388.3 5389.9 5122.2 5150.8 5164.2 5168.4 5186.5 3751.5 3788.6 3791.2 3794.1 3800.3 5359.7 5373.4 5510.8 5543.4 5558.1 5277.8 5292.2 5311.9 5315.1 5372.5 5207.6 5233.7 5273.3 5314.4 5377.7 5032.3 5250.6 5256.6 5277.6 5286.8 5289.7 5303.1 5330.8 5368.7 5384.5 5186.5 5190.6 5214.4 5214.6 5227.0 13:38:56 INFO - PROCESS | 8371 | 13:38:56 INFO - PROCESS | 8371 | [#5] yui.html Cycles:180 Average:16800.57 Median:484.00 stddev:23561.99 (4868.2%) stddev-sans-first:23596.67 13:38:56 INFO - PROCESS | 8371 | Values: 594.8 618.1 629.2 638.3 693.5 10390.3 11595.2 12110.0 12246.3 12319.4 11711.4 11822.0 11875.1 11925.0 12547.0 603.2 758.5 778.2 784.6 784.6 746.4 771.4 772.4 780.9 784.9 813.1 815.4 816.2 818.8 819.7 803.7 805.3 807.4 807.6 809.8 587.4 587.5 591.0 591.3 592.8 11821.9 11919.0 11932.5 11960.8 11975.9 12213.6 12551.7 12710.6 12941.7 13181.9 9848.2 9907.6 10075.9 10170.6 10221.0 3318.8 3320.3 3337.6 3338.2 3375.1 59978.4 60357.7 60946.7 61329.4 61439.4 9996.6 10080.6 10091.8 10095.6 10310.8 18334.7 18433.4 18438.7 18440.9 18489.9 6529.5 6542.2 6592.3 6613.3 6777.6 3367.9 3447.4 3482.2 3486.8 3513.4 2741.1 2830.2 2832.0 2841.1 2847.3 476.8 483.6 484.4 498.0 502.3 427.2 438.0 473.7 567.0 634.3 7874.7 8163.4 8190.6 8222.7 8375.3 564.2 582.1 587.8 594.4 607.1 3880.9 3893.6 3905.6 4066.6 4088.9 82881.6 83646.0 84145.0 87063.0 87353.0 80081.4 80363.2 81088.6 81432.2 82521.0 67988.0 69742.0 72275.0 72948.3 73322.6 6906.9 7652.9 7664.6 7775.6 7872.5 41002.4 42236.6 43125.8 43464.0 43660.0 37114.3 61401.0 62847.7 62906.4 63039.0 9395.2 9536.4 10249.6 10338.0 11135.5 12335.9 12432.4 12490.6 12524.4 12590.9 11885.5 12010.5 12067.2 12307.1 12442.4 11107.3 11222.8 11372.3 11538.0 11834.3 11225.3 11865.4 11975.9 12049.2 12169.2 9147.0 9189.5 9256.7 9535.9 9620.0 10173.6 10256.2 10317.5 10346.5 10374.5 13:38:56 INFO - PROCESS | 8371 | -------- Summary: end -------- 13:38:56 INFO - PROCESS | 8371 | 13:38:57 INFO - TEST-INFO | 8371: exit 0 13:38:57 INFO - TEST-OK | dromaeo_css | took 1115137ms 13:38:57 INFO - TEST-START | kraken 13:38:57 INFO - operating with platform_type : linux_ 13:38:57 INFO - Initialising browser for kraken test... 13:38:57 INFO - TEST-INFO | started process 8600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXHCgzO/profile http://localhost:59000/getInfo.html) 13:39:02 INFO - PROCESS | 8600 | __metrics Screen width/height:1600/1200 13:39:02 INFO - PROCESS | 8600 | colorDepth:24 13:39:02 INFO - PROCESS | 8600 | Browser inner width/height: 1024/697 13:39:02 INFO - PROCESS | 8600 | __metrics 13:39:03 ERROR - PROCESS | 8600 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 13:39:04 INFO - TEST-INFO | 8600: exit 0 13:39:04 INFO - Browser initialized. 13:39:04 INFO - Running cycle 1/1 for kraken test... 13:39:04 INFO - TEST-INFO | started process 8717 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXHCgzO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:39:16 INFO - PROCESS | 8717 | RSS: Main: 168767488 13:39:16 INFO - PROCESS | 8717 | 13:39:18 INFO - PROCESS | 8717 | Cycle 1(1): loaded http://localhost:59000/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59000/tests/kraken/driver.html?testName=audio-beat-detection) 13:39:19 INFO - PROCESS | 8717 | RSS: Main: 173670400 13:39:19 INFO - PROCESS | 8717 | 13:39:22 INFO - PROCESS | 8717 | Cycle 1(1): loaded http://localhost:59000/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59000/tests/kraken/driver.html?testName=audio-dft) 13:39:23 INFO - PROCESS | 8717 | RSS: Main: 173826048 13:39:23 INFO - PROCESS | 8717 | 13:39:26 INFO - PROCESS | 8717 | Cycle 1(1): loaded http://localhost:59000/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59000/tests/kraken/driver.html?testName=audio-fft) 13:39:26 INFO - PROCESS | 8717 | RSS: Main: 167878656 13:39:26 INFO - PROCESS | 8717 | 13:39:29 INFO - PROCESS | 8717 | Cycle 1(1): loaded http://localhost:59000/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59000/tests/kraken/driver.html?testName=audio-oscillator) 13:39:29 INFO - PROCESS | 8717 | RSS: Main: 168390656 13:39:29 INFO - PROCESS | 8717 | 13:39:31 INFO - PROCESS | 8717 | Cycle 1(1): loaded http://localhost:59000/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59000/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:39:32 INFO - PROCESS | 8717 | RSS: Main: 168816640 13:39:32 INFO - PROCESS | 8717 | 13:39:35 INFO - PROCESS | 8717 | Cycle 1(1): loaded http://localhost:59000/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59000/tests/kraken/driver.html?testName=imaging-darkroom) 13:39:36 INFO - PROCESS | 8717 | RSS: Main: 169336832 13:39:36 INFO - PROCESS | 8717 | 13:39:39 INFO - PROCESS | 8717 | Cycle 1(1): loaded http://localhost:59000/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59000/tests/kraken/driver.html?testName=imaging-desaturate) 13:39:40 INFO - PROCESS | 8717 | RSS: Main: 166961152 13:39:40 INFO - PROCESS | 8717 | 13:39:43 INFO - PROCESS | 8717 | Cycle 1(1): loaded http://localhost:59000/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59000/tests/kraken/driver.html?testName=json-parse-financial) 13:39:44 INFO - PROCESS | 8717 | RSS: Main: 168185856 13:39:44 INFO - PROCESS | 8717 | 13:39:45 INFO - PROCESS | 8717 | Cycle 1(1): loaded http://localhost:59000/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59000/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:39:46 INFO - PROCESS | 8717 | RSS: Main: 168460288 13:39:46 INFO - PROCESS | 8717 | 13:39:48 INFO - PROCESS | 8717 | Cycle 1(1): loaded http://localhost:59000/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59000/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:39:49 INFO - PROCESS | 8717 | RSS: Main: 168304640 13:39:49 INFO - PROCESS | 8717 | 13:39:51 INFO - PROCESS | 8717 | Cycle 1(1): loaded http://localhost:59000/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59000/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:39:52 INFO - PROCESS | 8717 | RSS: Main: 168603648 13:39:52 INFO - PROCESS | 8717 | 13:39:54 INFO - PROCESS | 8717 | Cycle 1(1): loaded http://localhost:59000/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59000/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:39:55 INFO - PROCESS | 8717 | RSS: Main: 168665088 13:39:55 INFO - PROCESS | 8717 | 13:39:58 INFO - PROCESS | 8717 | Cycle 1(1): loaded http://localhost:59000/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59000/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:39:58 INFO - PROCESS | 8717 | RSS: Main: 168390656 13:39:59 INFO - PROCESS | 8717 | 13:40:00 INFO - PROCESS | 8717 | Cycle 1(1): loaded http://localhost:59000/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59000/tests/kraken/driver.html?testName=ai-astar) 13:40:01 INFO - PROCESS | 8717 | RSS: Main: 169668608 13:40:01 INFO - PROCESS | 8717 | 13:40:01 INFO - PROCESS | 8717 | __start_tp_report 13:40:01 INFO - PROCESS | 8717 | _x_x_mozilla_page_load 13:40:01 INFO - PROCESS | 8717 | _x_x_mozilla_page_load_details 13:40:01 INFO - PROCESS | 8717 | |i|pagename|runs| 13:40:01 INFO - PROCESS | 8717 | |0;ai-astar;117;111;127;115;116;116;115;114;115;114 13:40:01 INFO - PROCESS | 8717 | |1;audio-beat-detection;164;131;155;194;135;159;162;134;192;131 13:40:01 INFO - PROCESS | 8717 | |2;audio-dft;162;163;166;183;166;161;161;164;163;164 13:40:01 INFO - PROCESS | 8717 | |3;audio-fft;78;77;76;165;77;78;78;77;164;78 13:40:01 INFO - PROCESS | 8717 | |4;audio-oscillator;84;87;154;85;85;84;144;84;84;133 13:40:01 INFO - PROCESS | 8717 | |5;imaging-gaussian-blur;118;117;117;120;118;118;118;119;122;118 13:40:01 INFO - PROCESS | 8717 | |6;imaging-darkroom;148;148;147;148;149;148;147;148;147;147 13:40:01 INFO - PROCESS | 8717 | |7;imaging-desaturate;95;95;95;96;97;96;97;97;95;95 13:40:01 INFO - PROCESS | 8717 | |8;json-parse-financial;63;63;64;65;63;63;65;65;63;64 13:40:01 INFO - PROCESS | 8717 | |9;json-stringify-tinderbox;66;65;67;66;66;65;66;66;65;67 13:40:01 INFO - PROCESS | 8717 | |10;stanford-crypto-aes;89;88;85;84;86;84;88;86;121;87 13:40:01 INFO - PROCESS | 8717 | |11;stanford-crypto-ccm;140;133;149;146;133;138;150;134;154;137 13:40:01 INFO - PROCESS | 8717 | |12;stanford-crypto-pbkdf2;177;177;179;169;178;175;176;176;171;169 13:40:01 INFO - PROCESS | 8717 | |13;stanford-crypto-sha256-iterative;74;72;68;68;70;67;69;69;68;66 13:40:01 INFO - PROCESS | 8717 | __end_tp_report 13:40:01 INFO - PROCESS | 8717 | __start_cc_report 13:40:01 INFO - PROCESS | 8717 | _x_x_mozilla_cycle_collect,962 13:40:01 INFO - PROCESS | 8717 | __end_cc_report 13:40:01 INFO - PROCESS | 8717 | __startTimestamp1464900001012__endTimestamp 13:40:01 INFO - PROCESS | 8717 | 13:40:01 INFO - PROCESS | 8717 | ------- Summary: start ------- 13:40:01 INFO - PROCESS | 8717 | Number of tests: 14 13:40:01 INFO - PROCESS | 8717 | 13:40:01 INFO - PROCESS | 8717 | [#0] ai-astar Cycles:10 Average:116.00 Median:115.50 stddev:4.19 (3.6%) stddev-sans-first:4.43 13:40:01 INFO - PROCESS | 8717 | Values: 117.0 111.0 127.0 115.0 116.0 116.0 115.0 114.0 115.0 114.0 13:40:01 INFO - PROCESS | 8717 | 13:40:01 INFO - PROCESS | 8717 | [#1] audio-beat-detection Cycles:10 Average:155.70 Median:160.50 stddev:23.63 (14.7%) stddev-sans-first:24.87 13:40:01 INFO - PROCESS | 8717 | Values: 164.0 131.0 155.0 194.0 135.0 159.0 162.0 134.0 192.0 131.0 13:40:01 INFO - PROCESS | 8717 | 13:40:01 INFO - PROCESS | 8717 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.00 stddev:6.46 (3.9%) stddev-sans-first:6.75 13:40:01 INFO - PROCESS | 8717 | Values: 162.0 163.0 166.0 183.0 166.0 161.0 161.0 164.0 163.0 164.0 13:40:01 INFO - PROCESS | 8717 | 13:40:01 INFO - PROCESS | 8717 | [#3] audio-fft Cycles:10 Average:94.80 Median:77.50 stddev:36.74 (47.4%) stddev-sans-first:38.46 13:40:01 INFO - PROCESS | 8717 | Values: 78.0 77.0 76.0 165.0 77.0 78.0 78.0 77.0 164.0 78.0 13:40:01 INFO - PROCESS | 8717 | 13:40:01 INFO - PROCESS | 8717 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:84.00 stddev:28.92 (34.4%) stddev-sans-first:29.90 13:40:01 INFO - PROCESS | 8717 | Values: 84.0 87.0 154.0 85.0 85.0 84.0 144.0 84.0 84.0 133.0 13:40:01 INFO - PROCESS | 8717 | 13:40:01 INFO - PROCESS | 8717 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.00 stddev:1.51 (1.3%) stddev-sans-first:1.59 13:40:01 INFO - PROCESS | 8717 | Values: 118.0 117.0 117.0 120.0 118.0 118.0 118.0 119.0 122.0 118.0 13:40:01 INFO - PROCESS | 8717 | 13:40:01 INFO - PROCESS | 8717 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 13:40:01 INFO - PROCESS | 8717 | Values: 148.0 148.0 147.0 148.0 149.0 148.0 147.0 148.0 147.0 147.0 13:40:01 INFO - PROCESS | 8717 | 13:40:01 INFO - PROCESS | 8717 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.93 13:40:01 INFO - PROCESS | 8717 | Values: 95.0 95.0 95.0 96.0 97.0 96.0 97.0 97.0 95.0 95.0 13:40:01 INFO - PROCESS | 8717 | 13:40:01 INFO - PROCESS | 8717 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 13:40:01 INFO - PROCESS | 8717 | Values: 63.0 63.0 64.0 65.0 63.0 63.0 65.0 65.0 63.0 64.0 13:40:01 INFO - PROCESS | 8717 | 13:40:01 INFO - PROCESS | 8717 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 13:40:01 INFO - PROCESS | 8717 | Values: 66.0 65.0 67.0 66.0 66.0 65.0 66.0 66.0 65.0 67.0 13:40:01 INFO - PROCESS | 8717 | 13:40:01 INFO - PROCESS | 8717 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:86.50 stddev:11.09 (12.8%) stddev-sans-first:11.76 13:40:01 INFO - PROCESS | 8717 | Values: 89.0 88.0 85.0 84.0 86.0 84.0 88.0 86.0 121.0 87.0 13:40:01 INFO - PROCESS | 8717 | 13:40:01 INFO - PROCESS | 8717 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:143.00 stddev:7.75 (5.4%) stddev-sans-first:8.20 13:40:01 INFO - PROCESS | 8717 | Values: 140.0 133.0 149.0 146.0 133.0 138.0 150.0 134.0 154.0 137.0 13:40:01 INFO - PROCESS | 8717 | 13:40:01 INFO - PROCESS | 8717 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:176.50 stddev:3.68 (2.1%) stddev-sans-first:3.81 13:40:01 INFO - PROCESS | 8717 | Values: 177.0 177.0 179.0 169.0 178.0 175.0 176.0 176.0 171.0 169.0 13:40:01 INFO - PROCESS | 8717 | 13:40:01 INFO - PROCESS | 8717 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:2.38 (3.4%) stddev-sans-first:1.74 13:40:01 INFO - PROCESS | 8717 | Values: 74.0 72.0 68.0 68.0 70.0 67.0 69.0 69.0 68.0 66.0 13:40:01 INFO - PROCESS | 8717 | -------- Summary: end -------- 13:40:01 INFO - PROCESS | 8717 | 13:40:02 INFO - TEST-INFO | 8717: exit 0 13:40:02 INFO - TEST-OK | kraken | took 64378ms 13:40:02 INFO - SUITE-END | took 1179s 13:40:02 INFO - Completed test suite (00:19:39) 13:40:02 INFO - javascript benchmark 13:40:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6315.208458050711, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2594.5459544579708, 2601.9739802601975, 2604.4791041791636, 2616.856072915989, 2617.2410001099684, 4456.777161141946, 4566.497685254623, 4574.7255164690105, 4613.515580864003, 4628.745419001953, 4529.048899731052, 4614.307853821929, 4630.583247507724, 4684.906301873961, 4716.0, 4267.231898258305, 4359.411479450281, 4377.387165796791, 4381.3208952612395, 4410.09593033429, 544.4623578975581, 4321.697481176319, 4363.759993200372, 4419.580139886722, 4443.400140980959, 4317.309230523133, 4327.5239723630375, 4329.523752387235, 4366.366876802877, 4368.213721530124, 4272.786360681954, 4277.572242775728, 4321.416608757809, 4329.5453977332245, 4371.060222052274, 4266.402703621496, 4273.743575385487, 4322.697411181219, 4343.19650864591, 4360.585744354281, 4677.275022371504, 4683.906321873577, 4689.95310046902, 4713.269443236304, 4728.4798672146035, 5043.36957880265, 5123.436421993578, 5146.253793200002, 5148.691078535262, 5149.6910185389, 5170.121079416471, 5170.767315470813, 5180.222966555009, 5184.27420161174, 5194.662346947474, 4694.0611877624615, 4698.741569213692, 4716.268978308368, 4718.4337879454, 4748.9525104748855, 5091.261767043758, 5152.562032227228, 5212.609054320941, 5233.110371236899, 5236.136037553761, 4991.226359914146, 5014.623903207274, 5022.84931452057, 5035.0, 5068.847934561969, 5091.465396133427, 5102.948970510248, 5119.87200319995, 5127.0, 5127.948720512822, 4858.97961428097, 5000.524950129732, 5047.268146118866, 5053.267276244997, 5068.189089745623, 4837.201861692852, 4996.2505624156665, 5009.774560144802, 5021.824236151717, 5071.2139618359215, 4295.269804133305, 4315.029118448324, 4332.523422423531, 4376.846810361686, 4380.189664912002, 3673.8897833064516, 3715.2198038412234, 3746.0, 3763.5483741950593, 3769.321522125989, 4392.253316936129, 4408.096340250241, 4419.160359531678, 4451.465824101128, 4457.264551349056, 5077.695338279715, 5097.643164978416, 5101.0, 5114.43741188469, 5133.383993920754, 4400.625946794495, 4414.404055452537, 4424.491183513873, 4454.331850222427, 4458.888527786767, 4575.359449677047, 4576.496585375606, 4591.219492686185, 4606.677532572688, 4656.511066338054, 4707.199776038082, 4743.217369134054, 4749.715017098985, 4836.951630483721, 4857.077155340474, 5047.066292735855, 5048.167052436307, 5049.065922804146, 5049.141645920129, 5051.62112841531, 4743.667943244078, 4754.500777418321, 4759.357486739246, 4759.452662943667, 4798.376211092535, 4895.241237608177, 5003.924941125813, 5026.070177017264, 5072.061668591323, 5084.694918304914, 5137.897242055213, 5140.511651393112, 5143.948560514496, 5152.845414637567, 5226.63413561047, 4826.276058591239, 4989.201727723546, 4992.750362481934, 4994.350734404504, 5000.724960127228, 4862.343583616166, 4885.218365061573, 4919.3604831371695, 4926.310316555757, 4942.8022879085875, 4726.952730472652, 4827.08285425782, 4842.031593681349, 4873.147199240189, 4896.167651499325, 4821.421429428491, 4991.051700176955, 4996.000799840119, 5011.148104822262, 5042.042012017705, 4835.8065677372515, 4857.6599638025, 4901.58336541398, 4915.705057696549, 4925.1873440881855], "value": 4622.607695033837, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.8734610865939, 585.7715490958526, 597.9790707325242, 599.8620317327016, 611.5352332227511, 34980.82509587452, 39173.41239881397, 39515.407268890915, 39698.40452393213, 39856.80071599642, 40374.0, 40671.59328406715, 41266.0, 41367.793161034155, 41389.37915931256, 7607.4294427917985, 7779.260970207822, 7822.139564647884, 7842.333401660866, 7846.489978151402, 7729.845403091935, 7844.2155784421675, 7847.215278472164, 7848.843023139534, 7848.882266766003, 7781.2996830285265, 7827.5519028979825, 7858.1356050834365, 7866.646000929972, 7880.960595197016, 7766.417518686093, 7841.843163136706, 7855.6464959076975, 7878.290953814156, 7880.448368614142, 7600.581967991759, 7605.277498637621, 7632.465727399084, 7661.387089032864, 7663.3486153677, 29800.40399192026, 34979.82510087459, 35136.64863351359, 35148.0, 35244.118897027525, 3064.5709600655928, 3132.937341253185, 3222.9033129006166, 3348.2131699050706, 3479.0780443182325, 27844.443111137865, 30058.0, 30225.69774302251, 30257.546136807967, 30281.848590757127, 3493.3188028334484, 3573.749837511375, 3578.248567800739, 3609.187932715144, 3619.475176099451, 266123.0, 272414.0, 277333.0, 277632.0, 278287.99999999796, 60612.39387606156, 61291.0, 61438.38561614416, 61743.6912815433, 61802.381976180564, 34204.65795342065, 35449.645503544634, 35631.82184089063, 63406.68296658487, 63723.36276637267, 15878.744857304226, 15901.284442200129, 15931.840681593036, 15944.521664350088, 16018.75971860423, 10619.94690026545, 10659.573617055386, 10680.893191068146, 10711.0, 10733.141348692243, 19679.508012299808, 19887.0, 19921.402357929284, 19931.900340498203, 20047.0, 7428.591427471541, 7513.069902737937, 7545.811354716176, 7629.46593738433, 7663.540187588763, 742.7623160588668, 842.9157084291644, 887.3921363865772, 1009.8232809258351, 1077.4612693653173, 28528.714712852605, 28622.0, 28726.281842954093, 28990.42019159605, 29332.266693332836, 871.3464901324007, 991.7024892532212, 1024.5543188712934, 1041.7447725307347, 1065.3394895165047, 15089.170095644626, 15143.621409464851, 15343.616409589626, 15521.223938803014, 15543.0, 397957.0, 437648.0, 451995.0, 452468.0, 745295.0, 51480.0, 52143.73928130335, 52444.475555244724, 52743.20885186725, 52749.0, 1223.1926928227326, 1223.969400764988, 1233.4264566976399, 1234.4013153620488, 1234.73453207559, 27443.451130976868, 28800.0, 29421.411571768018, 29615.703842962157, 29645.0, 43018.35472467978, 43298.0, 43739.34390984201, 43890.0, 44007.0, 384157.0, 386823.0, 387297.0, 387810.0, 388283.0, 25766.227013189633, 25985.22044338673, 26138.73861261363, 26186.476270474865, 26583.734162658126, 41858.0, 42360.576394235664, 42591.36112958246, 42685.57314426816, 43091.35362969495, 36288.27423451569, 36396.636033639326, 37126.25747484981, 37186.442203367515, 37190.03755016247, 35871.0, 36190.63809361873, 36261.81869090637, 36355.818220908724, 36750.8162459186, 35138.648613513535, 35384.0, 35598.0, 35830.64169358377, 36130.8193459031, 31279.218019549695, 32363.19092022624, 32466.0, 32601.0, 32899.835500822344, 25161.370965726004, 25272.873635631706, 25419.110331138323, 25578.360540986625, 25825.483490329712], "value": 18056.290311904286, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.58046987374144, 376.7814667492854, 386.40181836149833, 396.11073140798914, 398.5635728876879, 15348.69302613947, 16857.49427517175, 17300.913495432505, 17460.38888638898, 17499.91250043748, 15144.848551514482, 16057.437989670363, 16803.32786688534, 17038.74441883373, 17041.233144508496, 4520.208963431394, 4720.0, 4724.4094488188975, 4729.077829823186, 4748.477667456577, 3493.8253087345656, 5098.388193416795, 5355.892882142355, 5401.540869026137, 5421.783128674848, 5446.7276636168235, 5453.0, 5456.836294911139, 5460.453954604528, 5475.0, 5095.6178286628465, 5392.137258038734, 5398.676079435227, 5409.540189083933, 5449.754761035763, 4640.373549570799, 5296.867578310535, 5297.894042119136, 5303.284056652341, 5313.0967735485065, 11875.940620296844, 11928.880711192864, 12103.515859365614, 12125.636230913087, 12144.453499592539, 1766.8851524650856, 1775.866809989256, 1831.9816801831944, 1923.086533896402, 2247.606668832948, 8942.418742781763, 8952.239059679934, 8965.193132618031, 9303.674371397035, 9346.719598412059, 1631.6491954229898, 1671.7826682531315, 1685.1995302231342, 1686.7216909209965, 1698.592337838922, 67095.66452167757, 67682.64634707278, 68224.6588767058, 70019.0, 70552.647236764, 9985.950070249748, 10031.648892288735, 10065.69802905914, 10148.441835699108, 10162.4918754062, 13726.0, 13851.445942162401, 13876.4449422024, 13878.0, 13887.722245555033, 7137.607431591208, 7301.671424785897, 7363.190049094595, 7385.187629360766, 7424.517406368569, 6878.69045892936, 6884.690188941509, 6925.6190909499455, 6997.090378250897, 7008.088948436671, 4325.091730736518, 4347.500037495665, 4362.149380870763, 4372.213001659732, 4415.779211039435, 1624.7644091606887, 1641.8932769369953, 1760.9735853962202, 1782.3939860447251, 1784.5717027913208, 871.7515508080166, 917.6742256498981, 920.4799288402031, 954.8997355277596, 969.1277849934974, 16516.42192523256, 16677.833221667628, 16770.58073548171, 16844.494665160066, 17046.659066818593, 866.5320726807579, 872.0799556467987, 878.912108789116, 923.9907600924039, 941.7051554113094, 9372.39079459833, 9485.0, 9707.514624268899, 9723.367981081206, 9855.0, 340183.0, 348275.0, 350296.0, 351279.0, 352291.0, 74712.25287747053, 75441.24558754452, 76483.61758191173, 77013.0, 77790.61104694441, 913.9314551408671, 916.0335845682736, 926.092429419173, 929.256594724218, 932.8973812880578, 13994.790078149039, 14610.269486525418, 14912.850871491146, 15048.699026019638, 15659.765103523228, 29272.0, 29565.0, 34288.485672715426, 36667.44998824967, 36844.0, 47946.280805788636, 49441.25838112359, 50080.48631732541, 50103.0, 50516.49483505265, 7552.6223688816435, 7667.961660191663, 7753.263439973193, 7763.14605393395, 7867.567283799446, 7984.20157984197, 9910.851337229804, 11152.275102118336, 11235.550577977116, 11581.073514119018, 8550.657973680984, 9204.079592040742, 9371.671991480538, 9456.763580910532, 9582.568784404857, 9885.950570247103, 9895.851562226717, 9956.352837065568, 9985.800283994426, 10117.544710487899, 9183.494907780136, 9357.485338306458, 9388.812223755624, 9418.152366287068, 9686.70939871805, 7021.68402421882, 7074.0, 7147.53541019832, 7174.0, 7281.199068102399, 8723.389362744547, 9324.372617535073, 9353.906460935576, 9394.906050939677, 9672.903270967201], "value": 7870.2794284424435, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.33294185262, 1419.340006896793, 1524.2074121456842, 1696.5843368374735, 1742.1202292842113, 6483.805485835433, 7077.6461176941075, 7130.393916517096, 7654.846903061943, 7654.923450765497, 7080.39816615587, 7318.597477138768, 7387.0, 7421.109466863971, 7428.331450169484, 2141.1649456711893, 2170.739511258651, 2175.4561359660083, 2179.9455013624706, 2183.858049226803, 2114.7885211478883, 2152.3758110148037, 2192.9232476863313, 2192.967105493419, 2203.3389983005036, 2154.450615093149, 2155.9461013474634, 2165.2421652421604, 2177.8366622503377, 2187.1907394264144, 2043.4891277180704, 2051.4973831411326, 2053.4763635273057, 2057.7222075019904, 2061.5464597788464, 2059.4748339173416, 2113.1019316790303, 2113.9788602113936, 2120.756113047004, 2125.362391282609, 7255.0, 7255.528390654644, 7299.854002919912, 7310.744123955636, 7333.0, 4191.140816132685, 4220.092680073799, 4222.5566315536735, 4283.271843786564, 4300.569943005706, 2791.092894809175, 2870.3828676834582, 2990.147807874767, 3011.3525591997604, 3014.0, 904.3262769236895, 929.159111004542, 949.2690628216304, 951.6241084771476, 961.9182369498601, 9424.670136545188, 9566.043395660448, 9593.616255349847, 9602.327837051409, 9656.90343096567, 4004.6395824375945, 4087.4481944937647, 4145.709800313949, 4167.291560434734, 4181.038361176947, 8173.468724532886, 8195.631196596167, 8229.177082291722, 8240.62917168729, 8299.377546683902, 4245.0448649053715, 4273.615374616237, 4296.2481565725875, 4299.204647140289, 4315.633171180422, 3416.333814906119, 3825.0, 3959.604039596075, 3965.6629186519467, 3976.76139431635, 3578.7673801202836, 3639.7442882205596, 3675.0, 3719.1260053887313, 3723.94414083789, 1217.3000524698334, 1219.1283232488636, 1222.7798996180595, 1230.2311055590255, 1242.031215651793, 685.1948959972013, 736.5617457612711, 823.7528741377563, 839.8110425154291, 842.6292431330195, 5075.0, 5125.103106956268, 5154.484551544891, 5167.870803229949, 5210.114280572312, 396.0988750592425, 398.88631739954553, 402.47276068350556, 403.22983102274515, 416.3421793566158, 3431.4166591679473, 3620.963790362063, 3624.909377265537, 3645.9817700911326, 3674.356987527172, 8499.277561407225, 8712.39013269065, 8803.207711306013, 8812.206901378906, 8822.161894620001, 8659.826803464022, 8669.263112635497, 8683.56582170889, 8756.824863502694, 8794.42836215644, 6515.54391192612, 6798.898016529756, 6800.931990680129, 6931.861362772817, 6949.999999999899, 5060.51925067118, 5147.9227811582105, 5236.63343565962, 5239.266502689703, 5248.3701955765555, 8308.584570771558, 8467.153284671484, 8475.74572762818, 8495.0, 8566.957165214135, 7954.164812694584, 8365.121662225622, 8365.205305495969, 8556.443831150955, 8558.0, 5910.143029260819, 6144.262688477412, 6317.6209427434505, 6329.968350158219, 6437.806865794034, 7182.748603798842, 7202.063731714844, 7241.710331586678, 7295.671694773854, 7315.085614298213, 6258.906116408167, 6530.575512591857, 6592.0, 6632.071509988509, 6736.5958042517605, 6231.75072997075, 6305.274893387135, 6306.028435830296, 6442.420182183626, 6533.216014078151, 6197.194364732556, 6253.437190652863, 6266.122742815918, 6279.466245369194, 6286.6856657166045, 4238.533761286318, 4332.176886391576, 4361.607455328909, 4401.163778882003, 4432.82268709248, 4252.829886804493, 4474.485434175112, 4537.977310113428, 4575.9771201143785, 4600.355950166912], "value": 3900.4656624482504, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.38455589980003, 285.2924746628362, 291.3430214865478, 293.05197685487457, 294.75829819547965, 4878.121938051149, 4886.731229782361, 5048.697078175312, 5084.186530155176, 5100.285959965608, 4905.460399356068, 4928.654994150411, 4944.629152813544, 4983.900321993558, 4993.950060499394, 3872.3029854626157, 3880.5343358796986, 3898.3957486589484, 3904.219156168763, 3904.6876249900083, 3716.535433070866, 3883.7475564088386, 3885.1064255221318, 3890.502156669674, 3899.415087736834, 3878.0, 3887.7667339959553, 3890.7860067696265, 3891.0661441254038, 3898.8635397761086, 3888.4361767543833, 3900.161465284963, 3906.726529142961, 3909.3354129798004, 3915.6897430515846, 3424.9657503424896, 3436.914077148066, 3452.723782097426, 3488.127968007998, 3496.947545786815, 4582.495925448198, 4867.269909513566, 4879.341288925985, 4914.680545764514, 4920.8031678732805, 4452.220861349283, 4457.9108417831785, 4479.126570318789, 4485.102979404132, 4485.641148708096, 5214.478552144793, 5244.134717771563, 5281.0758117329315, 5322.7072511011875, 5333.306670132897, 3670.1925576373155, 3708.332500149972, 3726.5341832270965, 3756.1173124315765, 3756.69946404287, 5507.862303442446, 5544.944550554484, 5554.527865131468, 5558.526455727203, 5560.525566123077, 3821.426785982125, 3828.904277393032, 3842.193139440749, 3846.442265871433, 3848.5766565677754, 3800.25894950482, 3880.5925377835483, 3898.493195884517, 3901.453796468497, 3921.941170882439, 4356.799816092853, 4369.71596846204, 4370.366296886934, 4382.9342559861625, 4388.846390376321, 5210.895782084337, 5213.488088454382, 5227.242049902743, 5248.422673505911, 5261.316028916216, 1259.508791571288, 1325.8541560428346, 1351.2500562187884, 1352.263016655925, 1356.403182599653, 849.7833052571555, 852.26705033671, 858.3648100405654, 869.7825543614097, 879.7316818370458, 4040.6261870964013, 4059.2287465381482, 4064.4919385076864, 4103.261412945639, 4171.770552619574, 4719.292106184032, 4775.95224047762, 4779.617630589614, 4782.904341913142, 4833.879153021203, 4117.3618089196225, 4132.297509423345, 4135.875923722293, 4136.751794892316, 4198.328267477189, 2610.7911367090587, 2705.742954419327, 2935.398243360106, 2946.7495262902466, 2963.881444742229, 5180.740962951837, 5203.479652034766, 5205.453427390145, 5205.7397130143345, 5228.869278268074, 5390.595705322116, 5616.157576363578, 5621.747021384048, 5628.324601047819, 5648.435156484319, 5197.920831667363, 5217.695576106049, 5228.92156617651, 5233.738313084331, 5238.371395432497, 5460.863478413072, 5483.7258137092185, 5491.505764481216, 5511.779528818803, 5564.91652625219, 5179.741012949413, 5354.411014788292, 5357.410684824744, 5388.332775276107, 5389.86525336854, 5122.1804511278015, 5150.768215430389, 5164.1995490699, 5168.3539557555305, 5186.507281808223, 3751.474793528963, 3788.6400791924725, 3791.241751649736, 3794.051487128218, 3800.3349413853016, 5359.732013399393, 5373.382061063028, 5510.752016159202, 5543.390227074938, 5558.055130627722, 5277.815276465305, 5292.179712144623, 5311.946880531145, 5315.050147168358, 5372.5433338166695, 5207.609429292743, 5233.738313084406, 5273.259824257909, 5314.362276526842, 5377.650452720561, 5032.3206367139965, 5250.553702935294, 5256.553192978639, 5277.604179686462, 5286.841394758163, 5289.7355132244, 5303.090887280653, 5330.7877230948725, 5368.677879327252, 5384.488473595002, 5186.507281808223, 5190.584753219658, 5214.374275087014, 5214.556762675215, 5227.0], "value": 3921.317264588783, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.7977687586222, 618.072890664004, 629.1789215074328, 638.2659941067772, 693.5214701855716, 10390.324628899125, 11595.24630898991, 12110.0, 12246.326452045134, 12319.384030798468, 11711.355875426849, 11822.0, 11875.109366797504, 11925.0, 12547.0, 603.2278683285401, 758.5183408535578, 778.1518145221708, 784.5645666655004, 784.5880912520915, 746.3879618712658, 771.3674786674928, 772.3782355204058, 780.886771418144, 784.9293563579276, 813.1015228172872, 815.4210510537525, 816.2042009041197, 818.8280461103176, 819.7212947597816, 803.7267329108131, 805.2591615713528, 807.4025221336199, 807.64059993303, 809.8137428391474, 587.4243241623191, 587.547588356967, 591.0248090650462, 591.2904514582518, 592.7747455966748, 11821.94089029558, 11919.0, 11932.522699092026, 11960.820587691192, 11975.940120299343, 12213.572524961584, 12551.686207844878, 12710.555130570385, 12941.676458088528, 13181.86818131816, 9848.212143028612, 9907.603695852158, 10075.949620251926, 10170.644027459004, 10221.0, 3318.784279021856, 3320.286138480238, 3337.6495467975756, 3338.21551935295, 3375.0887260439545, 59978.40021599772, 60357.6982115091, 60946.69526652383, 61329.38670613326, 61439.385606144264, 9996.550155243032, 10080.647177348905, 10091.798164036825, 10095.596176153018, 10310.793784124275, 18334.724979125323, 18433.446996590123, 18438.723419148722, 18440.907795461204, 18489.90755046243, 6529.537075378061, 6542.214934207926, 6592.30780768022, 6613.27254002069, 6777.593344399352, 3367.865285388557, 3447.4484082547174, 3482.21650128719, 3486.8430920608635, 3513.350030244413, 2741.12284069096, 2830.150954713578, 2831.971680283212, 2841.105051908642, 2847.3024109093403, 476.8283417969528, 483.5937812237737, 484.40176382167994, 497.9676321039121, 502.3143409246425, 427.20539795979454, 438.02320824561406, 473.6613321475162, 566.9773209071674, 634.3086036220542, 7874.72438464651, 8163.428560000862, 8190.590470476572, 8222.671093156207, 8375.329973602098, 564.1565859040678, 582.0948425198771, 587.806024012075, 594.3640304873744, 607.0742118269674, 3880.8835734927998, 3893.610638936084, 3905.628965248297, 4066.6340029397497, 4088.9182216355507, 82881.58559207286, 83646.0, 84145.0, 87063.0, 87353.0, 80081.39430239944, 80363.19636803673, 81088.59455702684, 81432.18567814365, 82521.0, 67988.0, 69742.0, 72275.0, 72948.27051729521, 73322.6333868338, 6906.93093069083, 7652.885206722015, 7664.578448185403, 7775.611219439119, 7872.527648341118, 41002.384964226156, 42236.577634223264, 43125.78437107794, 43464.0, 43660.0, 37114.25771484609, 61401.0, 62847.6857615709, 62906.37093629005, 63039.0, 9395.15443610051, 9536.380135291462, 10249.590016399261, 10338.0, 11135.498902549243, 12335.876641233473, 12432.378381080729, 12490.562830300896, 12524.436400362189, 12590.937045314715, 11885.46515406826, 12010.459529321377, 12067.155299128977, 12307.138500305251, 12442.37788110609, 11107.278026928223, 11222.7755444889, 11372.260803047775, 11538.0, 11834.349110798988, 11225.270357426742, 11865.406729663655, 11975.940120299343, 12049.216800908263, 12169.209001415235, 9146.954265228898, 9189.540522973959, 9256.72229833106, 9535.904640953502, 9620.0, 10173.644348995169, 10256.230782691178, 10317.535710893178, 10346.5344059516, 10374.533146008296], "value": 6312.778364223056, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1600.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 127.0, 115.0, 116.0, 116.0, 115.0, 114.0, 115.0, 114.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 131.0, 155.0, 194.0, 135.0, 159.0, 162.0, 134.0, 192.0, 131.0], "value": 155.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 166.0, 183.0, 166.0, 161.0, 161.0, 164.0, 163.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 76.0, 165.0, 77.0, 78.0, 78.0, 77.0, 164.0, 78.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 154.0, 85.0, 85.0, 84.0, 144.0, 84.0, 84.0, 133.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 120.0, 118.0, 118.0, 118.0, 119.0, 122.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 149.0, 148.0, 147.0, 148.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 97.0, 96.0, 97.0, 97.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 65.0, 63.0, 63.0, 65.0, 65.0, 63.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 66.0, 66.0, 65.0, 66.0, 66.0, 65.0, 67.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 85.0, 84.0, 86.0, 84.0, 88.0, 86.0, 121.0, 87.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 133.0, 149.0, 146.0, 133.0, 138.0, 150.0, 134.0, 154.0, 137.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 177.0, 179.0, 169.0, 178.0, 175.0, 176.0, 176.0, 171.0, 169.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 68.0, 68.0, 70.0, 67.0, 69.0, 69.0, 68.0, 66.0], "value": 69.1, "unit": "score"}]}]} 13:40:02 INFO - Return code: 0 13:40:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:40:02 ERROR - # TBPL SUCCESS # 13:40:02 INFO - Running post-action listener: _resource_record_post_action 13:40:02 INFO - ##### 13:40:02 INFO - ##### Finished run-tests step (success) 13:40:02 INFO - ##### 13:40:02 INFO - Running post-run listener: _resource_record_post_run 13:40:02 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 535261184; Read time: 0; Write time: 524748 13:40:02 INFO - TinderboxPrint: CPU usage
13.4% 13:40:02 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:40:02 INFO - TinderboxPrint: I/O write bytes / time
535,261,184 / 524,748 13:40:02 INFO - TinderboxPrint: CPU idle
8,265.8 (86.5%) 13:40:02 INFO - TinderboxPrint: CPU user
1,228.9 (12.9%) 13:40:02 INFO - TinderboxPrint: Swap in / out
0 / 0 13:40:02 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237465600; Read time: 0; Write time: 315840 13:40:02 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 297795584; Read time: 0; Write time: 208908 13:40:02 INFO - Running post-run listener: _upload_blobber_files 13:40:02 INFO - Blob upload gear active. 13:40:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:40:02 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 13:40:02 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:40:02 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:40:03 INFO - (blobuploader) - INFO - Open directory for files ... 13:40:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:40:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:40:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:40:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:40:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:40:04 INFO - (blobuploader) - INFO - Done attempting. 13:40:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:40:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:40:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:40:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:40:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:40:08 INFO - (blobuploader) - INFO - Done attempting. 13:40:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:40:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:40:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:40:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:40:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:40:10 INFO - (blobuploader) - INFO - Done attempting. 13:40:10 INFO - (blobuploader) - INFO - Iteration through files over. 13:40:10 INFO - Return code: 0 13:40:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:40:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:40:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/27dd58e2b2cd1652bcf20a4a0054ed19ed433b6d81c6bddcb3159b10028642b19aa0a3bc36e66f4093ef728073189e3f0c58096c6498143acc61cb8e9697017d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/b026db3bfedb0dce0e7dff63ca217445d8c2f1737f6221c41b476a66caa70e424a42fa7f0e9c778df604db4aca873ce3dfb3297e61c61329b5c51b2f6e0517ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/da3bd839790b92b183a0158e549c79200c0acfdd4106ef14ecad12a03ed6479b73450ddb1d86e4c435263ddef73023173fb0e61a1447e1c652269716c377781c"} 13:40:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:40:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:40:10 INFO - Contents: 13:40:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/27dd58e2b2cd1652bcf20a4a0054ed19ed433b6d81c6bddcb3159b10028642b19aa0a3bc36e66f4093ef728073189e3f0c58096c6498143acc61cb8e9697017d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/b026db3bfedb0dce0e7dff63ca217445d8c2f1737f6221c41b476a66caa70e424a42fa7f0e9c778df604db4aca873ce3dfb3297e61c61329b5c51b2f6e0517ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/da3bd839790b92b183a0158e549c79200c0acfdd4106ef14ecad12a03ed6479b73450ddb1d86e4c435263ddef73023173fb0e61a1447e1c652269716c377781c"} 13:40:10 INFO - Running post-run listener: copy_logs_to_upload_dir 13:40:10 INFO - Copying logs to upload dir... 13:40:10 INFO - mkdir: /builds/slave/test/build/upload/logs 13:40:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.958055 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-02 13:40:09.680725) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 13:40:09.684161) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045 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/Larch-Non-PGO/sha512/27dd58e2b2cd1652bcf20a4a0054ed19ed433b6d81c6bddcb3159b10028642b19aa0a3bc36e66f4093ef728073189e3f0c58096c6498143acc61cb8e9697017d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/b026db3bfedb0dce0e7dff63ca217445d8c2f1737f6221c41b476a66caa70e424a42fa7f0e9c778df604db4aca873ce3dfb3297e61c61329b5c51b2f6e0517ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/da3bd839790b92b183a0158e549c79200c0acfdd4106ef14ecad12a03ed6479b73450ddb1d86e4c435263ddef73023173fb0e61a1447e1c652269716c377781c"} build_url:https://queue.taskcluster.net/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011493 build_url: 'https://queue.taskcluster.net/v1/task/f-NArvXPRbSeGcNyBS8lVQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/27dd58e2b2cd1652bcf20a4a0054ed19ed433b6d81c6bddcb3159b10028642b19aa0a3bc36e66f4093ef728073189e3f0c58096c6498143acc61cb8e9697017d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/b026db3bfedb0dce0e7dff63ca217445d8c2f1737f6221c41b476a66caa70e424a42fa7f0e9c778df604db4aca873ce3dfb3297e61c61329b5c51b2f6e0517ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/da3bd839790b92b183a0158e549c79200c0acfdd4106ef14ecad12a03ed6479b73450ddb1d86e4c435263ddef73023173fb0e61a1447e1c652269716c377781c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 13:40:09.714186) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:40:09.714564) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1464896242.469334-873660045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:40:09.806668) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 13:40:09.807050) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 13:40:09.807340) ========= ========= Total master_lag: 0.18 =========