builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1456790867.23 results: success (0) buildid: 20160229152528 builduid: 08b8ec7b0b9c4c4dac8a0f237fa97ce0 revision: b839cf31fa76393f1e2cc7270c88b630ee3e9dc3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:47.235280) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:47.235741) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:47.236022) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006424 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:47.258130) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:47.258458) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:47.272528) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:47.272906) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004626 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:47.322079) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:47.322387) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:47.322748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:47.323050) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 16:07:47-- 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% 226M=0s 2016-02-29 16:07:47 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096068 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:47.431002) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:47.431317) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022133 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:47.480555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:47.480873) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b839cf31fa76393f1e2cc7270c88b630ee3e9dc3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b839cf31fa76393f1e2cc7270c88b630ee3e9dc3 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 16:07:47,616 truncating revision to first 12 chars 2016-02-29 16:07:47,616 Setting DEBUG logging. 2016-02-29 16:07:47,616 attempt 1/10 2016-02-29 16:07:47,616 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b839cf31fa76?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 16:07:47,887 unpacking tar archive at: fx-team-b839cf31fa76/testing/mozharness/ program finished with exit code 0 elapsedTime=0.582974 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:48.076499) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:48.076852) ========= echo b839cf31fa76393f1e2cc7270c88b630ee3e9dc3 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b839cf31fa76393f1e2cc7270c88b630ee3e9dc3'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b839cf31fa76393f1e2cc7270c88b630ee3e9dc3 program finished with exit code 0 elapsedTime=0.004667 script_repo_revision: 'b839cf31fa76393f1e2cc7270c88b630ee3e9dc3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:48.128140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:48.128467) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 16:07:48.138534) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-02-29 16:07:48.138939) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:07:48 INFO - MultiFileLogger online at 20160229 16:07:48 in /builds/slave/test 16:07:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:07:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:07:48 INFO - {'append_to_log': False, 16:07:48 INFO - 'base_work_dir': '/builds/slave/test', 16:07:48 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:07:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:07:48 INFO - 'branch': 'Fx-Team-Non-PGO', 16:07:48 INFO - 'buildbot_json_path': 'buildprops.json', 16:07:48 INFO - 'config_files': ('talos/linux_config.py',), 16:07:48 INFO - 'default_actions': ('clobber', 16:07:48 INFO - 'read-buildbot-config', 16:07:48 INFO - 'download-and-extract', 16:07:48 INFO - 'populate-webroot', 16:07:48 INFO - 'create-virtualenv', 16:07:48 INFO - 'install', 16:07:48 INFO - 'run-tests'), 16:07:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:07:48 INFO - 'download_minidump_stackwalk': True, 16:07:48 INFO - 'download_symbols': 'ondemand', 16:07:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:07:48 INFO - 'tooltool.py': '/tools/tooltool.py', 16:07:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:07:48 INFO - '/tools/misc-python/virtualenv.py')}, 16:07:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:07:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:07:48 INFO - 'installer_path': 'installer.exe', 16:07:48 INFO - 'log_level': 'info', 16:07:48 INFO - 'log_name': 'talos', 16:07:48 INFO - 'log_to_console': True, 16:07:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:07:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:07:48 INFO - 'opt_config_files': (), 16:07:48 INFO - 'pip_index': False, 16:07:48 INFO - 'sps_profile': False, 16:07:48 INFO - 'sps_profile_interval': 0, 16:07:48 INFO - 'suite': 'dromaeojs-e10s', 16:07:48 INFO - 'system_bits': '32', 16:07:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:07:48 INFO - 'title': 'talos-linux64-ix-036', 16:07:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:07:48 INFO - 'use_talos_json': True, 16:07:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:07:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:07:48 INFO - 'work_dir': 'build'} 16:07:48 INFO - ##### 16:07:48 INFO - ##### Running clobber step. 16:07:48 INFO - ##### 16:07:48 INFO - Running pre-action listener: _resource_record_pre_action 16:07:48 INFO - Running main action method: clobber 16:07:48 INFO - rmtree: /builds/slave/test/build 16:07:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:07:48 INFO - Running post-action listener: _resource_record_post_action 16:07:48 INFO - ##### 16:07:48 INFO - ##### Running read-buildbot-config step. 16:07:48 INFO - ##### 16:07:48 INFO - Running pre-action listener: _resource_record_pre_action 16:07:48 INFO - Running main action method: read_buildbot_config 16:07:48 INFO - Using buildbot properties: 16:07:48 INFO - { 16:07:48 INFO - "project": "", 16:07:48 INFO - "product": "firefox", 16:07:48 INFO - "script_repo_revision": "production", 16:07:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:07:48 INFO - "repository": "", 16:07:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 16:07:48 INFO - "buildid": "20160229152528", 16:07:48 INFO - "pgo_build": "False", 16:07:48 INFO - "basedir": "/builds/slave/test", 16:07:48 INFO - "buildnumber": 916, 16:07:48 INFO - "slavename": "talos-linux64-ix-036", 16:07:48 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:07:48 INFO - "platform": "ubuntu64_hw", 16:07:48 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:07:48 INFO - "branch": "fx-team", 16:07:48 INFO - "repo_path": "integration/fx-team", 16:07:48 INFO - "revision": "b839cf31fa76393f1e2cc7270c88b630ee3e9dc3", 16:07:48 INFO - "stage_platform": "linux64", 16:07:48 INFO - "builduid": "08b8ec7b0b9c4c4dac8a0f237fa97ce0", 16:07:48 INFO - "slavebuilddir": "test" 16:07:48 INFO - } 16:07:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 16:07:48 INFO - Running post-action listener: _resource_record_post_action 16:07:48 INFO - ##### 16:07:48 INFO - ##### Running download-and-extract step. 16:07:48 INFO - ##### 16:07:48 INFO - Running pre-action listener: _resource_record_pre_action 16:07:48 INFO - Running main action method: download_and_extract 16:07:48 INFO - mkdir: /builds/slave/test/build/tests 16:07: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')]} 16:07:48 INFO - https://queue.taskcluster.net/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:07:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/test_packages.json 16:07:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/test_packages.json 16:07:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:07:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:07:49 INFO - Downloaded 1448 bytes. 16:07:49 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:07:49 INFO - Using the following test package requirements: 16:07:49 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:07:49 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:49 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:07:49 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:49 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:07:49 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:49 INFO - u'jsshell-linux-x86_64.zip'], 16:07:49 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:49 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:07:49 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:07:49 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:49 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:07:49 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:49 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:07:49 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:49 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:07:49 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:07:49 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:49 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:07:49 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:07:49 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')]} 16:07:49 INFO - https://queue.taskcluster.net/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:07:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:07:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:07:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:07:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:07:51 INFO - Downloaded 22065168 bytes. 16:07:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:07:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:07:52 INFO - Return code: 0 16:07:52 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:07: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')]} 16:07:52 INFO - https://queue.taskcluster.net/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:07:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:07:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:07:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:07:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:07:59 INFO - Downloaded 22065168 bytes. 16:07:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:07:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:08:01 INFO - Return code: 0 16:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:01 INFO - https://queue.taskcluster.net/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:08:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:08:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:08:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:08:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:08:02 INFO - Downloaded 10713410 bytes. 16:08:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:08:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:08:02 INFO - Return code: 0 16:08: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')]} 16:08:02 INFO - https://queue.taskcluster.net/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:08:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:08:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:08:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:08:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:08:04 INFO - Downloaded 54837414 bytes. 16:08:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:08:04 INFO - mkdir: /builds/slave/test/properties 16:08:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:08:04 INFO - Writing to file /builds/slave/test/properties/build_url 16:08:04 INFO - Contents: 16:08:04 INFO - build_url:https://queue.taskcluster.net/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:08:04 INFO - Running post-action listener: _resource_record_post_action 16:08:04 INFO - Running post-action listener: set_extra_try_arguments 16:08:04 INFO - ##### 16:08:04 INFO - ##### Running populate-webroot step. 16:08:04 INFO - ##### 16:08:04 INFO - Running pre-action listener: _resource_record_pre_action 16:08:04 INFO - Running main action method: populate_webroot 16:08:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:08:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:08:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:08:04 INFO - '--tppagecycles', 16:08:04 INFO - '7'], 16:08:04 INFO - 'tests': ['tsvgm']}}, 16:08:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:08:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:08:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:08:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:08:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:08:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:08:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:08:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:04 INFO - 'talos_options': ['--e10s'], 16:08:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:08:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:04 INFO - 'tests': ['damp', 'tps']}, 16:08:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:04 INFO - 'talos_options': ['--e10s'], 16:08:04 INFO - 'tests': ['damp', 'tps']}, 16:08:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:08:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:08:04 INFO - 'other': {'tests': ['a11yr', 16:08:04 INFO - 'ts_paint', 16:08:04 INFO - 'tpaint', 16:08:04 INFO - 'sessionrestore', 16:08:04 INFO - 'sessionrestore_no_auto_restore']}, 16:08:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:08:04 INFO - 'tests': ['a11yr', 16:08:04 INFO - 'ts_paint', 16:08:04 INFO - 'tpaint', 16:08:04 INFO - 'sessionrestore', 16:08:04 INFO - 'sessionrestore_no_auto_restore']}, 16:08:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:08:04 INFO - 'tests': ['a11yr', 16:08:04 INFO - 'ts_paint', 16:08:04 INFO - 'tpaint', 16:08:04 INFO - 'sessionrestore', 16:08:04 INFO - 'sessionrestore_no_auto_restore']}, 16:08:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:08:04 INFO - 'tests': ['a11yr', 16:08:04 INFO - 'ts_paint', 16:08:04 INFO - 'tpaint', 16:08:04 INFO - 'sessionrestore', 16:08:04 INFO - 'sessionrestore_no_auto_restore']}, 16:08:04 INFO - 'other_l64': {'tests': ['a11yr', 16:08:04 INFO - 'ts_paint', 16:08:04 INFO - 'tpaint', 16:08:04 INFO - 'sessionrestore', 16:08:04 INFO - 'sessionrestore_no_auto_restore']}, 16:08:04 INFO - 'other_nol64': {'tests': ['a11yr', 16:08:04 INFO - 'ts_paint', 16:08:04 INFO - 'tpaint', 16:08:04 INFO - 'sessionrestore', 16:08:04 INFO - 'sessionrestore_no_auto_restore']}, 16:08:04 INFO - 'svgr': {'tests': ['tsvgx', 16:08:04 INFO - 'tsvgr_opacity', 16:08:04 INFO - 'tart', 16:08:04 INFO - 'tscrollx', 16:08:04 INFO - 'cart']}, 16:08:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:08:04 INFO - 'tests': ['tsvgx', 16:08:04 INFO - 'tsvgr_opacity', 16:08:04 INFO - 'tart', 16:08:04 INFO - 'tscrollx', 16:08:04 INFO - 'cart']}, 16:08:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:04 INFO - 'tests': ['tp5o']}, 16:08:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:04 INFO - 'talos_options': ['--e10s'], 16:08:04 INFO - 'tests': ['tp5o']}, 16:08:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:04 INFO - 'talos_options': ['--xperf_path', 16:08:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:08:04 INFO - 'tests': ['tp5n']}, 16:08:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:04 INFO - 'talos_options': ['--e10s', 16:08:04 INFO - '--xperf_path', 16:08:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:08:04 INFO - 'tests': ['tp5n']}}, 16:08:04 INFO - 'talos.zip': {'path': '', 16:08:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:08:04 INFO - Running post-action listener: _resource_record_post_action 16:08:04 INFO - ##### 16:08:04 INFO - ##### Running create-virtualenv step. 16:08:04 INFO - ##### 16:08:04 INFO - Running pre-action listener: _resource_record_pre_action 16:08:04 INFO - Running main action method: create_virtualenv 16:08:04 INFO - Creating virtualenv /builds/slave/test/build/venv 16:08:04 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 16:08:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:08:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:08:04 INFO - Using real prefix '/usr' 16:08:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:08:05 INFO - Installing distribute.............................................................................................................................................................................................done. 16:08:07 INFO - Installing pip.................done. 16:08:07 INFO - Return code: 0 16:08:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc97e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecb100>, '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 0xecc000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecc490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', '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 16:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:08:07 INFO - Using env: {'DISPLAY': ':0', 16:08:07 INFO - 'HOME': '/home/cltbld', 16:08:07 INFO - 'LANG': 'en_US.UTF-8', 16:08:07 INFO - 'LANGUAGE': 'en_US:en', 16:08:07 INFO - 'LOGNAME': 'cltbld', 16:08:07 INFO - 'MAIL': '/var/mail/cltbld', 16:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:07 INFO - 'MOZ_NO_REMOTE': '1', 16:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:07 INFO - 'NO_EM_RESTART': '1', 16:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:07 INFO - 'PWD': '/builds/slave/test', 16:08:07 INFO - 'SHELL': '/bin/bash', 16:08:07 INFO - 'SHLVL': '1', 16:08:07 INFO - 'TERM': 'linux', 16:08:07 INFO - 'TMOUT': '86400', 16:08:07 INFO - 'USER': 'cltbld', 16:08:07 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', 16:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:07 INFO - '_': '/tools/buildbot/bin/python'} 16:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:07 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 16:08:07 INFO - Cleaning up... 16:08:07 INFO - Return code: 0 16:08:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc97e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecb100>, '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 0xecc000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecc490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', '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 16:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:08:07 INFO - Using env: {'DISPLAY': ':0', 16:08:07 INFO - 'HOME': '/home/cltbld', 16:08:07 INFO - 'LANG': 'en_US.UTF-8', 16:08:07 INFO - 'LANGUAGE': 'en_US:en', 16:08:07 INFO - 'LOGNAME': 'cltbld', 16:08:07 INFO - 'MAIL': '/var/mail/cltbld', 16:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:07 INFO - 'MOZ_NO_REMOTE': '1', 16:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:07 INFO - 'NO_EM_RESTART': '1', 16:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:07 INFO - 'PWD': '/builds/slave/test', 16:08:07 INFO - 'SHELL': '/bin/bash', 16:08:07 INFO - 'SHLVL': '1', 16:08:07 INFO - 'TERM': 'linux', 16:08:07 INFO - 'TMOUT': '86400', 16:08:07 INFO - 'USER': 'cltbld', 16:08:07 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', 16:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:07 INFO - '_': '/tools/buildbot/bin/python'} 16:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:07 INFO - Downloading/unpacking psutil>=0.7.1 16:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:08:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:08:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:08:09 INFO - Installing collected packages: psutil 16:08:09 INFO - Running setup.py install for psutil 16:08:09 INFO - building 'psutil._psutil_linux' extension 16:08:09 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 16:08:10 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 16:08:10 INFO - building 'psutil._psutil_posix' extension 16:08:10 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 16:08:10 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 16:08:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:08:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:08:10 INFO - Successfully installed psutil 16:08:10 INFO - Cleaning up... 16:08:10 INFO - Return code: 0 16:08:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc97e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecb100>, '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 0xecc000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecc490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', '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 16:08:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:08:10 INFO - Using env: {'DISPLAY': ':0', 16:08:10 INFO - 'HOME': '/home/cltbld', 16:08:10 INFO - 'LANG': 'en_US.UTF-8', 16:08:10 INFO - 'LANGUAGE': 'en_US:en', 16:08:10 INFO - 'LOGNAME': 'cltbld', 16:08:10 INFO - 'MAIL': '/var/mail/cltbld', 16:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:10 INFO - 'MOZ_NO_REMOTE': '1', 16:08:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:10 INFO - 'NO_EM_RESTART': '1', 16:08:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:10 INFO - 'PWD': '/builds/slave/test', 16:08:10 INFO - 'SHELL': '/bin/bash', 16:08:10 INFO - 'SHLVL': '1', 16:08:10 INFO - 'TERM': 'linux', 16:08:10 INFO - 'TMOUT': '86400', 16:08:10 INFO - 'USER': 'cltbld', 16:08:10 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', 16:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:10 INFO - '_': '/tools/buildbot/bin/python'} 16:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:08:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:08:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:08:12 INFO - Installing collected packages: mozsystemmonitor 16:08:12 INFO - Running setup.py install for mozsystemmonitor 16:08:12 INFO - Successfully installed mozsystemmonitor 16:08:12 INFO - Cleaning up... 16:08:12 INFO - Return code: 0 16:08:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdc97e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecb100>, '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 0xecc000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecc490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', '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 16:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:08:12 INFO - Using env: {'DISPLAY': ':0', 16:08:12 INFO - 'HOME': '/home/cltbld', 16:08:12 INFO - 'LANG': 'en_US.UTF-8', 16:08:12 INFO - 'LANGUAGE': 'en_US:en', 16:08:12 INFO - 'LOGNAME': 'cltbld', 16:08:12 INFO - 'MAIL': '/var/mail/cltbld', 16:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:12 INFO - 'MOZ_NO_REMOTE': '1', 16:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:12 INFO - 'NO_EM_RESTART': '1', 16:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:12 INFO - 'PWD': '/builds/slave/test', 16:08:12 INFO - 'SHELL': '/bin/bash', 16:08:12 INFO - 'SHLVL': '1', 16:08:12 INFO - 'TERM': 'linux', 16:08:12 INFO - 'TMOUT': '86400', 16:08:12 INFO - 'USER': 'cltbld', 16:08:12 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', 16:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:12 INFO - '_': '/tools/buildbot/bin/python'} 16:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:12 INFO - Downloading/unpacking blobuploader==1.2.4 16:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:14 INFO - Downloading blobuploader-1.2.4.tar.gz 16:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:08:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:08:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:15 INFO - Downloading docopt-0.6.1.tar.gz 16:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:08:15 INFO - Installing collected packages: blobuploader, requests, docopt 16:08:15 INFO - Running setup.py install for blobuploader 16:08:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:08:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:08:15 INFO - Running setup.py install for requests 16:08:15 INFO - Running setup.py install for docopt 16:08:15 INFO - Successfully installed blobuploader requests docopt 16:08:15 INFO - Cleaning up... 16:08:15 INFO - Return code: 0 16:08:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:15 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 0x7fdc97e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecb100>, '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 0xecc000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecc490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', '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 16:08:15 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 16:08:15 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 16:08:15 INFO - Using env: {'DISPLAY': ':0', 16:08:15 INFO - 'HOME': '/home/cltbld', 16:08:15 INFO - 'LANG': 'en_US.UTF-8', 16:08:15 INFO - 'LANGUAGE': 'en_US:en', 16:08:15 INFO - 'LOGNAME': 'cltbld', 16:08:15 INFO - 'MAIL': '/var/mail/cltbld', 16:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:15 INFO - 'MOZ_NO_REMOTE': '1', 16:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:15 INFO - 'NO_EM_RESTART': '1', 16:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:15 INFO - 'PWD': '/builds/slave/test', 16:08:15 INFO - 'SHELL': '/bin/bash', 16:08:15 INFO - 'SHLVL': '1', 16:08:15 INFO - 'TERM': 'linux', 16:08:15 INFO - 'TMOUT': '86400', 16:08:15 INFO - 'USER': 'cltbld', 16:08:15 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', 16:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:15 INFO - '_': '/tools/buildbot/bin/python'} 16:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:08:16 INFO - Running setup.py (path:/tmp/pip-GVqIFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:08:16 INFO - Running setup.py (path:/tmp/pip-hwmkwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:08:16 INFO - Running setup.py (path:/tmp/pip-AMvToY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:08:16 INFO - Running setup.py (path:/tmp/pip-bYK1oU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:08:16 INFO - Running setup.py (path:/tmp/pip-HNbwWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:08:16 INFO - Running setup.py (path:/tmp/pip-op7MTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:08:16 INFO - Running setup.py (path:/tmp/pip-H2XtZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:08:16 INFO - Running setup.py (path:/tmp/pip-2uwpHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:08:16 INFO - Running setup.py (path:/tmp/pip-s56SQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:08:16 INFO - Running setup.py (path:/tmp/pip-a2Yu4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:08:16 INFO - Running setup.py (path:/tmp/pip-dkJXaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:08:16 INFO - Running setup.py (path:/tmp/pip-Ba0PpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:08:16 INFO - Running setup.py (path:/tmp/pip-hOHCDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:08:17 INFO - Running setup.py (path:/tmp/pip-s95VUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:08:17 INFO - Running setup.py (path:/tmp/pip-leF59x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:08:17 INFO - Running setup.py (path:/tmp/pip-bVVx0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:08:17 INFO - Running setup.py (path:/tmp/pip-2SMtIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:08:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:08:17 INFO - Running setup.py install for manifestparser 16:08:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:08:17 INFO - Running setup.py install for mozcrash 16:08:17 INFO - Running setup.py install for mozdebug 16:08:17 INFO - Running setup.py install for mozdevice 16:08:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:08:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:08:17 INFO - Running setup.py install for mozfile 16:08:17 INFO - Running setup.py install for mozhttpd 16:08:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:08:17 INFO - Running setup.py install for mozinfo 16:08:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:08:18 INFO - Running setup.py install for mozInstall 16:08:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:08:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:08:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:08:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:08:18 INFO - Running setup.py install for mozleak 16:08:18 INFO - Running setup.py install for mozlog 16:08:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:08:18 INFO - Running setup.py install for moznetwork 16:08:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:08:18 INFO - Running setup.py install for mozprocess 16:08:18 INFO - Running setup.py install for mozprofile 16:08:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:08:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:08:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:08:18 INFO - Running setup.py install for mozrunner 16:08:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:08:18 INFO - Running setup.py install for mozscreenshot 16:08:18 INFO - Running setup.py install for moztest 16:08:18 INFO - Running setup.py install for mozversion 16:08:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:08:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:08:19 INFO - Cleaning up... 16:08:19 INFO - Return code: 0 16:08:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:08:19 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')]} 16:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:19 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')]} 16:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:19 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 0x7fdc97e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecb100>, '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 0xecc000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecc490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', '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 16:08:19 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 16:08:19 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 16:08:19 INFO - Using env: {'DISPLAY': ':0', 16:08:19 INFO - 'HOME': '/home/cltbld', 16:08:19 INFO - 'LANG': 'en_US.UTF-8', 16:08:19 INFO - 'LANGUAGE': 'en_US:en', 16:08:19 INFO - 'LOGNAME': 'cltbld', 16:08:19 INFO - 'MAIL': '/var/mail/cltbld', 16:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:19 INFO - 'MOZ_NO_REMOTE': '1', 16:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:19 INFO - 'NO_EM_RESTART': '1', 16:08:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:19 INFO - 'PWD': '/builds/slave/test', 16:08:19 INFO - 'SHELL': '/bin/bash', 16:08:19 INFO - 'SHLVL': '1', 16:08:19 INFO - 'TERM': 'linux', 16:08:19 INFO - 'TMOUT': '86400', 16:08:19 INFO - 'USER': 'cltbld', 16:08:19 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', 16:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:19 INFO - '_': '/tools/buildbot/bin/python'} 16:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:08:19 INFO - Running setup.py (path:/tmp/pip-ULtjHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:08:19 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)) 16:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:08:19 INFO - Running setup.py (path:/tmp/pip-vnyNTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 16:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:08:19 INFO - Running setup.py (path:/tmp/pip-jweRxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:08:19 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)) 16:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:08:19 INFO - Running setup.py (path:/tmp/pip-ln7ALh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:08:19 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)) 16:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:08:19 INFO - Running setup.py (path:/tmp/pip-2yUfLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:08:19 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)) 16:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:08:19 INFO - Running setup.py (path:/tmp/pip-eJr8ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:08:19 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)) 16:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:08:19 INFO - Running setup.py (path:/tmp/pip-nDtb23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:08:19 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)) 16:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:08:19 INFO - Running setup.py (path:/tmp/pip-vtnCmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:08:19 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)) 16:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:08:19 INFO - Running setup.py (path:/tmp/pip-1PS01k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:08:19 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)) 16:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:08:19 INFO - Running setup.py (path:/tmp/pip-pnCcPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:08:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:08:20 INFO - Running setup.py (path:/tmp/pip-cQgZk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:08:20 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)) 16:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:08:20 INFO - Running setup.py (path:/tmp/pip-Y_aNW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:08:20 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)) 16:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:08:20 INFO - Running setup.py (path:/tmp/pip-4CinKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:08:20 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)) 16:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:08:20 INFO - Running setup.py (path:/tmp/pip-pc5BKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:08:20 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)) 16:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:08:20 INFO - Running setup.py (path:/tmp/pip-_xQZSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:08:20 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)) 16:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:08:20 INFO - Running setup.py (path:/tmp/pip-Noxkpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:08:20 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)) 16:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:08:20 INFO - Running setup.py (path:/tmp/pip-1BgGYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:08:20 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)) 16:08:20 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:08:20 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:08:20 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)) 16:08:20 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)) 16:08:20 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)) 16:08:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:08:20 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 16:08:20 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 16:08:20 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 16:08:20 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 16:08:20 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 16:08:20 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 16:08:22 INFO - Downloading blessings-1.6.tar.gz 16:08:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:08:22 INFO - Installing collected packages: blessings 16:08:22 INFO - Running setup.py install for blessings 16:08:22 INFO - Successfully installed blessings 16:08:22 INFO - Cleaning up... 16:08:22 INFO - Return code: 0 16:08:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:08:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:08:22 INFO - Reading from file tmpfile_stdout 16:08:22 INFO - Current package versions: 16:08:22 INFO - argparse == 1.2.1 16:08:22 INFO - blessings == 1.6 16:08:22 INFO - blobuploader == 1.2.4 16:08:22 INFO - docopt == 0.6.1 16:08:22 INFO - manifestparser == 1.1 16:08:22 INFO - mozInstall == 1.12 16:08:22 INFO - mozcrash == 0.16 16:08:22 INFO - mozdebug == 0.1 16:08:22 INFO - mozdevice == 0.48 16:08:22 INFO - mozfile == 1.2 16:08:22 INFO - mozhttpd == 0.7 16:08:22 INFO - mozinfo == 0.9 16:08:22 INFO - mozleak == 0.1 16:08:22 INFO - mozlog == 3.1 16:08:22 INFO - moznetwork == 0.27 16:08:22 INFO - mozprocess == 0.22 16:08:22 INFO - mozprofile == 0.28 16:08:22 INFO - mozrunner == 6.11 16:08:22 INFO - mozscreenshot == 0.1 16:08:22 INFO - mozsystemmonitor == 0.0 16:08:22 INFO - moztest == 0.7 16:08:22 INFO - mozversion == 1.4 16:08:22 INFO - psutil == 3.1.1 16:08:22 INFO - requests == 1.2.3 16:08:22 INFO - wsgiref == 0.1.2 16:08:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:22 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 0x7fdc97e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecb100>, '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 0xecc000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecc490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', '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 16:08:22 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 16:08:22 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 16:08:22 INFO - Using env: {'DISPLAY': ':0', 16:08:22 INFO - 'HOME': '/home/cltbld', 16:08:22 INFO - 'LANG': 'en_US.UTF-8', 16:08:22 INFO - 'LANGUAGE': 'en_US:en', 16:08:22 INFO - 'LOGNAME': 'cltbld', 16:08:22 INFO - 'MAIL': '/var/mail/cltbld', 16:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:22 INFO - 'MOZ_NO_REMOTE': '1', 16:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:22 INFO - 'NO_EM_RESTART': '1', 16:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:22 INFO - 'PWD': '/builds/slave/test', 16:08:22 INFO - 'SHELL': '/bin/bash', 16:08:22 INFO - 'SHLVL': '1', 16:08:22 INFO - 'TERM': 'linux', 16:08:22 INFO - 'TMOUT': '86400', 16:08:22 INFO - 'USER': 'cltbld', 16:08:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', 16:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:22 INFO - '_': '/tools/buildbot/bin/python'} 16:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:23 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)) 16:08:23 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)) 16:08:23 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)) 16:08:23 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)) 16:08:23 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)) 16:08:23 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)) 16:08:23 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)) 16:08:23 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)) 16:08:23 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)) 16:08:23 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)) 16:08:23 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)) 16:08:23 INFO - Cleaning up... 16:08:23 INFO - Return code: 0 16:08:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:23 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 0x7fdc97e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecb100>, '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 0xecc000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecc490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', '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 16:08:23 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 16:08:23 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 16:08:23 INFO - Using env: {'DISPLAY': ':0', 16:08:23 INFO - 'HOME': '/home/cltbld', 16:08:23 INFO - 'LANG': 'en_US.UTF-8', 16:08:23 INFO - 'LANGUAGE': 'en_US:en', 16:08:23 INFO - 'LOGNAME': 'cltbld', 16:08:23 INFO - 'MAIL': '/var/mail/cltbld', 16:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:23 INFO - 'MOZ_NO_REMOTE': '1', 16:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:23 INFO - 'NO_EM_RESTART': '1', 16:08:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:23 INFO - 'PWD': '/builds/slave/test', 16:08:23 INFO - 'SHELL': '/bin/bash', 16:08:23 INFO - 'SHLVL': '1', 16:08:23 INFO - 'TERM': 'linux', 16:08:23 INFO - 'TMOUT': '86400', 16:08:23 INFO - 'USER': 'cltbld', 16:08:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', 16:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:23 INFO - '_': '/tools/buildbot/bin/python'} 16:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:23 INFO - Downloading/unpacking jsonschema 16:08:23 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 16:08:23 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 16:08:23 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 16:08:23 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 16:08:23 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 16:08:23 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 16:08:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:08:25 INFO - Downloading/unpacking functools32 (from jsonschema) 16:08:25 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 16:08:25 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 16:08:25 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 16:08:25 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 16:08:25 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 16:08:25 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 16:08:25 INFO - Downloading functools32-3.2.3-2.tar.gz 16:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:08:25 INFO - warning: no files found matching '*.txt' 16:08:25 INFO - no previously-included directories found matching 'build' 16:08:25 INFO - no previously-included directories found matching 'dist' 16:08:25 INFO - no previously-included directories found matching '.git*' 16:08:25 INFO - Installing collected packages: jsonschema, functools32 16:08:25 INFO - Running setup.py install for functools32 16:08:25 INFO - warning: no files found matching '*.txt' 16:08:25 INFO - no previously-included directories found matching 'build' 16:08:25 INFO - no previously-included directories found matching 'dist' 16:08:25 INFO - no previously-included directories found matching '.git*' 16:08:25 INFO - Successfully installed jsonschema functools32 16:08:25 INFO - Cleaning up... 16:08:25 INFO - Return code: 0 16:08:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:08:25 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')]} 16:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:25 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')]} 16:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:25 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 0x7fdc97e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe3c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecb100>, '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 0xecc000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecc490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', '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 16:08:25 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 16:08:25 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 16:08:25 INFO - Using env: {'DISPLAY': ':0', 16:08:25 INFO - 'HOME': '/home/cltbld', 16:08:25 INFO - 'LANG': 'en_US.UTF-8', 16:08:25 INFO - 'LANGUAGE': 'en_US:en', 16:08:25 INFO - 'LOGNAME': 'cltbld', 16:08:25 INFO - 'MAIL': '/var/mail/cltbld', 16:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:25 INFO - 'MOZ_NO_REMOTE': '1', 16:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:25 INFO - 'NO_EM_RESTART': '1', 16:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:25 INFO - 'PWD': '/builds/slave/test', 16:08:25 INFO - 'SHELL': '/bin/bash', 16:08:25 INFO - 'SHLVL': '1', 16:08:25 INFO - 'TERM': 'linux', 16:08:25 INFO - 'TMOUT': '86400', 16:08:25 INFO - 'USER': 'cltbld', 16:08:25 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', 16:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:25 INFO - '_': '/tools/buildbot/bin/python'} 16:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:25 INFO - Downloading/unpacking flake8 16:08:25 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 16:08:25 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 16:08:25 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 16:08:25 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 16:08:25 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 16:08:25 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 16:08:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:08:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:08:27 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 16:08:27 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 16:08:27 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 16:08:27 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 16:08:27 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 16:08:27 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 16:08:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:08:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:08:27 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 16:08:27 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 16:08:27 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 16:08:27 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 16:08:27 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 16:08:27 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 16:08:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:08:27 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 16:08:27 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 16:08:27 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 16:08:27 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 16:08:27 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 16:08:27 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 16:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:08:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:08:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:08:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:08:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:08:28 INFO - no previously-included directories found matching 'docs/_build' 16:08:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:08:28 INFO - Running setup.py install for pep8 16:08:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:08:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:08:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:08:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:08:28 INFO - no previously-included directories found matching 'docs/_build' 16:08:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:08:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:08:28 INFO - Cleaning up... 16:08:28 INFO - Return code: 0 16:08:28 INFO - Running post-action listener: _resource_record_post_action 16:08:28 INFO - Running post-action listener: _start_resource_monitoring 16:08:28 INFO - Starting resource monitoring. 16:08:28 INFO - ##### 16:08:28 INFO - ##### Running install step. 16:08:28 INFO - ##### 16:08:28 INFO - Running pre-action listener: _resource_record_pre_action 16:08:28 INFO - Running main action method: install 16:08:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:08:28 INFO - Reading from file tmpfile_stdout 16:08:28 INFO - Detecting whether we're running mozinstall >=1.0... 16:08:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:08:28 INFO - Reading from file tmpfile_stdout 16:08:28 INFO - Output received: 16:08:28 INFO - Usage: mozinstall [options] installer 16:08:28 INFO - Options: 16:08:28 INFO - -h, --help show this help message and exit 16:08:28 INFO - -d DEST, --destination=DEST 16:08:28 INFO - Directory to install application into. [default: 16:08:28 INFO - "/builds/slave/test"] 16:08:28 INFO - --app=APP Application being installed. [default: firefox] 16:08:28 INFO - mkdir: /builds/slave/test/build/application 16:08:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:08:44 INFO - Reading from file tmpfile_stdout 16:08:44 INFO - Output received: 16:08:44 INFO - /builds/slave/test/build/application/firefox/firefox 16:08:44 INFO - Running post-action listener: _resource_record_post_action 16:08:44 INFO - ##### 16:08:44 INFO - ##### Running run-tests step. 16:08:44 INFO - ##### 16:08:44 INFO - Running pre-action listener: _resource_record_pre_action 16:08:44 INFO - Running main action method: run_tests 16:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:08:44 INFO - Python 2.7.3 16:08:44 INFO - Return code: 0 16:08:44 INFO - grabbing minidump binary from tooltool 16:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecb100>, '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 0xecc000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecc490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:08:44 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 16:08:44 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 16:08:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:08:44 INFO - Return code: 0 16:08:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:08:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:08:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:08:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:08:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:08:45 INFO - Return code: 0 16:08:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 16:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 16:08:45 INFO - Using env: {'DISPLAY': ':0', 16:08:45 INFO - 'HOME': '/home/cltbld', 16:08:45 INFO - 'LANG': 'en_US.UTF-8', 16:08:45 INFO - 'LANGUAGE': 'en_US:en', 16:08:45 INFO - 'LOGNAME': 'cltbld', 16:08:45 INFO - 'MAIL': '/var/mail/cltbld', 16:08:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:08:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:45 INFO - 'MOZ_NO_REMOTE': '1', 16:08:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:45 INFO - 'NO_EM_RESTART': '1', 16:08:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:45 INFO - 'PWD': '/builds/slave/test', 16:08:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:08:45 INFO - 'SHELL': '/bin/bash', 16:08:45 INFO - 'SHLVL': '1', 16:08:45 INFO - 'TERM': 'linux', 16:08:45 INFO - 'TMOUT': '86400', 16:08:45 INFO - 'USER': 'cltbld', 16:08:45 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466', 16:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:45 INFO - '_': '/tools/buildbot/bin/python'} 16:08:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 16:08:46 INFO - mozversion application_buildid: 20160229152528 16:08:46 INFO - mozversion application_changeset: b839cf31fa76393f1e2cc7270c88b630ee3e9dc3 16:08:46 INFO - mozversion application_display_name: Nightly 16:08:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:08:46 INFO - mozversion application_name: Firefox 16:08:46 INFO - mozversion application_remotingname: firefox 16:08:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:08:46 INFO - mozversion application_vendor: Mozilla 16:08:46 INFO - mozversion application_version: 47.0a1 16:08:46 INFO - mozversion platform_buildid: 20160229152528 16:08:46 INFO - mozversion platform_changeset: b839cf31fa76393f1e2cc7270c88b630ee3e9dc3 16:08:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:08:46 INFO - mozversion platform_version: 47.0a1 16:08:46 INFO - using testdate: 1456790926 16:08:46 INFO - actual date: 1456790926 16:08:46 INFO - starting webserver on 'localhost:49454' 16:08:46 INFO - SUITE-START | Running 2 tests 16:08:46 INFO - TEST-START | dromaeo_css 16:08:46 INFO - operating with platform_type : linux_ 16:08:46 INFO - Initialising browser for dromaeo_css test... 16:08:46 INFO - TEST-INFO | started process 6918 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw6yxIx/profile http://localhost:49454/getInfo.html) 16:08:50 INFO - PROCESS | 6918 | 16:08:50 INFO - PROCESS | 6918 | (process:7002): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:08:51 INFO - PROCESS | 6918 | __metrics Screen width/height:1600/1200 16:08:51 INFO - PROCESS | 6918 | colorDepth:24 16:08:51 INFO - PROCESS | 6918 | Browser inner width/height: 1024/697 16:08:51 INFO - PROCESS | 6918 | __metrics 16:08:51 ERROR - PROCESS | 6918 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:08:51 INFO - PROCESS | 6918 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:08:51 INFO - PROCESS | 6918 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:08:51 INFO - PROCESS | 6918 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:08:51 INFO - PROCESS | 6918 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:08:51 INFO - PROCESS | 6918 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:08:51 INFO - PROCESS | 6918 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:08:51 INFO - PROCESS | 6918 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:08:51 INFO - PROCESS | 6918 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:08:51 INFO - PROCESS | 6918 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:08:52 INFO - TEST-INFO | 6918: exit 0 16:08:52 INFO - Browser initialized. 16:08:52 INFO - Running cycle 1/1 for dromaeo_css test... 16:08:52 INFO - TEST-INFO | started process 7053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw6yxIx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:54 INFO - PROCESS | 7053 | 16:08:54 INFO - PROCESS | 7053 | (process:7108): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:09:04 INFO - PROCESS | 7053 | RSS: Main: 161288192 16:09:04 INFO - PROCESS | 7053 | 16:09:54 INFO - PROCESS | 7053 | 1456790994434 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] 16:12:06 INFO - PROCESS | 7053 | Cycle 1(1): loaded http://localhost:49454/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49454/tests/dromaeo/cssquery-ext.html) 16:12:07 INFO - PROCESS | 7053 | RSS: Main: 170270720 16:12:07 INFO - PROCESS | 7053 | 16:15:09 INFO - PROCESS | 7053 | Cycle 1(1): loaded http://localhost:49454/tests/dromaeo/cssquery-ext.html (next: http://localhost:49454/tests/dromaeo/cssquery-jquery.html) 16:15:09 INFO - PROCESS | 7053 | RSS: Main: 164966400 16:15:09 INFO - PROCESS | 7053 | 16:18:11 INFO - PROCESS | 7053 | Cycle 1(1): loaded http://localhost:49454/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49454/tests/dromaeo/cssquery-mootools.html) 16:18:12 INFO - PROCESS | 7053 | RSS: Main: 166559744 16:18:12 INFO - PROCESS | 7053 | 16:21:13 INFO - PROCESS | 7053 | Cycle 1(1): loaded http://localhost:49454/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49454/tests/dromaeo/cssquery-prototype.html) 16:21:14 INFO - PROCESS | 7053 | RSS: Main: 164278272 16:21:14 INFO - PROCESS | 7053 | 16:24:17 INFO - PROCESS | 7053 | Cycle 1(1): loaded http://localhost:49454/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49454/tests/dromaeo/cssquery-yui.html) 16:24:17 INFO - PROCESS | 7053 | RSS: Main: 163958784 16:24:17 INFO - PROCESS | 7053 | 16:27:20 INFO - PROCESS | 7053 | Cycle 1(1): loaded http://localhost:49454/tests/dromaeo/cssquery-yui.html (next: http://localhost:49454/tests/dromaeo/cssquery-dojo.html) 16:27:20 INFO - PROCESS | 7053 | RSS: Main: 168398848 16:27:20 INFO - PROCESS | 7053 | 16:27:20 INFO - PROCESS | 7053 | __start_tp_report 16:27:20 INFO - PROCESS | 7053 | _x_x_mozilla_page_load 16:27:20 INFO - PROCESS | 7053 | _x_x_mozilla_page_load_details 16:27:20 INFO - PROCESS | 7053 | |i|pagename|runs| 16:27:20 INFO - PROCESS | 7053 | |0;dojo.html;2622.47550489902;2651.82763120397;2671.866406679667;2690.6367640368558;2699.3791427971564;4506.211413002719;4626.236670949298;4631.120087183437;4661.091087237985;4683.695559788612;4594.40272764541;4656.998745269766;4689.835855745049;4690.624750019999;4735.408073990751;3998.452338389353;4209.49486061673;4222.725522841013;4269.487661480626;4379.693421460499;4283.993261583525;4328.2209202343565;4344.78276086196;4373.562643735633;4389.429374181352;4154.667626589866;4181.289180839264;4278.44380230568;4313.870583882457;4317.740935543878;4224.112936283384;4236.6187043165955;4249.830006799755;4273.3162693969125;4298.74207547545;4115.34154535273;4241.957580424187;4243.066525364415;4259.531451540328;4261.7229880058;4531.43357080365;4610.077984403133;4648.465426475965;4657.953420465786;4663.440387153563;4914.238293064581;4948.802047918079;4964.60283177345;4977.452480227172;5005.449400565934;4788.11419887322;4992.775325110379;4995.325631039799;5007.173816320303;5050.191969284897;4648.721076735406;4684.695494792828;4721.5278472153195;4724.976375118103;4746.264329029006;5123.641345105807;5150.613703972217;5152.690838549699;5172.818951336685;5183.118869792144;4668.85993420198;4723.055388922161;4850.660453768273;4948.628852836052;4993.775280112403;4872.220444728897;4934.037862616755;4947.579455746302;4968.8757781055765;4985.351904252424;4883.877903052381;4916.582090522345;4917.360743103373;4921.729304888194;4940.8764780880765;4770.403699537558;4889.168841296988;4910.968696573759;4935.506449355035;4971.1797553404;4130.855420060344;4150.584941505886;4155.355919832431;4182.2681030819485;4193.014641559231;3647.598764135943;3648.6533779290926;3649.872254471081;3660.176460296412;3679.0434487033563;4268.850590229389;4317.654587632982;4331.545187755303;4367.039251364695;4374.934375984363;5042.974785126051;5062.190049592047;5081.898362032739;5087.236914462786;5130.076586214443;4201.138766552849;4369.978150109229;4394.692371534026;4401.317795741666;4432.822687092545;4461.152381047591;4484.596386325246;4502.941808674958;4512.165249428801;4520.163769702615;4731.432228132646;4760.285957106462;4761.619070474423;4765.11845308619;4770.045990801854;4870.245112007645;4971.279164521196;5048.141815891234;5049.84850454487;5069.163588008085;4644.93032604518;4663.370444989883;4674.275487299474;4686.554777296152;4709.858704238878;4861.4895435978715;4865.9270110947655;4868.026394720999;4874.195757700081;4904.558589726942;4819.927701084416;4920.778564964657;4956.330895329084;4958.355413796184;5015.974920125376;4702.27114797207;4801.4958429364415;4801.855944321676;4840.370751802384;4861.829835955725;4717.198076326964;4765.975315307087;4794.640401969797;4800.039992001543;4851.417829860439;4552.476465206543;4647.55848194421;4715.056988602362;4737.123632128068;4756.928646070242;4893.217085266483;4924.113659541317;4928.975355123202;4940.60475161979;4978.626603004862;4755.239161734106;4773.775581794614;4797.112534181188;4800.039992001543;4824.276358546246 16:27:20 INFO - PROCESS | 7053 | |1;ext.html;489.2099259695588;489.48359480747797;508.5600955173775;532.8880935003649;533.4958464251282;32227.35545289096;32338;32627.347453050923;32727.181820454472;32773.344533109324;36137.638623613755;36538.08654783632;36538.634613653856;36637.816810915974;36902.44646330307;7585.810354741134;7714.691412343527;7737.110232323271;7756.069271687377;7769.611519424035;7548.5848278344665;7665.655045522937;7706.7302644407455;7713.382929365637;7714.19001004892;7834.451588388815;7921.920780792176;7922.207779222061;7928.207179282083;7936.801579960518;7866.6460009299435;7886.487378320391;7922.683092676286;7936.404769642242;7952.125266220711;7709.229077092302;7781.377489800802;7802.492837965514;7827.921720782776;7848.332891704212;36047;36127.63872361269;36348.454773178426;36448.81775591105;36486.27027459462;2203.4160947348964;2652.38995031142;2663.9600405993924;2691.448253108108;2925.736683698456;24564.263072107864;24878.50242995148;24897.5020499589;24956.625650615257;25097.874510627513;2990.9401811963858;2992.0874133389307;3032.5602787595676;3068.9846550767325;3112.7821052526333;147552;147900;148024;148486;148691;39103.80448097798;51876.22185667218;52245.7387713059;52247;52435.21347179796;37002.44496332503;37014.25971480555;37025.444618330206;37158.628413716055;37206.25587488289;11383;11565.710857228469;11586.36275004866;11592.420378981185;11629.127815413878;8686.261667758185;8762.86855697165;8786.956065219632;8819.823603528022;8832.779180520538;12943.446786385693;13038.674033149247;13351.46458157305;13565.389557469938;13579.660508487366;5513.2005859150195;5525.530329921921;5597.888042239214;5613.186088017214;5627.46539078795;880.3881302494705;904.3759805734154;928.01630271912;967.6032826541084;1011.1506334678758;25049.87475062613;26193.704095466503;26326.736732632427;26346.473070538483;26731;897.6221499997473;941.8634298026748;950.9001554836781;966.6278482784179;1024.9545463627207;13734.45062197521;13905.582832515041;14110.082844615066;14121;14230.786538201935;254739;255863;258750;259992;260623;44661;45099.549004509536;45238.773806131416;45641.31538026932;45793.5420645796;1125.6341688951125;1167.0780083733755;1201.7716633839543;1203.741195642941;1217.8964787992943;25295.74704252934;25713.357166070997;25734.871325643253;25904.352391189615;26189;39543;39963.40420851523;39966.80016599898;40018.19963600653;40076.599234007284;241098;242893;243533;244408;244710;29311;29715.405691886474;42430.78784606057;42855.14289714126;43090.78454607707;37826.62173378231;37997;38198.2360352797;39035;39197;32169.195770105936;32348.807304698876;32479.512807307437;33241.83379083089;33271.66728332686;31522.842385787924;31935.201619959687;32092.358152837278;32470;32501.674983249864;31673.524897127023;31747.206319841265;32307;32428.73364307597;32598.34803303968;28443.28891777722;29783.255418614706;29910.700892991663;30064.398712026075;30075.248118797204;23624.29127126189;23653.399295405554;24046.27861164168;24064.398390040387;24103.758962410153 16:27:20 INFO - PROCESS | 7053 | |2;jquery.html;328.1959199960097;338.23221287676984;340.99488507672373;342.963988781178;344.1671155802957;15000.174990375539;15218.239088045595;15940.36238550458;16155.43455979041;16215.51353459395;14660.780088298658;14931.328090235966;15009.774853377208;15484.767728484081;15571.844281557182;4857.319975203474;5059.316992206061;5082.720450375228;5085.593152547805;5096.490350964911;4920.852374428773;4969.602431805447;5050.217216331456;5068.518490743373;5078.339815823938;4966.329545511346;4974.651774375795;4979.676321039139;4984.177610694231;4988.152014157602;4804.087223427555;4977.55202031817;5007.424146223177;5029.346184995927;5038.2190760432195;4469.240229161051;4481.9103617927785;4484.304932735431;4487.416635837353;4489.1919454498175;18059.54851128719;18328.175232114587;18799.530011749677;18960;18998.905005474884;1848.9445316640522;1862.4971257760465;1883.3031778242;2081.6669332906813;2280.977190228093;11283.605073822377;12259.877401225962;12364.876351236553;12652.367381630882;12722.300273484954;1638.3774165817033;1645.1116397145527;1661.7175080236268;1689.4847071643144;1695.2879790488025;53793.193102103105;56102;56823;57142.428575714126;57195.142072868526;9200.631974720936;9236.953815230881;9545.952270238604;9557.569909353957;9652.517374131265;11920.403979800974;12087.697807554881;12094.032477401786;12111.757764844653;12128.75742485163;6333.303336632966;6527.510436717265;6585.506087043395;6649.168853893263;6703.597784132968;6148.893199224093;6218.160548326008;6308.621482711052;6315.842103947346;6332.810015699536;5652.745626446737;5766.106253530709;5793.15999180125;5793.681347525927;5909.409059094056;1711.3924556782413;1729.0835856995811;1750.81616430273;1757.9560510987328;1761.383515769496;846.2299307630027;858.7895965488495;898.3576742629051;907.5416914458289;922.6540047482194;15396.846031539766;15440.150791706565;15801.683966320608;15859.127747973742;15949.840501595068;854.9700760473354;886.964521419136;894.2443635128307;895.7536677413764;907.1835348186685;9046.909530904739;9097.954510227406;9107.635694572144;9147.588358523883;9316.906830931604;341124;346384.8255747376;350075;350221;350355;41741.79129104335;49601.25598116031;56527.869442610914;57735.26794196181;59138.11292830611;924.4591913730409;944.7213072143734;945.2815859946353;951.2485136741897;953.9761505962267;14285.357158927665;14474.927625361806;14476.276186190858;14486.492972745904;14684.85315146835;28582.285442864093;29121.85439072791;29828.254293642833;29876.402471950005;29893.701062989963;37446.43830342602;38486.42270365891;38622.61377386303;38925.416118757676;39105.80447097746;6823.55646882951;6943.305669433218;7069.045678833498;7156.141263048467;7192.496525243392;10452.477376131315;10671.839922401325;10766.192535560021;10869;10974.780504390028;5874.118882167709;5976.432238937294;9180.908190918273;9383.296252780932;9503.429794212369;8937.955310223668;9077.409968352036;9296.674616388394;9397.577109030246;9558.091981261769;8867.512286824287;9636.951815240878;9690.079442452956;9787.804243915225;10118;6809.65951702403;6915;6966.616836074065;6980.267071957372;7091.042709234187;9632.325737198329;9650.613975440903;9653.806923861624;9678.75803104928;9781.364211326241 16:27:20 INFO - PROCESS | 7053 | |3;mootools.html;1372.231550331814;1387.5143699705104;1499.5501349595127;1683.4108062178248;1707.4024091567944;5998.400159983999;6917.550359226647;7000.229974702785;7163.820904477384;7165.534240274378;6959.304069593039;7049.577025378468;7058.929410705891;7071;7101.8224544386285;2077.439091445309;2084.291340944086;2086.645270304052;2093.9371818845457;2097.968530472044;2040.8673436226597;2041.6631255842767;2044.94887627809;2087.1859974609915;2089.1956596710224;2060.093558834116;2085.2388878059473;2089.2165437960766;2101.0965284927474;2109.915603375863;2098.685197220414;2105.284203370846;2107.1887323380456;2109.0298462707174;2109.0825490911425;2081.438011736823;2089.039042040663;2116.132385721862;2116.185268671557;2126.457753272921;7079.929200707978;7150.856982860366;7159.57042577447;7179.569225846466;7206.099237595301;4210.810513526868;4263.893402664927;4279.5078565965005;4282.614564689193;4299.269124248885;2562.1160699558623;2566.358410397401;2602.8828702708424;2705.485957668037;2708.9322766930786;837.7319257837495;844.252836239926;867.2324992381724;873.0789017586444;875.2647775868301;9621.90378096224;9633.710988670351;9668.081532254424;9676.371035882645;9684.225261979025;3855.9614403856162;3918.0596656802163;4013.458183145238;4015.4177644242004;4025.4364388985564;8100.189981001853;8125.1062383137805;8143.918560814434;8167;8191.71329003494;4232.32282834745;4265.338872474771;4288.549702281278;4299.9785001075425;4302.376155457441;3107.6270847498445;3774.5659249186697;3776.773393596393;3782.8108594570162;3791.696664266852;3390.1694084949345;3426;3429.3141371725756;3458.4639380896;3467.924943267595;1095.3537412926412;1103.586155191803;1106.1427393769732;1109.073923274059;1110.4225802582612;809.3363441977522;809.3727361295043;812.4028838803474;815.559597817184;825.3809642767924;6631.33686631333;6652;6657.833554161185;6684.131062961881;6690.799276021728;409.2939679053668;412.3402555910519;413.0973822198506;415.55535576932994;453.9886502837455;5205.167173252262;5218.765155568009;5228.843134705965;5251.921221181686;5289.021531016774;8390.538520381315;8562.571871406404;8663.78340541479;8720.8691869622;8843;8526.40315177944;8615.095414981337;8624.95687521571;8698.869516957251;8754.824903502022;6804.489663275274;6828.863422731518;6855.417289530346;6956.095707557985;7004.299570042853;6545.312742162005;6572.572782769296;6578.638174900427;6590.373914478117;6596.076549283008;7608.543487390774;7715.22847715224;7752.806179845549;7880.645370958436;7885.093214280431;7810.3751699865015;8052.114267430461;8111.553864537507;8112.18878112184;8118.675252989814;5123.077845987609;5998.670073146019;6177.505799535937;6230.345813689679;6247;6801.5238933274195;6848.3494068063455;6852.554583952027;6854.862902741817;6900.171979362509;5877.735501902339;5939.643621382731;5986.970065149646;6046.183765191643;6085.965385884322;6094.969525152346;6202.937970620416;6218.689065546795;6269.62382257066;6317.178766760292;6524.151860258136;6606.009098635051;6620.2386725527185;6621.735130594722;6658.467322614276;5814.30228372598;5853.239078919713;5898.056310990221;5900.055991041413;5926.585139040226;6080.847978800565;6175.59858609189;6194.38056194377;6246.593971391845;6262.279837818709 16:27:20 INFO - PROCESS | 7053 | |4;prototype.html;287.24597930432617;295.28393645409875;298.20528292101545;300.59719975233185;301.6124280299814;5651.180578816069;5678.971605141974;5725.255716756821;5791.942080579193;5875.265591801025;5645.576581756364;5730.7707691692285;5738.770449182038;5749.540036797057;5755.712214389285;4157.833686652531;4252.447181866353;4268.829246830123;4279.379489973952;4286.292761694324;4247.745135291877;4262.680298977589;4283.164782867342;4283.593058659438;4289.742615443068;4236.4704411948505;4247.108107297471;4247.851325203618;4249.490061192646;4254.553271906451;4251.341042138458;4253.766042867641;4254.851080212208;4263.786810659454;4268.996785755345;3674.52231209941;3674.761140525884;3676.117731744389;3677;3682.429223470366;5403.567714582824;5435.755391007375;5468.9726551367385;5474.616776825624;5481.616286859921;4779.2874336072055;4836.8875158713345;4872.0499502597;4891.070696567676;4895.339129217546;5877.706114694291;5886.617369870987;5889.882202355929;5910.852228694274;5931.317898441648;3966.5835087315995;3973.7417067890783;3988.501437320335;3991.481107456012;3993.3610622300293;6196.535259855529;6247.031710084944;6279.7174127163935;6305.369463053704;6319.399657032621;4094.8566800161852;4101.589841015874;4105.0763578194665;4108.383742438598;4115.300398932189;4124.566920473367;4162.771047592411;4164.271252530795;4167.333226683716;4170.70805043644;4625.560571745679;4796.640251981045;4847.321375007502;4847.394075740533;4858.514148585114;5976.252968378953;5977.731002104916;5989.401059893976;5997.370276121032;6017.06735456005;1444.8844092472577;1458.7520121579357;1463.8828893688478;1465.9664936220152;1471.433498103238;941.5857022910035;952.961272213277;965.0735294117726;978.3493976505545;980.9411435313904;5173.456787037307;5176.50823171798;5177.7152256625495;5182.300389447451;5183.637145399785;6134.141220229171;6167.938320616737;6187.226596675416;6198.0702894566175;6204.689765511706;5146.356705411824;5157.226416037549;5165.431802501722;5167.276581278624;5176.663516871391;3284.9835750821094;3382.8139452329865;3397.6262611112757;3408.625051244361;3412.19813343864;5852.858692554911;5853.912191317134;5873.9412605873395;5882.529397648178;5897.144913987448;6412.807615771534;6435.131257280207;6444.806655800334;6465.191851018622;6500.382463666038;5844.094165404369;5864.2083318752275;5867.413258674099;5884.176215329857;5892.381299963527;6003.879922401615;6009.579329446897;6027.849303767441;6236.469900058546;6265.122882796321;6041.486473649789;6042.8791424170395;6051.273847138372;6127.908081378872;6129.295131059806;5813.651180929158;5821;5821.76712931478;5832.600175957825;5842.853928651648;4000.3199456093116;4037.37420699792;4051.7568945862163;4058.6144316289906;4075.49056367954;6240.812775616739;6283.3088360281245;6290.182276304051;6295.55931084838;6296.968515157395;5789.45000224978;5958.404159584007;5962.2249107615735;5980.671063091571;6047.123167140828;5974.671393073423;6022;6023.668698221464;6044.063170208625;6044.88169688609;5857.912131318119;5880.882382352243;5893.174955506318;5894.469497745224;5902.203202567598;6058.0610005449225;6062.484688801501;6068.726907289094;6071.787487437919;6077.331493535619;5485.204645326485;5635.633683810539;5707.68607726579;5920.526357891272;5920.615160014585 16:27:20 INFO - PROCESS | 7053 | |5;yui.html;564.2805423085568;655.1254075808795;683.9692213850376;706.8374273916999;723.8588475247326;10199.082082612573;10315.742106447342;10327.431991240488;10340.534675939582;10343.741406464842;11050.613228537002;11335.659930202108;11447.59933402329;11534.307941523515;12822.487100515968;756.825930036092;771.9884201736978;773.0452890680006;780.8282177920877;781.4022272961189;763.6181909045478;765.0169532151186;766.624354066509;767.3362541401704;771.3713323641242;792.8810678398257;801.8356236971407;801.9278264956182;802.6468353924283;803.5459965119688;800.0359566722086;800.2837460472873;800.8798680197958;802.0936341933636;802.2779498451382;596.397638385234;597.8445604142911;598.0849300570135;599.053495477145;599.2718846601357;11129.666110016713;11145.832812507819;11176.944115279372;11225.66323010311;11254.324740515513;11704.590339338167;11774.352410617412;11976.341301228429;12088.576899808553;12178.330191839445;8753.7811554711;8799.78000549985;8889.155530224683;8933;8954.776130596721;3216.5175223716396;3228.418884600771;3261.168402057484;3263.7225835803984;3290.3912776136253;35860.64139358599;38294.42558361627;38858;40521;41531.584684152775;9142;9280.95359523198;9589.130119626745;9595.42427454355;9655.71032869001;15422.768658470131;15469;15480.845191548166;15489.922550387177;15508.069515829086;6381.298057213703;6495.577787443801;6512.187961806609;6543.214814222229;6591;3204.919877003047;3284.310294838063;3314.4034073866937;3374.6287908330064;3414.9146271343416;2509.1845150326217;2524.1670248817845;2531.316544533003;2541.4917016596755;2542.275451496315;460.5854730742359;461.7114303560275;464.8349835808307;469.3710428026461;473.0019658520519;518.2381898609038;554.692145859044;587.3539106982286;591.775125452334;601.5712682379349;7549.6225188740345;7579.204183560647;7580.204078571671;7580.9620951894885;7714.845703085907;597.1758972617846;600.2257088355972;600.4535872356134;600.8738164985315;607.8146165419502;3467.3758723430024;3521.084518025332;3589.6769290763955;3611.8194090295906;3670.4127339626066;45278;45811.31283030757;46191.30713039307;46965.76517117392;46993.295100573516;38991.22017559633;39469.80265098656;39501.80249098794;39524.802375987936;39619;39019.41470877939;39742;39838.99999999942;40347.394789078186;40764.592354076674;7567.470277080552;7631.771046868603;7647.235276472308;7744.148143704076;7992.160823113722;28485.287867803472;28876.70054847579;29458;29623;29736.702632973393;33788.49317260194;35758.64241357553;35849;36193.27613447663;37018.444723328634;9694.951525242328;9742.95128524353;9802.558884850056;9924.702258932244;9951.900480995097;9819.803603928025;10179.93110723393;10235.283530153116;11044.226904116957;11797.528098876292;10226.6420675276;10259;10400.895991039994;10754.193435492212;10987.61543345979;9652.420854748738;9739.610415583298;10089.041541053588;10258;10355.275130740776;9722.562484688347;9870.605175792887;10156;10675.039246467855;10761.730956726144;8154.836903261783;8209.179082091743;8252.587370631565;8444.197801208875;8505.574721264036;8429.957850210709;8525.27223140164;8547.316214702932;8728.08355122703;8775.956120219358 16:27:20 INFO - PROCESS | 7053 | __end_tp_report 16:27:20 INFO - PROCESS | 7053 | __start_cc_report 16:27:20 INFO - PROCESS | 7053 | _x_x_mozilla_cycle_collect,343 16:27:20 INFO - PROCESS | 7053 | __end_cc_report 16:27:20 INFO - PROCESS | 7053 | __startTimestamp1456792040363__endTimestamp 16:27:20 INFO - PROCESS | 7053 | 16:27:20 INFO - PROCESS | 7053 | ------- Summary: start ------- 16:27:20 INFO - PROCESS | 7053 | Number of tests: 6 16:27:20 INFO - PROCESS | 7053 | 16:27:20 INFO - PROCESS | 7053 | [#0] dojo.html Cycles:165 Average:4593.36 Median:4721.53 stddev:476.34 (10.1%) stddev-sans-first:452.01 16:27:20 INFO - PROCESS | 7053 | Values: 2622.5 2651.8 2671.9 2690.6 2699.4 4506.2 4626.2 4631.1 4661.1 4683.7 4594.4 4657.0 4689.8 4690.6 4735.4 3998.5 4209.5 4222.7 4269.5 4379.7 4284.0 4328.2 4344.8 4373.6 4389.4 4154.7 4181.3 4278.4 4313.9 4317.7 4224.1 4236.6 4249.8 4273.3 4298.7 4115.3 4242.0 4243.1 4259.5 4261.7 4531.4 4610.1 4648.5 4658.0 4663.4 4914.2 4948.8 4964.6 4977.5 5005.4 4788.1 4992.8 4995.3 5007.2 5050.2 4648.7 4684.7 4721.5 4725.0 4746.3 5123.6 5150.6 5152.7 5172.8 5183.1 4668.9 4723.1 4850.7 4948.6 4993.8 4872.2 4934.0 4947.6 4968.9 4985.4 4883.9 4916.6 4917.4 4921.7 4940.9 4770.4 4889.2 4911.0 4935.5 4971.2 4130.9 4150.6 4155.4 4182.3 4193.0 3647.6 3648.7 3649.9 3660.2 3679.0 4268.9 4317.7 4331.5 4367.0 4374.9 5043.0 5062.2 5081.9 5087.2 5130.1 4201.1 4370.0 4394.7 4401.3 4432.8 4461.2 4484.6 4502.9 4512.2 4520.2 4731.4 4760.3 4761.6 4765.1 4770.0 4870.2 4971.3 5048.1 5049.8 5069.2 4644.9 4663.4 4674.3 4686.6 4709.9 4861.5 4865.9 4868.0 4874.2 4904.6 4819.9 4920.8 4956.3 4958.4 5016.0 4702.3 4801.5 4801.9 4840.4 4861.8 4717.2 4766.0 4794.6 4800.0 4851.4 4552.5 4647.6 4715.1 4737.1 4756.9 4893.2 4924.1 4929.0 4940.6 4978.6 4755.2 4773.8 4797.1 4800.0 4824.3 16:27:20 INFO - PROCESS | 7053 | 16:27:20 INFO - PROCESS | 7053 | [#1] ext.html Cycles:180 Average:36983.05 Median:32750.26 stddev:57923.46 (176.9%) stddev-sans-first:58021.14 16:27:20 INFO - PROCESS | 7053 | Values: 489.2 489.5 508.6 532.9 533.5 32227.4 32338.0 32627.3 32727.2 32773.3 36137.6 36538.1 36538.6 36637.8 36902.4 7585.8 7714.7 7737.1 7756.1 7769.6 7548.6 7665.7 7706.7 7713.4 7714.2 7834.5 7921.9 7922.2 7928.2 7936.8 7866.6 7886.5 7922.7 7936.4 7952.1 7709.2 7781.4 7802.5 7827.9 7848.3 36047.0 36127.6 36348.5 36448.8 36486.3 2203.4 2652.4 2664.0 2691.4 2925.7 24564.3 24878.5 24897.5 24956.6 25097.9 2990.9 2992.1 3032.6 3069.0 3112.8 147552.0 147900.0 148024.0 148486.0 148691.0 39103.8 51876.2 52245.7 52247.0 52435.2 37002.4 37014.3 37025.4 37158.6 37206.3 11383.0 11565.7 11586.4 11592.4 11629.1 8686.3 8762.9 8787.0 8819.8 8832.8 12943.4 13038.7 13351.5 13565.4 13579.7 5513.2 5525.5 5597.9 5613.2 5627.5 880.4 904.4 928.0 967.6 1011.2 25049.9 26193.7 26326.7 26346.5 26731.0 897.6 941.9 950.9 966.6 1025.0 13734.5 13905.6 14110.1 14121.0 14230.8 254739.0 255863.0 258750.0 259992.0 260623.0 44661.0 45099.5 45238.8 45641.3 45793.5 1125.6 1167.1 1201.8 1203.7 1217.9 25295.7 25713.4 25734.9 25904.4 26189.0 39543.0 39963.4 39966.8 40018.2 40076.6 241098.0 242893.0 243533.0 244408.0 244710.0 29311.0 29715.4 42430.8 42855.1 43090.8 37826.6 37997.0 38198.2 39035.0 39197.0 32169.2 32348.8 32479.5 33241.8 33271.7 31522.8 31935.2 32092.4 32470.0 32501.7 31673.5 31747.2 32307.0 32428.7 32598.3 28443.3 29783.3 29910.7 30064.4 30075.2 23624.3 23653.4 24046.3 24064.4 24103.8 16:27:20 INFO - PROCESS | 7053 | 16:27:20 INFO - PROCESS | 7053 | [#2] jquery.html Cycles:180 Average:21114.97 Median:4981.93 stddev:56853.74 (1141.2%) stddev-sans-first:56991.80 16:27:20 INFO - PROCESS | 7053 | Values: 328.2 338.2 341.0 343.0 344.2 15000.2 15218.2 15940.4 16155.4 16215.5 14660.8 14931.3 15009.8 15484.8 15571.8 4857.3 5059.3 5082.7 5085.6 5096.5 4920.9 4969.6 5050.2 5068.5 5078.3 4966.3 4974.7 4979.7 4984.2 4988.2 4804.1 4977.6 5007.4 5029.3 5038.2 4469.2 4481.9 4484.3 4487.4 4489.2 18059.5 18328.2 18799.5 18960.0 18998.9 1848.9 1862.5 1883.3 2081.7 2281.0 11283.6 12259.9 12364.9 12652.4 12722.3 1638.4 1645.1 1661.7 1689.5 1695.3 53793.2 56102.0 56823.0 57142.4 57195.1 9200.6 9237.0 9546.0 9557.6 9652.5 11920.4 12087.7 12094.0 12111.8 12128.8 6333.3 6527.5 6585.5 6649.2 6703.6 6148.9 6218.2 6308.6 6315.8 6332.8 5652.7 5766.1 5793.2 5793.7 5909.4 1711.4 1729.1 1750.8 1758.0 1761.4 846.2 858.8 898.4 907.5 922.7 15396.8 15440.2 15801.7 15859.1 15949.8 855.0 887.0 894.2 895.8 907.2 9046.9 9098.0 9107.6 9147.6 9316.9 341124.0 346384.8 350075.0 350221.0 350355.0 41741.8 49601.3 56527.9 57735.3 59138.1 924.5 944.7 945.3 951.2 954.0 14285.4 14474.9 14476.3 14486.5 14684.9 28582.3 29121.9 29828.3 29876.4 29893.7 37446.4 38486.4 38622.6 38925.4 39105.8 6823.6 6943.3 7069.0 7156.1 7192.5 10452.5 10671.8 10766.2 10869.0 10974.8 5874.1 5976.4 9180.9 9383.3 9503.4 8938.0 9077.4 9296.7 9397.6 9558.1 8867.5 9637.0 9690.1 9787.8 10118.0 6809.7 6915.0 6966.6 6980.3 7091.0 9632.3 9650.6 9653.8 9678.8 9781.4 16:27:20 INFO - PROCESS | 7053 | 16:27:20 INFO - PROCESS | 7053 | [#3] mootools.html Cycles:180 Average:4955.68 Median:6176.55 stddev:2618.28 (42.4%) stddev-sans-first:2611.78 16:27:20 INFO - PROCESS | 7053 | Values: 1372.2 1387.5 1499.6 1683.4 1707.4 5998.4 6917.6 7000.2 7163.8 7165.5 6959.3 7049.6 7058.9 7071.0 7101.8 2077.4 2084.3 2086.6 2093.9 2098.0 2040.9 2041.7 2044.9 2087.2 2089.2 2060.1 2085.2 2089.2 2101.1 2109.9 2098.7 2105.3 2107.2 2109.0 2109.1 2081.4 2089.0 2116.1 2116.2 2126.5 7079.9 7150.9 7159.6 7179.6 7206.1 4210.8 4263.9 4279.5 4282.6 4299.3 2562.1 2566.4 2602.9 2705.5 2708.9 837.7 844.3 867.2 873.1 875.3 9621.9 9633.7 9668.1 9676.4 9684.2 3856.0 3918.1 4013.5 4015.4 4025.4 8100.2 8125.1 8143.9 8167.0 8191.7 4232.3 4265.3 4288.5 4300.0 4302.4 3107.6 3774.6 3776.8 3782.8 3791.7 3390.2 3426.0 3429.3 3458.5 3467.9 1095.4 1103.6 1106.1 1109.1 1110.4 809.3 809.4 812.4 815.6 825.4 6631.3 6652.0 6657.8 6684.1 6690.8 409.3 412.3 413.1 415.6 454.0 5205.2 5218.8 5228.8 5251.9 5289.0 8390.5 8562.6 8663.8 8720.9 8843.0 8526.4 8615.1 8625.0 8698.9 8754.8 6804.5 6828.9 6855.4 6956.1 7004.3 6545.3 6572.6 6578.6 6590.4 6596.1 7608.5 7715.2 7752.8 7880.6 7885.1 7810.4 8052.1 8111.6 8112.2 8118.7 5123.1 5998.7 6177.5 6230.3 6247.0 6801.5 6848.3 6852.6 6854.9 6900.2 5877.7 5939.6 5987.0 6046.2 6086.0 6095.0 6202.9 6218.7 6269.6 6317.2 6524.2 6606.0 6620.2 6621.7 6658.5 5814.3 5853.2 5898.1 5900.1 5926.6 6080.8 6175.6 6194.4 6246.6 6262.3 16:27:20 INFO - PROCESS | 7053 | 16:27:20 INFO - PROCESS | 7053 | [#4] prototype.html Cycles:180 Average:4902.54 Median:5716.47 stddev:1491.81 (26.1%) stddev-sans-first:1455.22 16:27:20 INFO - PROCESS | 7053 | Values: 287.2 295.3 298.2 300.6 301.6 5651.2 5679.0 5725.3 5791.9 5875.3 5645.6 5730.8 5738.8 5749.5 5755.7 4157.8 4252.4 4268.8 4279.4 4286.3 4247.7 4262.7 4283.2 4283.6 4289.7 4236.5 4247.1 4247.9 4249.5 4254.6 4251.3 4253.8 4254.9 4263.8 4269.0 3674.5 3674.8 3676.1 3677.0 3682.4 5403.6 5435.8 5469.0 5474.6 5481.6 4779.3 4836.9 4872.0 4891.1 4895.3 5877.7 5886.6 5889.9 5910.9 5931.3 3966.6 3973.7 3988.5 3991.5 3993.4 6196.5 6247.0 6279.7 6305.4 6319.4 4094.9 4101.6 4105.1 4108.4 4115.3 4124.6 4162.8 4164.3 4167.3 4170.7 4625.6 4796.6 4847.3 4847.4 4858.5 5976.3 5977.7 5989.4 5997.4 6017.1 1444.9 1458.8 1463.9 1466.0 1471.4 941.6 953.0 965.1 978.3 980.9 5173.5 5176.5 5177.7 5182.3 5183.6 6134.1 6167.9 6187.2 6198.1 6204.7 5146.4 5157.2 5165.4 5167.3 5176.7 3285.0 3382.8 3397.6 3408.6 3412.2 5852.9 5853.9 5873.9 5882.5 5897.1 6412.8 6435.1 6444.8 6465.2 6500.4 5844.1 5864.2 5867.4 5884.2 5892.4 6003.9 6009.6 6027.8 6236.5 6265.1 6041.5 6042.9 6051.3 6127.9 6129.3 5813.7 5821.0 5821.8 5832.6 5842.9 4000.3 4037.4 4051.8 4058.6 4075.5 6240.8 6283.3 6290.2 6295.6 6297.0 5789.5 5958.4 5962.2 5980.7 6047.1 5974.7 6022.0 6023.7 6044.1 6044.9 5857.9 5880.9 5893.2 5894.5 5902.2 6058.1 6062.5 6068.7 6071.8 6077.3 5485.2 5635.6 5707.7 5920.5 5920.6 16:27:20 INFO - PROCESS | 7053 | 16:27:20 INFO - PROCESS | 7053 | [#5] yui.html Cycles:180 Average:11586.76 Median:467.10 stddev:12843.15 (2749.5%) stddev-sans-first:12852.50 16:27:20 INFO - PROCESS | 7053 | Values: 564.3 655.1 684.0 706.8 723.9 10199.1 10315.7 10327.4 10340.5 10343.7 11050.6 11335.7 11447.6 11534.3 12822.5 756.8 772.0 773.0 780.8 781.4 763.6 765.0 766.6 767.3 771.4 792.9 801.8 801.9 802.6 803.5 800.0 800.3 800.9 802.1 802.3 596.4 597.8 598.1 599.1 599.3 11129.7 11145.8 11176.9 11225.7 11254.3 11704.6 11774.4 11976.3 12088.6 12178.3 8753.8 8799.8 8889.2 8933.0 8954.8 3216.5 3228.4 3261.2 3263.7 3290.4 35860.6 38294.4 38858.0 40521.0 41531.6 9142.0 9281.0 9589.1 9595.4 9655.7 15422.8 15469.0 15480.8 15489.9 15508.1 6381.3 6495.6 6512.2 6543.2 6591.0 3204.9 3284.3 3314.4 3374.6 3414.9 2509.2 2524.2 2531.3 2541.5 2542.3 460.6 461.7 464.8 469.4 473.0 518.2 554.7 587.4 591.8 601.6 7549.6 7579.2 7580.2 7581.0 7714.8 597.2 600.2 600.5 600.9 607.8 3467.4 3521.1 3589.7 3611.8 3670.4 45278.0 45811.3 46191.3 46965.8 46993.3 38991.2 39469.8 39501.8 39524.8 39619.0 39019.4 39742.0 39839.0 40347.4 40764.6 7567.5 7631.8 7647.2 7744.1 7992.2 28485.3 28876.7 29458.0 29623.0 29736.7 33788.5 35758.6 35849.0 36193.3 37018.4 9695.0 9743.0 9802.6 9924.7 9951.9 9819.8 10179.9 10235.3 11044.2 11797.5 10226.6 10259.0 10400.9 10754.2 10987.6 9652.4 9739.6 10089.0 10258.0 10355.3 9722.6 9870.6 10156.0 10675.0 10761.7 8154.8 8209.2 8252.6 8444.2 8505.6 8430.0 8525.3 8547.3 8728.1 8776.0 16:27:20 INFO - PROCESS | 7053 | -------- Summary: end -------- 16:27:20 INFO - PROCESS | 7053 | 16:27:20 INFO - PROCESS | 7053 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:27:20 INFO - PROCESS | 7053 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:27:20 INFO - PROCESS | 7053 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:27:20 INFO - PROCESS | 7053 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:27:20 INFO - PROCESS | 7053 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:27:20 INFO - PROCESS | 7053 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:27:20 INFO - PROCESS | 7053 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:27:20 INFO - PROCESS | 7053 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:27:21 INFO - TEST-INFO | 7053: exit 0 16:27:21 INFO - TEST-OK | dromaeo_css | took 1115020ms 16:27:21 INFO - TEST-START | kraken 16:27:21 INFO - operating with platform_type : linux_ 16:27:21 INFO - Initialising browser for kraken test... 16:27:21 INFO - TEST-INFO | started process 7289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMPOYls/profile http://localhost:49454/getInfo.html) 16:27:25 INFO - PROCESS | 7289 | 16:27:25 INFO - PROCESS | 7289 | (process:7359): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:27:26 INFO - PROCESS | 7289 | __metrics Screen width/height:1600/1200 16:27:26 INFO - PROCESS | 7289 | colorDepth:24 16:27:26 INFO - PROCESS | 7289 | Browser inner width/height: 1024/697 16:27:26 INFO - PROCESS | 7289 | __metrics 16:27:26 ERROR - PROCESS | 7289 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:27:26 INFO - PROCESS | 7289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:27:26 INFO - PROCESS | 7289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:27:26 INFO - PROCESS | 7289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:27:26 INFO - PROCESS | 7289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:27:26 INFO - PROCESS | 7289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:27:26 INFO - PROCESS | 7289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:27:26 INFO - PROCESS | 7289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:27:26 INFO - PROCESS | 7289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:27:26 INFO - PROCESS | 7289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:27:27 INFO - TEST-INFO | 7289: exit 0 16:27:27 INFO - Browser initialized. 16:27:27 INFO - Running cycle 1/1 for kraken test... 16:27:27 INFO - TEST-INFO | started process 7410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMPOYls/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:27:29 INFO - PROCESS | 7410 | 16:27:29 INFO - PROCESS | 7410 | (process:7466): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:27:39 INFO - PROCESS | 7410 | RSS: Main: 161562624 16:27:39 INFO - PROCESS | 7410 | 16:27:42 INFO - PROCESS | 7410 | Cycle 1(1): loaded http://localhost:49454/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49454/tests/kraken/driver.html?testName=audio-beat-detection) 16:27:43 INFO - PROCESS | 7410 | RSS: Main: 167305216 16:27:43 INFO - PROCESS | 7410 | 16:27:45 INFO - PROCESS | 7410 | Cycle 1(1): loaded http://localhost:49454/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49454/tests/kraken/driver.html?testName=audio-dft) 16:27:46 INFO - PROCESS | 7410 | RSS: Main: 169807872 16:27:46 INFO - PROCESS | 7410 | 16:27:49 INFO - PROCESS | 7410 | Cycle 1(1): loaded http://localhost:49454/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49454/tests/kraken/driver.html?testName=audio-fft) 16:27:50 INFO - PROCESS | 7410 | RSS: Main: 165224448 16:27:50 INFO - PROCESS | 7410 | 16:27:52 INFO - PROCESS | 7410 | Cycle 1(1): loaded http://localhost:49454/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49454/tests/kraken/driver.html?testName=audio-oscillator) 16:27:52 INFO - PROCESS | 7410 | RSS: Main: 164831232 16:27:52 INFO - PROCESS | 7410 | 16:27:54 INFO - PROCESS | 7410 | Cycle 1(1): loaded http://localhost:49454/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49454/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:27:55 INFO - PROCESS | 7410 | RSS: Main: 164302848 16:27:55 INFO - PROCESS | 7410 | 16:27:58 INFO - PROCESS | 7410 | Cycle 1(1): loaded http://localhost:49454/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49454/tests/kraken/driver.html?testName=imaging-darkroom) 16:27:59 INFO - PROCESS | 7410 | RSS: Main: 166735872 16:27:59 INFO - PROCESS | 7410 | 16:28:02 INFO - PROCESS | 7410 | Cycle 1(1): loaded http://localhost:49454/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49454/tests/kraken/driver.html?testName=imaging-desaturate) 16:28:03 INFO - PROCESS | 7410 | RSS: Main: 164139008 16:28:03 INFO - PROCESS | 7410 | 16:28:06 INFO - PROCESS | 7410 | Cycle 1(1): loaded http://localhost:49454/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49454/tests/kraken/driver.html?testName=json-parse-financial) 16:28:06 INFO - PROCESS | 7410 | RSS: Main: 163028992 16:28:06 INFO - PROCESS | 7410 | 16:28:08 INFO - PROCESS | 7410 | Cycle 1(1): loaded http://localhost:49454/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49454/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:28:09 INFO - PROCESS | 7410 | RSS: Main: 164573184 16:28:09 INFO - PROCESS | 7410 | 16:28:11 INFO - PROCESS | 7410 | Cycle 1(1): loaded http://localhost:49454/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49454/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:28:11 INFO - PROCESS | 7410 | RSS: Main: 163762176 16:28:11 INFO - PROCESS | 7410 | 16:28:13 INFO - PROCESS | 7410 | Cycle 1(1): loaded http://localhost:49454/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49454/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:28:14 INFO - PROCESS | 7410 | RSS: Main: 163606528 16:28:14 INFO - PROCESS | 7410 | 16:28:17 INFO - PROCESS | 7410 | Cycle 1(1): loaded http://localhost:49454/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:28:17 INFO - PROCESS | 7410 | RSS: Main: 163966976 16:28:17 INFO - PROCESS | 7410 | 16:28:20 INFO - PROCESS | 7410 | Cycle 1(1): loaded http://localhost:49454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:28:21 INFO - PROCESS | 7410 | RSS: Main: 163663872 16:28:21 INFO - PROCESS | 7410 | 16:28:22 INFO - PROCESS | 7410 | Cycle 1(1): loaded http://localhost:49454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49454/tests/kraken/driver.html?testName=ai-astar) 16:28:23 INFO - PROCESS | 7410 | RSS: Main: 166600704 16:28:23 INFO - PROCESS | 7410 | 16:28:23 INFO - PROCESS | 7410 | __start_tp_report 16:28:23 INFO - PROCESS | 7410 | _x_x_mozilla_page_load 16:28:23 INFO - PROCESS | 7410 | _x_x_mozilla_page_load_details 16:28:23 INFO - PROCESS | 7410 | |i|pagename|runs| 16:28:23 INFO - PROCESS | 7410 | |0;ai-astar;114;111;116;114;116;125;114;113;115;115 16:28:23 INFO - PROCESS | 7410 | |1;audio-beat-detection;157;139;155;168;139;152;155;137;184;144 16:28:23 INFO - PROCESS | 7410 | |2;audio-dft;162;162;163;162;168;171;162;164;166;163 16:28:23 INFO - PROCESS | 7410 | |3;audio-fft;74;74;73;74;74;153;74;74;75;74 16:28:23 INFO - PROCESS | 7410 | |4;audio-oscillator;98;98;143;101;98;98;138;100;99;141 16:28:23 INFO - PROCESS | 7410 | |5;imaging-gaussian-blur;120;116;116;116;116;116;116;116;117;115 16:28:23 INFO - PROCESS | 7410 | |6;imaging-darkroom;149;148;148;148;148;149;148;149;149;148 16:28:23 INFO - PROCESS | 7410 | |7;imaging-desaturate;97;96;97;96;97;96;97;98;96;97 16:28:23 INFO - PROCESS | 7410 | |8;json-parse-financial;69;67;67;68;67;67;67;76;65;65 16:28:23 INFO - PROCESS | 7410 | |9;json-stringify-tinderbox;71;71;71;72;71;71;72;72;72;71 16:28:23 INFO - PROCESS | 7410 | |10;stanford-crypto-aes;84;86;85;85;86;85;87;85;85;86 16:28:23 INFO - PROCESS | 7410 | |11;stanford-crypto-ccm;127;123;133;128;133;132;127;126;125;134 16:28:23 INFO - PROCESS | 7410 | |12;stanford-crypto-pbkdf2;139;155;142;151;150;138;161;157;151;138 16:28:23 INFO - PROCESS | 7410 | |13;stanford-crypto-sha256-iterative;72;73;74;73;71;71;71;71;70;70 16:28:23 INFO - PROCESS | 7410 | __end_tp_report 16:28:23 INFO - PROCESS | 7410 | __start_cc_report 16:28:23 INFO - PROCESS | 7410 | _x_x_mozilla_cycle_collect,874 16:28:23 INFO - PROCESS | 7410 | __end_cc_report 16:28:23 INFO - PROCESS | 7410 | __startTimestamp1456792103088__endTimestamp 16:28:23 INFO - PROCESS | 7410 | 16:28:23 INFO - PROCESS | 7410 | ------- Summary: start ------- 16:28:23 INFO - PROCESS | 7410 | Number of tests: 14 16:28:23 INFO - PROCESS | 7410 | 16:28:23 INFO - PROCESS | 7410 | [#0] ai-astar Cycles:10 Average:115.30 Median:115.00 stddev:3.71 (3.2%) stddev-sans-first:3.91 16:28:23 INFO - PROCESS | 7410 | Values: 114.0 111.0 116.0 114.0 116.0 125.0 114.0 113.0 115.0 115.0 16:28:23 INFO - PROCESS | 7410 | 16:28:23 INFO - PROCESS | 7410 | [#1] audio-beat-detection Cycles:10 Average:153.00 Median:155.00 stddev:14.68 (9.5%) stddev-sans-first:15.50 16:28:23 INFO - PROCESS | 7410 | Values: 157.0 139.0 155.0 168.0 139.0 152.0 155.0 137.0 184.0 144.0 16:28:23 INFO - PROCESS | 7410 | 16:28:23 INFO - PROCESS | 7410 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:3.09 (1.9%) stddev-sans-first:3.17 16:28:23 INFO - PROCESS | 7410 | Values: 162.0 162.0 163.0 162.0 168.0 171.0 162.0 164.0 166.0 163.0 16:28:23 INFO - PROCESS | 7410 | 16:28:23 INFO - PROCESS | 7410 | [#3] audio-fft Cycles:10 Average:81.90 Median:74.00 stddev:24.99 (33.8%) stddev-sans-first:26.34 16:28:23 INFO - PROCESS | 7410 | Values: 74.0 74.0 73.0 74.0 74.0 153.0 74.0 74.0 75.0 74.0 16:28:23 INFO - PROCESS | 7410 | 16:28:23 INFO - PROCESS | 7410 | [#4] audio-oscillator Cycles:10 Average:111.40 Median:98.00 stddev:20.26 (20.7%) stddev-sans-first:20.90 16:28:23 INFO - PROCESS | 7410 | Values: 98.0 98.0 143.0 101.0 98.0 98.0 138.0 100.0 99.0 141.0 16:28:23 INFO - PROCESS | 7410 | 16:28:23 INFO - PROCESS | 7410 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.00 stddev:1.35 (1.2%) stddev-sans-first:0.50 16:28:23 INFO - PROCESS | 7410 | Values: 120.0 116.0 116.0 116.0 116.0 116.0 116.0 116.0 117.0 115.0 16:28:23 INFO - PROCESS | 7410 | 16:28:23 INFO - PROCESS | 7410 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:0.52 (0.3%) stddev-sans-first:0.50 16:28:23 INFO - PROCESS | 7410 | Values: 149.0 148.0 148.0 148.0 148.0 149.0 148.0 149.0 149.0 148.0 16:28:23 INFO - PROCESS | 7410 | 16:28:23 INFO - PROCESS | 7410 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 16:28:23 INFO - PROCESS | 7410 | Values: 97.0 96.0 97.0 96.0 97.0 96.0 97.0 98.0 96.0 97.0 16:28:23 INFO - PROCESS | 7410 | 16:28:23 INFO - PROCESS | 7410 | [#8] json-parse-financial Cycles:10 Average:67.80 Median:67.00 stddev:3.12 (4.7%) stddev-sans-first:3.28 16:28:23 INFO - PROCESS | 7410 | Values: 69.0 67.0 67.0 68.0 67.0 67.0 67.0 76.0 65.0 65.0 16:28:23 INFO - PROCESS | 7410 | 16:28:23 INFO - PROCESS | 7410 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.50 stddev:0.52 (0.7%) stddev-sans-first:0.53 16:28:23 INFO - PROCESS | 7410 | Values: 71.0 71.0 71.0 72.0 71.0 71.0 72.0 72.0 72.0 71.0 16:28:23 INFO - PROCESS | 7410 | 16:28:23 INFO - PROCESS | 7410 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:0.84 (1.0%) stddev-sans-first:0.73 16:28:23 INFO - PROCESS | 7410 | Values: 84.0 86.0 85.0 85.0 86.0 85.0 87.0 85.0 85.0 86.0 16:28:23 INFO - PROCESS | 7410 | 16:28:23 INFO - PROCESS | 7410 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:130.00 stddev:3.88 (3.0%) stddev-sans-first:4.06 16:28:23 INFO - PROCESS | 7410 | Values: 127.0 123.0 133.0 128.0 133.0 132.0 127.0 126.0 125.0 134.0 16:28:23 INFO - PROCESS | 7410 | 16:28:23 INFO - PROCESS | 7410 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.20 Median:151.00 stddev:8.42 (5.6%) stddev-sans-first:8.24 16:28:23 INFO - PROCESS | 7410 | Values: 139.0 155.0 142.0 151.0 150.0 138.0 161.0 157.0 151.0 138.0 16:28:23 INFO - PROCESS | 7410 | 16:28:23 INFO - PROCESS | 7410 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:71.50 stddev:1.35 (1.9%) stddev-sans-first:1.42 16:28:23 INFO - PROCESS | 7410 | Values: 72.0 73.0 74.0 73.0 71.0 71.0 71.0 71.0 70.0 70.0 16:28:23 INFO - PROCESS | 7410 | -------- Summary: end -------- 16:28:23 INFO - PROCESS | 7410 | 16:28:23 INFO - PROCESS | 7410 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:28:23 INFO - PROCESS | 7410 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:28:23 INFO - PROCESS | 7410 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:28:23 INFO - PROCESS | 7410 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:28:23 INFO - PROCESS | 7410 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:28:23 INFO - PROCESS | 7410 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:28:23 INFO - PROCESS | 7410 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:28:24 INFO - TEST-INFO | 7410: exit 0 16:28:24 INFO - TEST-OK | kraken | took 62963ms 16:28:24 INFO - SUITE-END | took 1177s 16:28:24 INFO - Completed test suite (00:19:38) 16:28:24 INFO - Working with test: dromaeo_css 16:28:24 INFO - Generating results file: dromaeo_css 16:28:24 INFO - Working with test: kraken 16:28:24 INFO - Generating results file: kraken 16:28:24 INFO - javascript benchmark 16:28:24 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:28:24 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 16:28:24 INFO - process_Request line: dromaeo_css 6115.60 graph.html#tests=[[72,132,43]] 16:28:24 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:28:24 INFO - process_Request line: kraken 1560.60 graph.html#tests=[[232,132,43]] 16:28:24 INFO - RETURN: dromaeo_css: 6115.60 16:28:24 INFO - RETURN: kraken: 1560.60 16:28:24 INFO - javascript benchmark 16:28:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2622.47550489902, 2651.82763120397, 2671.866406679667, 2690.6367640368558, 2699.3791427971564, 4506.211413002719, 4626.236670949298, 4631.120087183437, 4661.091087237985, 4683.695559788612, 4594.40272764541, 4656.998745269766, 4689.835855745049, 4690.624750019999, 4735.408073990751, 3998.452338389353, 4209.49486061673, 4222.725522841013, 4269.487661480626, 4379.693421460499, 4283.993261583525, 4328.2209202343565, 4344.78276086196, 4373.562643735633, 4389.429374181352, 4154.667626589866, 4181.289180839264, 4278.44380230568, 4313.870583882457, 4317.740935543878, 4224.112936283384, 4236.6187043165955, 4249.830006799755, 4273.3162693969125, 4298.74207547545, 4115.34154535273, 4241.957580424187, 4243.066525364415, 4259.531451540328, 4261.7229880058, 4531.43357080365, 4610.077984403133, 4648.465426475965, 4657.953420465786, 4663.440387153563, 4914.238293064581, 4948.802047918079, 4964.60283177345, 4977.452480227172, 5005.449400565934, 4788.11419887322, 4992.775325110379, 4995.325631039799, 5007.173816320303, 5050.191969284897, 4648.721076735406, 4684.695494792828, 4721.5278472153195, 4724.976375118103, 4746.264329029006, 5123.641345105807, 5150.613703972217, 5152.690838549699, 5172.818951336685, 5183.118869792144, 4668.85993420198, 4723.055388922161, 4850.660453768273, 4948.628852836052, 4993.775280112403, 4872.220444728897, 4934.037862616755, 4947.579455746302, 4968.8757781055765, 4985.351904252424, 4883.877903052381, 4916.582090522345, 4917.360743103373, 4921.729304888194, 4940.8764780880765, 4770.403699537558, 4889.168841296988, 4910.968696573759, 4935.506449355035, 4971.1797553404, 4130.855420060344, 4150.584941505886, 4155.355919832431, 4182.2681030819485, 4193.014641559231, 3647.598764135943, 3648.6533779290926, 3649.872254471081, 3660.176460296412, 3679.0434487033563, 4268.850590229389, 4317.654587632982, 4331.545187755303, 4367.039251364695, 4374.934375984363, 5042.974785126051, 5062.190049592047, 5081.898362032739, 5087.236914462786, 5130.076586214443, 4201.138766552849, 4369.978150109229, 4394.692371534026, 4401.317795741666, 4432.822687092545, 4461.152381047591, 4484.596386325246, 4502.941808674958, 4512.165249428801, 4520.163769702615, 4731.432228132646, 4760.285957106462, 4761.619070474423, 4765.11845308619, 4770.045990801854, 4870.245112007645, 4971.279164521196, 5048.141815891234, 5049.84850454487, 5069.163588008085, 4644.93032604518, 4663.370444989883, 4674.275487299474, 4686.554777296152, 4709.858704238878, 4861.4895435978715, 4865.9270110947655, 4868.026394720999, 4874.195757700081, 4904.558589726942, 4819.927701084416, 4920.778564964657, 4956.330895329084, 4958.355413796184, 5015.974920125376, 4702.27114797207, 4801.4958429364415, 4801.855944321676, 4840.370751802384, 4861.829835955725, 4717.198076326964, 4765.975315307087, 4794.640401969797, 4800.039992001543, 4851.417829860439, 4552.476465206543, 4647.55848194421, 4715.056988602362, 4737.123632128068, 4756.928646070242, 4893.217085266483, 4924.113659541317, 4928.975355123202, 4940.60475161979, 4978.626603004862, 4755.239161734106, 4773.775581794614, 4797.112534181188, 4800.039992001543, 4824.276358546246], "unit": "score", "name": "dojo.html", "value": 4563.8828116703535}, {"lowerIsBetter": false, "replicates": [489.2099259695588, 489.48359480747797, 508.5600955173775, 532.8880935003649, 533.4958464251282, 32227.35545289096, 32338.0, 32627.347453050923, 32727.181820454472, 32773.344533109324, 36137.638623613755, 36538.08654783632, 36538.634613653856, 36637.816810915974, 36902.44646330307, 7585.810354741134, 7714.691412343527, 7737.110232323271, 7756.069271687377, 7769.611519424035, 7548.5848278344665, 7665.655045522937, 7706.7302644407455, 7713.382929365637, 7714.19001004892, 7834.451588388815, 7921.920780792176, 7922.207779222061, 7928.207179282083, 7936.801579960518, 7866.6460009299435, 7886.487378320391, 7922.683092676286, 7936.404769642242, 7952.125266220711, 7709.229077092302, 7781.377489800802, 7802.492837965514, 7827.921720782776, 7848.332891704212, 36047.0, 36127.63872361269, 36348.454773178426, 36448.81775591105, 36486.27027459462, 2203.4160947348964, 2652.38995031142, 2663.9600405993924, 2691.448253108108, 2925.736683698456, 24564.263072107864, 24878.50242995148, 24897.5020499589, 24956.625650615257, 25097.874510627513, 2990.9401811963858, 2992.0874133389307, 3032.5602787595676, 3068.9846550767325, 3112.7821052526333, 147552.0, 147900.0, 148024.0, 148486.0, 148691.0, 39103.80448097798, 51876.22185667218, 52245.7387713059, 52247.0, 52435.21347179796, 37002.44496332503, 37014.25971480555, 37025.444618330206, 37158.628413716055, 37206.25587488289, 11383.0, 11565.710857228469, 11586.36275004866, 11592.420378981185, 11629.127815413878, 8686.261667758185, 8762.86855697165, 8786.956065219632, 8819.823603528022, 8832.779180520538, 12943.446786385693, 13038.674033149247, 13351.46458157305, 13565.389557469938, 13579.660508487366, 5513.2005859150195, 5525.530329921921, 5597.888042239214, 5613.186088017214, 5627.46539078795, 880.3881302494705, 904.3759805734154, 928.01630271912, 967.6032826541084, 1011.1506334678758, 25049.87475062613, 26193.704095466503, 26326.736732632427, 26346.473070538483, 26731.0, 897.6221499997473, 941.8634298026748, 950.9001554836781, 966.6278482784179, 1024.9545463627207, 13734.45062197521, 13905.582832515041, 14110.082844615066, 14121.0, 14230.786538201935, 254739.0, 255863.0, 258750.0, 259992.0, 260623.0, 44661.0, 45099.549004509536, 45238.773806131416, 45641.31538026932, 45793.5420645796, 1125.6341688951125, 1167.0780083733755, 1201.7716633839543, 1203.741195642941, 1217.8964787992943, 25295.74704252934, 25713.357166070997, 25734.871325643253, 25904.352391189615, 26189.0, 39543.0, 39963.40420851523, 39966.80016599898, 40018.19963600653, 40076.599234007284, 241098.0, 242893.0, 243533.0, 244408.0, 244710.0, 29311.0, 29715.405691886474, 42430.78784606057, 42855.14289714126, 43090.78454607707, 37826.62173378231, 37997.0, 38198.2360352797, 39035.0, 39197.0, 32169.195770105936, 32348.807304698876, 32479.512807307437, 33241.83379083089, 33271.66728332686, 31522.842385787924, 31935.201619959687, 32092.358152837278, 32470.0, 32501.674983249864, 31673.524897127023, 31747.206319841265, 32307.0, 32428.73364307597, 32598.34803303968, 28443.28891777722, 29783.255418614706, 29910.700892991663, 30064.398712026075, 30075.248118797204, 23624.29127126189, 23653.399295405554, 24046.27861164168, 24064.398390040387, 24103.758962410153], "unit": "score", "name": "ext.html", "value": 15655.851090169961}, {"lowerIsBetter": false, "replicates": [328.1959199960097, 338.23221287676984, 340.99488507672373, 342.963988781178, 344.1671155802957, 15000.174990375539, 15218.239088045595, 15940.36238550458, 16155.43455979041, 16215.51353459395, 14660.780088298658, 14931.328090235966, 15009.774853377208, 15484.767728484081, 15571.844281557182, 4857.319975203474, 5059.316992206061, 5082.720450375228, 5085.593152547805, 5096.490350964911, 4920.852374428773, 4969.602431805447, 5050.217216331456, 5068.518490743373, 5078.339815823938, 4966.329545511346, 4974.651774375795, 4979.676321039139, 4984.177610694231, 4988.152014157602, 4804.087223427555, 4977.55202031817, 5007.424146223177, 5029.346184995927, 5038.2190760432195, 4469.240229161051, 4481.9103617927785, 4484.304932735431, 4487.416635837353, 4489.1919454498175, 18059.54851128719, 18328.175232114587, 18799.530011749677, 18960.0, 18998.905005474884, 1848.9445316640522, 1862.4971257760465, 1883.3031778242, 2081.6669332906813, 2280.977190228093, 11283.605073822377, 12259.877401225962, 12364.876351236553, 12652.367381630882, 12722.300273484954, 1638.3774165817033, 1645.1116397145527, 1661.7175080236268, 1689.4847071643144, 1695.2879790488025, 53793.193102103105, 56102.0, 56823.0, 57142.428575714126, 57195.142072868526, 9200.631974720936, 9236.953815230881, 9545.952270238604, 9557.569909353957, 9652.517374131265, 11920.403979800974, 12087.697807554881, 12094.032477401786, 12111.757764844653, 12128.75742485163, 6333.303336632966, 6527.510436717265, 6585.506087043395, 6649.168853893263, 6703.597784132968, 6148.893199224093, 6218.160548326008, 6308.621482711052, 6315.842103947346, 6332.810015699536, 5652.745626446737, 5766.106253530709, 5793.15999180125, 5793.681347525927, 5909.409059094056, 1711.3924556782413, 1729.0835856995811, 1750.81616430273, 1757.9560510987328, 1761.383515769496, 846.2299307630027, 858.7895965488495, 898.3576742629051, 907.5416914458289, 922.6540047482194, 15396.846031539766, 15440.150791706565, 15801.683966320608, 15859.127747973742, 15949.840501595068, 854.9700760473354, 886.964521419136, 894.2443635128307, 895.7536677413764, 907.1835348186685, 9046.909530904739, 9097.954510227406, 9107.635694572144, 9147.588358523883, 9316.906830931604, 341124.0, 346384.8255747376, 350075.0, 350221.0, 350355.0, 41741.79129104335, 49601.25598116031, 56527.869442610914, 57735.26794196181, 59138.11292830611, 924.4591913730409, 944.7213072143734, 945.2815859946353, 951.2485136741897, 953.9761505962267, 14285.357158927665, 14474.927625361806, 14476.276186190858, 14486.492972745904, 14684.85315146835, 28582.285442864093, 29121.85439072791, 29828.254293642833, 29876.402471950005, 29893.701062989963, 37446.43830342602, 38486.42270365891, 38622.61377386303, 38925.416118757676, 39105.80447097746, 6823.55646882951, 6943.305669433218, 7069.045678833498, 7156.141263048467, 7192.496525243392, 10452.477376131315, 10671.839922401325, 10766.192535560021, 10869.0, 10974.780504390028, 5874.118882167709, 5976.432238937294, 9180.908190918273, 9383.296252780932, 9503.429794212369, 8937.955310223668, 9077.409968352036, 9296.674616388394, 9397.577109030246, 9558.091981261769, 8867.512286824287, 9636.951815240878, 9690.079442452956, 9787.804243915225, 10118.0, 6809.65951702403, 6915.0, 6966.616836074065, 6980.267071957372, 7091.042709234187, 9632.325737198329, 9650.613975440903, 9653.806923861624, 9678.75803104928, 9781.364211326241], "unit": "score", "name": "jquery.html", "value": 7608.183851557826}, {"lowerIsBetter": false, "replicates": [1372.231550331814, 1387.5143699705104, 1499.5501349595127, 1683.4108062178248, 1707.4024091567944, 5998.400159983999, 6917.550359226647, 7000.229974702785, 7163.820904477384, 7165.534240274378, 6959.304069593039, 7049.577025378468, 7058.929410705891, 7071.0, 7101.8224544386285, 2077.439091445309, 2084.291340944086, 2086.645270304052, 2093.9371818845457, 2097.968530472044, 2040.8673436226597, 2041.6631255842767, 2044.94887627809, 2087.1859974609915, 2089.1956596710224, 2060.093558834116, 2085.2388878059473, 2089.2165437960766, 2101.0965284927474, 2109.915603375863, 2098.685197220414, 2105.284203370846, 2107.1887323380456, 2109.0298462707174, 2109.0825490911425, 2081.438011736823, 2089.039042040663, 2116.132385721862, 2116.185268671557, 2126.457753272921, 7079.929200707978, 7150.856982860366, 7159.57042577447, 7179.569225846466, 7206.099237595301, 4210.810513526868, 4263.893402664927, 4279.5078565965005, 4282.614564689193, 4299.269124248885, 2562.1160699558623, 2566.358410397401, 2602.8828702708424, 2705.485957668037, 2708.9322766930786, 837.7319257837495, 844.252836239926, 867.2324992381724, 873.0789017586444, 875.2647775868301, 9621.90378096224, 9633.710988670351, 9668.081532254424, 9676.371035882645, 9684.225261979025, 3855.9614403856162, 3918.0596656802163, 4013.458183145238, 4015.4177644242004, 4025.4364388985564, 8100.189981001853, 8125.1062383137805, 8143.918560814434, 8167.0, 8191.71329003494, 4232.32282834745, 4265.338872474771, 4288.549702281278, 4299.9785001075425, 4302.376155457441, 3107.6270847498445, 3774.5659249186697, 3776.773393596393, 3782.8108594570162, 3791.696664266852, 3390.1694084949345, 3426.0, 3429.3141371725756, 3458.4639380896, 3467.924943267595, 1095.3537412926412, 1103.586155191803, 1106.1427393769732, 1109.073923274059, 1110.4225802582612, 809.3363441977522, 809.3727361295043, 812.4028838803474, 815.559597817184, 825.3809642767924, 6631.33686631333, 6652.0, 6657.833554161185, 6684.131062961881, 6690.799276021728, 409.2939679053668, 412.3402555910519, 413.0973822198506, 415.55535576932994, 453.9886502837455, 5205.167173252262, 5218.765155568009, 5228.843134705965, 5251.921221181686, 5289.021531016774, 8390.538520381315, 8562.571871406404, 8663.78340541479, 8720.8691869622, 8843.0, 8526.40315177944, 8615.095414981337, 8624.95687521571, 8698.869516957251, 8754.824903502022, 6804.489663275274, 6828.863422731518, 6855.417289530346, 6956.095707557985, 7004.299570042853, 6545.312742162005, 6572.572782769296, 6578.638174900427, 6590.373914478117, 6596.076549283008, 7608.543487390774, 7715.22847715224, 7752.806179845549, 7880.645370958436, 7885.093214280431, 7810.3751699865015, 8052.114267430461, 8111.553864537507, 8112.18878112184, 8118.675252989814, 5123.077845987609, 5998.670073146019, 6177.505799535937, 6230.345813689679, 6247.0, 6801.5238933274195, 6848.3494068063455, 6852.554583952027, 6854.862902741817, 6900.171979362509, 5877.735501902339, 5939.643621382731, 5986.970065149646, 6046.183765191643, 6085.965385884322, 6094.969525152346, 6202.937970620416, 6218.689065546795, 6269.62382257066, 6317.178766760292, 6524.151860258136, 6606.009098635051, 6620.2386725527185, 6621.735130594722, 6658.467322614276, 5814.30228372598, 5853.239078919713, 5898.056310990221, 5900.055991041413, 5926.585139040226, 6080.847978800565, 6175.59858609189, 6194.38056194377, 6246.593971391845, 6262.279837818709], "unit": "score", "name": "mootools.html", "value": 3966.226787274821}, {"lowerIsBetter": false, "replicates": [287.24597930432617, 295.28393645409875, 298.20528292101545, 300.59719975233185, 301.6124280299814, 5651.180578816069, 5678.971605141974, 5725.255716756821, 5791.942080579193, 5875.265591801025, 5645.576581756364, 5730.7707691692285, 5738.770449182038, 5749.540036797057, 5755.712214389285, 4157.833686652531, 4252.447181866353, 4268.829246830123, 4279.379489973952, 4286.292761694324, 4247.745135291877, 4262.680298977589, 4283.164782867342, 4283.593058659438, 4289.742615443068, 4236.4704411948505, 4247.108107297471, 4247.851325203618, 4249.490061192646, 4254.553271906451, 4251.341042138458, 4253.766042867641, 4254.851080212208, 4263.786810659454, 4268.996785755345, 3674.52231209941, 3674.761140525884, 3676.117731744389, 3677.0, 3682.429223470366, 5403.567714582824, 5435.755391007375, 5468.9726551367385, 5474.616776825624, 5481.616286859921, 4779.2874336072055, 4836.8875158713345, 4872.0499502597, 4891.070696567676, 4895.339129217546, 5877.706114694291, 5886.617369870987, 5889.882202355929, 5910.852228694274, 5931.317898441648, 3966.5835087315995, 3973.7417067890783, 3988.501437320335, 3991.481107456012, 3993.3610622300293, 6196.535259855529, 6247.031710084944, 6279.7174127163935, 6305.369463053704, 6319.399657032621, 4094.8566800161852, 4101.589841015874, 4105.0763578194665, 4108.383742438598, 4115.300398932189, 4124.566920473367, 4162.771047592411, 4164.271252530795, 4167.333226683716, 4170.70805043644, 4625.560571745679, 4796.640251981045, 4847.321375007502, 4847.394075740533, 4858.514148585114, 5976.252968378953, 5977.731002104916, 5989.401059893976, 5997.370276121032, 6017.06735456005, 1444.8844092472577, 1458.7520121579357, 1463.8828893688478, 1465.9664936220152, 1471.433498103238, 941.5857022910035, 952.961272213277, 965.0735294117726, 978.3493976505545, 980.9411435313904, 5173.456787037307, 5176.50823171798, 5177.7152256625495, 5182.300389447451, 5183.637145399785, 6134.141220229171, 6167.938320616737, 6187.226596675416, 6198.0702894566175, 6204.689765511706, 5146.356705411824, 5157.226416037549, 5165.431802501722, 5167.276581278624, 5176.663516871391, 3284.9835750821094, 3382.8139452329865, 3397.6262611112757, 3408.625051244361, 3412.19813343864, 5852.858692554911, 5853.912191317134, 5873.9412605873395, 5882.529397648178, 5897.144913987448, 6412.807615771534, 6435.131257280207, 6444.806655800334, 6465.191851018622, 6500.382463666038, 5844.094165404369, 5864.2083318752275, 5867.413258674099, 5884.176215329857, 5892.381299963527, 6003.879922401615, 6009.579329446897, 6027.849303767441, 6236.469900058546, 6265.122882796321, 6041.486473649789, 6042.8791424170395, 6051.273847138372, 6127.908081378872, 6129.295131059806, 5813.651180929158, 5821.0, 5821.76712931478, 5832.600175957825, 5842.853928651648, 4000.3199456093116, 4037.37420699792, 4051.7568945862163, 4058.6144316289906, 4075.49056367954, 6240.812775616739, 6283.3088360281245, 6290.182276304051, 6295.55931084838, 6296.968515157395, 5789.45000224978, 5958.404159584007, 5962.2249107615735, 5980.671063091571, 6047.123167140828, 5974.671393073423, 6022.0, 6023.668698221464, 6044.063170208625, 6044.88169688609, 5857.912131318119, 5880.882382352243, 5893.174955506318, 5894.469497745224, 5902.203202567598, 6058.0610005449225, 6062.484688801501, 6068.726907289094, 6071.787487437919, 6077.331493535619, 5485.204645326485, 5635.633683810539, 5707.68607726579, 5920.526357891272, 5920.615160014585], "unit": "score", "name": "prototype.html", "value": 4410.55884892347}, {"lowerIsBetter": false, "replicates": [564.2805423085568, 655.1254075808795, 683.9692213850376, 706.8374273916999, 723.8588475247326, 10199.082082612573, 10315.742106447342, 10327.431991240488, 10340.534675939582, 10343.741406464842, 11050.613228537002, 11335.659930202108, 11447.59933402329, 11534.307941523515, 12822.487100515968, 756.825930036092, 771.9884201736978, 773.0452890680006, 780.8282177920877, 781.4022272961189, 763.6181909045478, 765.0169532151186, 766.624354066509, 767.3362541401704, 771.3713323641242, 792.8810678398257, 801.8356236971407, 801.9278264956182, 802.6468353924283, 803.5459965119688, 800.0359566722086, 800.2837460472873, 800.8798680197958, 802.0936341933636, 802.2779498451382, 596.397638385234, 597.8445604142911, 598.0849300570135, 599.053495477145, 599.2718846601357, 11129.666110016713, 11145.832812507819, 11176.944115279372, 11225.66323010311, 11254.324740515513, 11704.590339338167, 11774.352410617412, 11976.341301228429, 12088.576899808553, 12178.330191839445, 8753.7811554711, 8799.78000549985, 8889.155530224683, 8933.0, 8954.776130596721, 3216.5175223716396, 3228.418884600771, 3261.168402057484, 3263.7225835803984, 3290.3912776136253, 35860.64139358599, 38294.42558361627, 38858.0, 40521.0, 41531.584684152775, 9142.0, 9280.95359523198, 9589.130119626745, 9595.42427454355, 9655.71032869001, 15422.768658470131, 15469.0, 15480.845191548166, 15489.922550387177, 15508.069515829086, 6381.298057213703, 6495.577787443801, 6512.187961806609, 6543.214814222229, 6591.0, 3204.919877003047, 3284.310294838063, 3314.4034073866937, 3374.6287908330064, 3414.9146271343416, 2509.1845150326217, 2524.1670248817845, 2531.316544533003, 2541.4917016596755, 2542.275451496315, 460.5854730742359, 461.7114303560275, 464.8349835808307, 469.3710428026461, 473.0019658520519, 518.2381898609038, 554.692145859044, 587.3539106982286, 591.775125452334, 601.5712682379349, 7549.6225188740345, 7579.204183560647, 7580.204078571671, 7580.9620951894885, 7714.845703085907, 597.1758972617846, 600.2257088355972, 600.4535872356134, 600.8738164985315, 607.8146165419502, 3467.3758723430024, 3521.084518025332, 3589.6769290763955, 3611.8194090295906, 3670.4127339626066, 45278.0, 45811.31283030757, 46191.30713039307, 46965.76517117392, 46993.295100573516, 38991.22017559633, 39469.80265098656, 39501.80249098794, 39524.802375987936, 39619.0, 39019.41470877939, 39742.0, 39838.99999999942, 40347.394789078186, 40764.592354076674, 7567.470277080552, 7631.771046868603, 7647.235276472308, 7744.148143704076, 7992.160823113722, 28485.287867803472, 28876.70054847579, 29458.0, 29623.0, 29736.702632973393, 33788.49317260194, 35758.64241357553, 35849.0, 36193.27613447663, 37018.444723328634, 9694.951525242328, 9742.95128524353, 9802.558884850056, 9924.702258932244, 9951.900480995097, 9819.803603928025, 10179.93110723393, 10235.283530153116, 11044.226904116957, 11797.528098876292, 10226.6420675276, 10259.0, 10400.895991039994, 10754.193435492212, 10987.61543345979, 9652.420854748738, 9739.610415583298, 10089.041541053588, 10258.0, 10355.275130740776, 9722.562484688347, 9870.605175792887, 10156.0, 10675.039246467855, 10761.730956726144, 8154.836903261783, 8209.179082091743, 8252.587370631565, 8444.197801208875, 8505.574721264036, 8429.957850210709, 8525.27223140164, 8547.316214702932, 8728.08355122703, 8775.956120219358], "unit": "score", "name": "yui.html", "value": 5500.839099564901}], "name": "dromaeo_css", "value": 6115.596805979346}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 111.0, 116.0, 114.0, 116.0, 125.0, 114.0, 113.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.3}, {"lowerIsBetter": true, "replicates": [157.0, 139.0, 155.0, 168.0, 139.0, 152.0, 155.0, 137.0, 184.0, 144.0], "unit": "score", "name": "audio-beat-detection", "value": 153.0}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 162.0, 168.0, 171.0, 162.0, 164.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 73.0, 74.0, 74.0, 153.0, 74.0, 74.0, 75.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 143.0, 101.0, 98.0, 98.0, 138.0, 100.0, 99.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 111.4}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 116.0, 116.0, 116.0, 116.0, 116.0, 116.0, 117.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.4}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 148.0, 148.0, 148.0, 149.0, 148.0, 149.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.4}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 96.0, 97.0, 96.0, 97.0, 98.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 76.0, 65.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 67.8}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 72.0, 71.0, 71.0, 72.0, 72.0, 72.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.4}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 85.0, 85.0, 86.0, 85.0, 87.0, 85.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [127.0, 123.0, 133.0, 128.0, 133.0, 132.0, 127.0, 126.0, 125.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.8}, {"lowerIsBetter": true, "replicates": [139.0, 155.0, 142.0, 151.0, 150.0, 138.0, 161.0, 157.0, 151.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.2}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 74.0, 73.0, 71.0, 71.0, 71.0, 71.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.6}], "name": "kraken", "value": 1560.6000000000001}]} 16:28:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1560.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6115.60"}}} 16:28:24 INFO - Return code: 0 16:28:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:28:24 ERROR - # TBPL SUCCESS # 16:28:24 INFO - Running post-action listener: _resource_record_post_action 16:28:24 INFO - Running post-run listener: _resource_record_post_run 16:28:25 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 525955072; Read time: 20; Write time: 588236 16:28:25 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233578496; Read time: 0; Write time: 359260 16:28:25 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292376576; Read time: 20; Write time: 228976 16:28:25 INFO - Running post-run listener: _upload_blobber_files 16:28:25 INFO - Blob upload gear active. 16:28:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:28:25 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 16:28:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:28:25 INFO - (blobuploader) - INFO - Open directory for files ... 16:28:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:28:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:28:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:28:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:28:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:28:26 INFO - (blobuploader) - INFO - Done attempting. 16:28:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:28:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:28:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:28:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:28:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:28:27 INFO - (blobuploader) - INFO - Done attempting. 16:28:27 INFO - (blobuploader) - INFO - Iteration through files over. 16:28:27 INFO - Return code: 0 16:28:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:28:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:28:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90aa26fdf4e7af0c414d90af59610a94c87a547b5cd8df96ce49afb17229e3cb140d89b463aa0471140d49222a089d29a4e15f3710cf1eb3bad2e7f430afc8f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f96396cd10850cced9133d13a91949ffe36b49d9a985e3a6e7f720d571580bca6cb123c9fc651f7316df5a2029983cdf992bfb6c0def2a0196dfb1830411b7b9"} 16:28:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:28:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:28:27 INFO - Contents: 16:28:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90aa26fdf4e7af0c414d90af59610a94c87a547b5cd8df96ce49afb17229e3cb140d89b463aa0471140d49222a089d29a4e15f3710cf1eb3bad2e7f430afc8f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f96396cd10850cced9133d13a91949ffe36b49d9a985e3a6e7f720d571580bca6cb123c9fc651f7316df5a2029983cdf992bfb6c0def2a0196dfb1830411b7b9"} 16:28:27 INFO - Running post-run listener: copy_logs_to_upload_dir 16:28:27 INFO - Copying logs to upload dir... 16:28:27 INFO - mkdir: /builds/slave/test/build/upload/logs 16:28:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.418896 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-02-29 16:28:27.583127) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 16:28:27.590670) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90aa26fdf4e7af0c414d90af59610a94c87a547b5cd8df96ce49afb17229e3cb140d89b463aa0471140d49222a089d29a4e15f3710cf1eb3bad2e7f430afc8f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f96396cd10850cced9133d13a91949ffe36b49d9a985e3a6e7f720d571580bca6cb123c9fc651f7316df5a2029983cdf992bfb6c0def2a0196dfb1830411b7b9"} build_url:https://queue.taskcluster.net/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/Ce4SUsQvQ1mfjAwtdiClCQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90aa26fdf4e7af0c414d90af59610a94c87a547b5cd8df96ce49afb17229e3cb140d89b463aa0471140d49222a089d29a4e15f3710cf1eb3bad2e7f430afc8f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f96396cd10850cced9133d13a91949ffe36b49d9a985e3a6e7f720d571580bca6cb123c9fc651f7316df5a2029983cdf992bfb6c0def2a0196dfb1830411b7b9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 16:28:27.617144) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 16:28:27.617509) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1456787977.513205-1637863466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004698 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 16:28:27.701875) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 16:28:27.702232) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 16:28:27.702538) ========= ========= Total master_lag: 0.28 =========