builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1456876055.24 results: success (0) buildid: 20160301142131 builduid: a846109e3041467292e3378a02f96673 revision: d6788a70c97b5ed250e65e4d83c435fc6791e3ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:35.244807) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:35.245593) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:35.245887) ========= 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=836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006454 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:35.269187) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:35.269503) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:35.282558) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:35.282898) ========= 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=836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:35.332103) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:35.332420) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:35.332791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:35.333110) ========= 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=836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-01 15:47:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.4M=0s 2016-03-01 15:47:36 (84.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156088 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:35.501559) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:35.501904) ========= 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=836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020324 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:35.551303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-01 15:47:35.551684) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d6788a70c97b5ed250e65e4d83c435fc6791e3ff --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d6788a70c97b5ed250e65e4d83c435fc6791e3ff --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=836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-01 15:47:36,469 truncating revision to first 12 chars 2016-03-01 15:47:36,469 Setting DEBUG logging. 2016-03-01 15:47:36,469 attempt 1/10 2016-03-01 15:47:36,469 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d6788a70c97b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-01 15:47:37,148 unpacking tar archive at: mozilla-central-d6788a70c97b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.991476 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-01 15:47:36.556117) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:36.556463) ========= echo d6788a70c97b5ed250e65e4d83c435fc6791e3ff in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd6788a70c97b5ed250e65e4d83c435fc6791e3ff'] 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=836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d6788a70c97b5ed250e65e4d83c435fc6791e3ff program finished with exit code 0 elapsedTime=0.003912 script_repo_revision: 'd6788a70c97b5ed250e65e4d83c435fc6791e3ff' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:36.606072) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:36.606444) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 15:47:36.616829) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-01 15:47:36.617251) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:47:37 INFO - MultiFileLogger online at 20160301 15:47:37 in /builds/slave/test 15:47:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:47:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:47:37 INFO - {'append_to_log': False, 15:47:37 INFO - 'base_work_dir': '/builds/slave/test', 15:47:37 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:47:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:47:37 INFO - 'branch': 'Firefox-Non-PGO', 15:47:37 INFO - 'buildbot_json_path': 'buildprops.json', 15:47:37 INFO - 'config_files': ('talos/linux_config.py',), 15:47:37 INFO - 'default_actions': ('clobber', 15:47:37 INFO - 'read-buildbot-config', 15:47:37 INFO - 'download-and-extract', 15:47:37 INFO - 'populate-webroot', 15:47:37 INFO - 'create-virtualenv', 15:47:37 INFO - 'install', 15:47:37 INFO - 'run-tests'), 15:47:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:47:37 INFO - 'download_minidump_stackwalk': True, 15:47:37 INFO - 'download_symbols': 'ondemand', 15:47:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:47:37 INFO - 'tooltool.py': '/tools/tooltool.py', 15:47:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:47:37 INFO - '/tools/misc-python/virtualenv.py')}, 15:47:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:47:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:47:37 INFO - 'installer_path': 'installer.exe', 15:47:37 INFO - 'log_level': 'info', 15:47:37 INFO - 'log_name': 'talos', 15:47:37 INFO - 'log_to_console': True, 15:47:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:47:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:47:37 INFO - 'opt_config_files': (), 15:47:37 INFO - 'pip_index': False, 15:47:37 INFO - 'sps_profile': False, 15:47:37 INFO - 'sps_profile_interval': 0, 15:47:37 INFO - 'suite': 'dromaeojs-e10s', 15:47:37 INFO - 'system_bits': '32', 15:47:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:47:37 INFO - 'title': 'talos-linux64-ix-028', 15:47:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:47:37 INFO - 'use_talos_json': True, 15:47:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:47:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:47:37 INFO - 'work_dir': 'build'} 15:47:37 INFO - ##### 15:47:37 INFO - ##### Running clobber step. 15:47:37 INFO - ##### 15:47:37 INFO - Running pre-action listener: _resource_record_pre_action 15:47:37 INFO - Running main action method: clobber 15:47:37 INFO - rmtree: /builds/slave/test/build 15:47:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:47:38 INFO - Running post-action listener: _resource_record_post_action 15:47:38 INFO - ##### 15:47:38 INFO - ##### Running read-buildbot-config step. 15:47:38 INFO - ##### 15:47:38 INFO - Running pre-action listener: _resource_record_pre_action 15:47:38 INFO - Running main action method: read_buildbot_config 15:47:38 INFO - Using buildbot properties: 15:47:38 INFO - { 15:47:38 INFO - "project": "", 15:47:38 INFO - "product": "firefox", 15:47:38 INFO - "script_repo_revision": "production", 15:47:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:47:38 INFO - "repository": "", 15:47:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:47:38 INFO - "buildid": "20160301142131", 15:47:38 INFO - "pgo_build": "False", 15:47:38 INFO - "basedir": "/builds/slave/test", 15:47:38 INFO - "buildnumber": 226, 15:47:38 INFO - "slavename": "talos-linux64-ix-028", 15:47:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:47:38 INFO - "platform": "ubuntu64_hw", 15:47:38 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:47:38 INFO - "branch": "mozilla-central", 15:47:38 INFO - "repo_path": "mozilla-central", 15:47:38 INFO - "revision": "d6788a70c97b5ed250e65e4d83c435fc6791e3ff", 15:47:38 INFO - "stage_platform": "linux64", 15:47:38 INFO - "builduid": "a846109e3041467292e3378a02f96673", 15:47:38 INFO - "slavebuilddir": "test" 15:47:38 INFO - } 15:47:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 15:47:38 INFO - Running post-action listener: _resource_record_post_action 15:47:38 INFO - ##### 15:47:38 INFO - ##### Running download-and-extract step. 15:47:38 INFO - ##### 15:47:38 INFO - Running pre-action listener: _resource_record_pre_action 15:47:38 INFO - Running main action method: download_and_extract 15:47:38 INFO - mkdir: /builds/slave/test/build/tests 15:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:38 INFO - https://queue.taskcluster.net/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:47:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 15:47:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 15:47:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 15:47:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:47:38 INFO - Downloaded 1448 bytes. 15:47:38 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 15:47:38 INFO - Using the following test package requirements: 15:47:38 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:38 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:47:38 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:47:38 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:38 INFO - u'jsshell-linux-x86_64.zip'], 15:47:38 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:47:38 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:38 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:47:38 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:47:38 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:47:38 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:38 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:47:38 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:38 INFO - https://queue.taskcluster.net/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:47:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:47:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:47:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/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 15:47:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/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 15:47:40 INFO - Downloaded 22077321 bytes. 15:47:40 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'] 15:47:40 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 15:47:41 INFO - Return code: 0 15:47:41 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 15:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:41 INFO - https://queue.taskcluster.net/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:47:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:47:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:47:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/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 15:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/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 15:47:43 INFO - Downloaded 22077321 bytes. 15:47:43 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'] 15:47:43 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 15:47:44 INFO - Return code: 0 15:47: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')]} 15:47:44 INFO - https://queue.taskcluster.net/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:47:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/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 15:47:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/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 15:47:45 INFO - Downloaded 10713413 bytes. 15:47:45 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'] 15:47:45 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 15:47:45 INFO - Return code: 0 15:47:45 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')]} 15:47:45 INFO - https://queue.taskcluster.net/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:47:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:47:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:47:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/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 15:47:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LflQATdaSQOV_E_BpeJ3XQ/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 15:47:47 INFO - Downloaded 54390937 bytes. 15:47:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:47:47 INFO - mkdir: /builds/slave/test/properties 15:47:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:47:47 INFO - Writing to file /builds/slave/test/properties/build_url 15:47:47 INFO - Contents: 15:47:47 INFO - build_url:https://queue.taskcluster.net/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:47:48 INFO - Running post-action listener: _resource_record_post_action 15:47:48 INFO - Running post-action listener: set_extra_try_arguments 15:47:48 INFO - ##### 15:47:48 INFO - ##### Running populate-webroot step. 15:47:48 INFO - ##### 15:47:48 INFO - Running pre-action listener: _resource_record_pre_action 15:47:48 INFO - Running main action method: populate_webroot 15:47:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:47:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:47:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:47:48 INFO - '--tppagecycles', 15:47:48 INFO - '7'], 15:47:48 INFO - 'tests': ['tsvgm']}}, 15:47:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:47:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:47:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:47:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:47:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:48 INFO - 'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:48 INFO - 'tests': ['damp', 'tps']}, 15:47:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:48 INFO - 'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['damp', 'tps']}, 15:47:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:47:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:47:48 INFO - 'other': {'tests': ['a11yr', 15:47:48 INFO - 'ts_paint', 15:47:48 INFO - 'tpaint', 15:47:48 INFO - 'sessionrestore', 15:47:48 INFO - 'sessionrestore_no_auto_restore']}, 15:47:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['a11yr', 15:47:48 INFO - 'ts_paint', 15:47:48 INFO - 'tpaint', 15:47:48 INFO - 'sessionrestore', 15:47:48 INFO - 'sessionrestore_no_auto_restore']}, 15:47:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['a11yr', 15:47:48 INFO - 'ts_paint', 15:47:48 INFO - 'tpaint', 15:47:48 INFO - 'sessionrestore', 15:47:48 INFO - 'sessionrestore_no_auto_restore']}, 15:47:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['a11yr', 15:47:48 INFO - 'ts_paint', 15:47:48 INFO - 'tpaint', 15:47:48 INFO - 'sessionrestore', 15:47:48 INFO - 'sessionrestore_no_auto_restore']}, 15:47:48 INFO - 'other_l64': {'tests': ['a11yr', 15:47:48 INFO - 'ts_paint', 15:47:48 INFO - 'tpaint', 15:47:48 INFO - 'sessionrestore', 15:47:48 INFO - 'sessionrestore_no_auto_restore']}, 15:47:48 INFO - 'other_nol64': {'tests': ['a11yr', 15:47:48 INFO - 'ts_paint', 15:47:48 INFO - 'tpaint', 15:47:48 INFO - 'sessionrestore', 15:47:48 INFO - 'sessionrestore_no_auto_restore']}, 15:47:48 INFO - 'svgr': {'tests': ['tsvgx', 15:47:48 INFO - 'tsvgr_opacity', 15:47:48 INFO - 'tart', 15:47:48 INFO - 'tscrollx', 15:47:48 INFO - 'cart']}, 15:47:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['tsvgx', 15:47:48 INFO - 'tsvgr_opacity', 15:47:48 INFO - 'tart', 15:47:48 INFO - 'tscrollx', 15:47:48 INFO - 'cart']}, 15:47:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:48 INFO - 'tests': ['tp5o']}, 15:47:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:48 INFO - 'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['tp5o']}, 15:47:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:48 INFO - 'talos_options': ['--xperf_path', 15:47:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:48 INFO - 'tests': ['tp5n']}, 15:47:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:48 INFO - 'talos_options': ['--e10s', 15:47:48 INFO - '--xperf_path', 15:47:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:48 INFO - 'tests': ['tp5n']}}, 15:47:48 INFO - 'talos.zip': {'path': '', 15:47:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:47:48 INFO - Running post-action listener: _resource_record_post_action 15:47:48 INFO - ##### 15:47:48 INFO - ##### Running create-virtualenv step. 15:47:48 INFO - ##### 15:47:48 INFO - Running pre-action listener: _resource_record_pre_action 15:47:48 INFO - Running main action method: create_virtualenv 15:47:48 INFO - Creating virtualenv /builds/slave/test/build/venv 15:47:48 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 15:47:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:47:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:47:48 INFO - Using real prefix '/usr' 15:47:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:47:48 INFO - Installing distribute.............................................................................................................................................................................................done. 15:47:50 INFO - Installing pip.................done. 15:47:50 INFO - Return code: 0 15:47:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f79ba44cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29883b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a17100>, '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 0x2a18000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a18490>, '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': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', '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 15:47:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:47:50 INFO - Using env: {'DISPLAY': ':0', 15:47:50 INFO - 'HOME': '/home/cltbld', 15:47:50 INFO - 'LANG': 'en_US.UTF-8', 15:47:50 INFO - 'LANGUAGE': 'en_US:en', 15:47:50 INFO - 'LOGNAME': 'cltbld', 15:47:50 INFO - 'MAIL': '/var/mail/cltbld', 15:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:50 INFO - 'MOZ_NO_REMOTE': '1', 15:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:50 INFO - 'NO_EM_RESTART': '1', 15:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:50 INFO - 'PWD': '/builds/slave/test', 15:47:50 INFO - 'SHELL': '/bin/bash', 15:47:50 INFO - 'SHLVL': '1', 15:47:50 INFO - 'TERM': 'linux', 15:47:50 INFO - 'TMOUT': '86400', 15:47:50 INFO - 'USER': 'cltbld', 15:47:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', 15:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:50 INFO - '_': '/tools/buildbot/bin/python'} 15:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:51 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 15:47:51 INFO - Cleaning up... 15:47:51 INFO - Return code: 0 15:47:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:51 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 0x7f79ba44cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29883b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a17100>, '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 0x2a18000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a18490>, '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': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', '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 15:47:51 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 15:47:51 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 15:47:51 INFO - Using env: {'DISPLAY': ':0', 15:47:51 INFO - 'HOME': '/home/cltbld', 15:47:51 INFO - 'LANG': 'en_US.UTF-8', 15:47:51 INFO - 'LANGUAGE': 'en_US:en', 15:47:51 INFO - 'LOGNAME': 'cltbld', 15:47:51 INFO - 'MAIL': '/var/mail/cltbld', 15:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:51 INFO - 'MOZ_NO_REMOTE': '1', 15:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:51 INFO - 'NO_EM_RESTART': '1', 15:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:51 INFO - 'PWD': '/builds/slave/test', 15:47:51 INFO - 'SHELL': '/bin/bash', 15:47:51 INFO - 'SHLVL': '1', 15:47:51 INFO - 'TERM': 'linux', 15:47:51 INFO - 'TMOUT': '86400', 15:47:51 INFO - 'USER': 'cltbld', 15:47:51 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', 15:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:51 INFO - '_': '/tools/buildbot/bin/python'} 15:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:51 INFO - Downloading/unpacking psutil>=0.7.1 15:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:47:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:53 INFO - Installing collected packages: psutil 15:47:53 INFO - Running setup.py install for psutil 15:47:53 INFO - building 'psutil._psutil_linux' extension 15:47:53 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 15:47:53 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 15:47:53 INFO - building 'psutil._psutil_posix' extension 15:47:53 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 15:47:53 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 15:47:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:53 INFO - Successfully installed psutil 15:47:53 INFO - Cleaning up... 15:47:53 INFO - Return code: 0 15:47:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f79ba44cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29883b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a17100>, '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 0x2a18000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a18490>, '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': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', '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 15:47:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:47:53 INFO - Using env: {'DISPLAY': ':0', 15:47:53 INFO - 'HOME': '/home/cltbld', 15:47:53 INFO - 'LANG': 'en_US.UTF-8', 15:47:53 INFO - 'LANGUAGE': 'en_US:en', 15:47:53 INFO - 'LOGNAME': 'cltbld', 15:47:53 INFO - 'MAIL': '/var/mail/cltbld', 15:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:53 INFO - 'MOZ_NO_REMOTE': '1', 15:47:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:53 INFO - 'NO_EM_RESTART': '1', 15:47:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:53 INFO - 'PWD': '/builds/slave/test', 15:47:53 INFO - 'SHELL': '/bin/bash', 15:47:53 INFO - 'SHLVL': '1', 15:47:53 INFO - 'TERM': 'linux', 15:47:53 INFO - 'TMOUT': '86400', 15:47:53 INFO - 'USER': 'cltbld', 15:47:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', 15:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:53 INFO - '_': '/tools/buildbot/bin/python'} 15:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:47:54 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 15:47:54 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 15:47:54 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 15:47:54 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 15:47:54 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 15:47:54 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 15:47:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:47:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:47:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:47:55 INFO - Installing collected packages: mozsystemmonitor 15:47:55 INFO - Running setup.py install for mozsystemmonitor 15:47:56 INFO - Successfully installed mozsystemmonitor 15:47:56 INFO - Cleaning up... 15:47:56 INFO - Return code: 0 15:47:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f79ba44cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29883b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a17100>, '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 0x2a18000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a18490>, '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': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', '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 15:47:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:47:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:47:56 INFO - Using env: {'DISPLAY': ':0', 15:47:56 INFO - 'HOME': '/home/cltbld', 15:47:56 INFO - 'LANG': 'en_US.UTF-8', 15:47:56 INFO - 'LANGUAGE': 'en_US:en', 15:47:56 INFO - 'LOGNAME': 'cltbld', 15:47:56 INFO - 'MAIL': '/var/mail/cltbld', 15:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:56 INFO - 'MOZ_NO_REMOTE': '1', 15:47:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:56 INFO - 'NO_EM_RESTART': '1', 15:47:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:56 INFO - 'PWD': '/builds/slave/test', 15:47:56 INFO - 'SHELL': '/bin/bash', 15:47:56 INFO - 'SHLVL': '1', 15:47:56 INFO - 'TERM': 'linux', 15:47:56 INFO - 'TMOUT': '86400', 15:47:56 INFO - 'USER': 'cltbld', 15:47:56 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', 15:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:56 INFO - '_': '/tools/buildbot/bin/python'} 15:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:56 INFO - Downloading/unpacking blobuploader==1.2.4 15:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:58 INFO - Downloading blobuploader-1.2.4.tar.gz 15:47:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:47:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:47:58 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 15:47:58 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 15:47:58 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 15:47:58 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 15:47:58 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 15:47:58 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 15:47:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:47:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:47:58 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 15:47:58 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 15:47:58 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 15:47:58 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 15:47:58 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 15:47:58 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 15:47:58 INFO - Downloading docopt-0.6.1.tar.gz 15:47:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:47:58 INFO - Installing collected packages: blobuploader, requests, docopt 15:47:58 INFO - Running setup.py install for blobuploader 15:47:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:47:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:47:58 INFO - Running setup.py install for requests 15:47:59 INFO - Running setup.py install for docopt 15:47:59 INFO - Successfully installed blobuploader requests docopt 15:47:59 INFO - Cleaning up... 15:47:59 INFO - Return code: 0 15:47:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:59 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 0x7f79ba44cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29883b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a17100>, '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 0x2a18000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a18490>, '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': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', '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 15:47:59 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 15:47:59 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 15:47:59 INFO - Using env: {'DISPLAY': ':0', 15:47:59 INFO - 'HOME': '/home/cltbld', 15:47:59 INFO - 'LANG': 'en_US.UTF-8', 15:47:59 INFO - 'LANGUAGE': 'en_US:en', 15:47:59 INFO - 'LOGNAME': 'cltbld', 15:47:59 INFO - 'MAIL': '/var/mail/cltbld', 15:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:59 INFO - 'MOZ_NO_REMOTE': '1', 15:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:59 INFO - 'NO_EM_RESTART': '1', 15:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:59 INFO - 'PWD': '/builds/slave/test', 15:47:59 INFO - 'SHELL': '/bin/bash', 15:47:59 INFO - 'SHLVL': '1', 15:47:59 INFO - 'TERM': 'linux', 15:47:59 INFO - 'TMOUT': '86400', 15:47:59 INFO - 'USER': 'cltbld', 15:47:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', 15:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:59 INFO - '_': '/tools/buildbot/bin/python'} 15:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:47:59 INFO - Running setup.py (path:/tmp/pip-FaFFGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:47:59 INFO - Running setup.py (path:/tmp/pip-R8zKzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:47:59 INFO - Running setup.py (path:/tmp/pip-POyvba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:47:59 INFO - Running setup.py (path:/tmp/pip-LHbJKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:47:59 INFO - Running setup.py (path:/tmp/pip-R2s2iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:00 INFO - Running setup.py (path:/tmp/pip-yQMz7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:00 INFO - Running setup.py (path:/tmp/pip-5M2WKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:00 INFO - Running setup.py (path:/tmp/pip-j_fR7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:00 INFO - Running setup.py (path:/tmp/pip-pEKYHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:00 INFO - Running setup.py (path:/tmp/pip-pRnESO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:00 INFO - Running setup.py (path:/tmp/pip-06NLy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:00 INFO - Running setup.py (path:/tmp/pip-sYaudQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:00 INFO - Running setup.py (path:/tmp/pip-WIa5Nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:00 INFO - Running setup.py (path:/tmp/pip-SC1Pin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:00 INFO - Running setup.py (path:/tmp/pip-pvDVou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:00 INFO - Running setup.py (path:/tmp/pip-10LUPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:00 INFO - Running setup.py (path:/tmp/pip-yz30Kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:48:00 INFO - Running setup.py install for manifestparser 15:48:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:48:01 INFO - Running setup.py install for mozcrash 15:48:01 INFO - Running setup.py install for mozdebug 15:48:01 INFO - Running setup.py install for mozdevice 15:48:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:48:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:48:01 INFO - Running setup.py install for mozfile 15:48:01 INFO - Running setup.py install for mozhttpd 15:48:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:48:01 INFO - Running setup.py install for mozinfo 15:48:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:48:01 INFO - Running setup.py install for mozInstall 15:48:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:48:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:48:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:48:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:48:01 INFO - Running setup.py install for mozleak 15:48:01 INFO - Running setup.py install for mozlog 15:48:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:48:01 INFO - Running setup.py install for moznetwork 15:48:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:48:02 INFO - Running setup.py install for mozprocess 15:48:02 INFO - Running setup.py install for mozprofile 15:48:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:48:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:48:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:48:02 INFO - Running setup.py install for mozrunner 15:48:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:48:02 INFO - Running setup.py install for mozscreenshot 15:48:02 INFO - Running setup.py install for moztest 15:48:02 INFO - Running setup.py install for mozversion 15:48:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:48:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:48:02 INFO - Cleaning up... 15:48:02 INFO - Return code: 0 15:48:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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')]} 15:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f79ba44cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29883b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a17100>, '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 0x2a18000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a18490>, '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': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', '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 15:48:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:48:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:02 INFO - Using env: {'DISPLAY': ':0', 15:48:02 INFO - 'HOME': '/home/cltbld', 15:48:02 INFO - 'LANG': 'en_US.UTF-8', 15:48:02 INFO - 'LANGUAGE': 'en_US:en', 15:48:02 INFO - 'LOGNAME': 'cltbld', 15:48:02 INFO - 'MAIL': '/var/mail/cltbld', 15:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:02 INFO - 'MOZ_NO_REMOTE': '1', 15:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:02 INFO - 'NO_EM_RESTART': '1', 15:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:02 INFO - 'PWD': '/builds/slave/test', 15:48:02 INFO - 'SHELL': '/bin/bash', 15:48:02 INFO - 'SHLVL': '1', 15:48:02 INFO - 'TERM': 'linux', 15:48:02 INFO - 'TMOUT': '86400', 15:48:02 INFO - 'USER': 'cltbld', 15:48:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', 15:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:02 INFO - '_': '/tools/buildbot/bin/python'} 15:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:02 INFO - Running setup.py (path:/tmp/pip-QC7OOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:02 INFO - Running setup.py (path:/tmp/pip-W7cJrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:03 INFO - Running setup.py (path:/tmp/pip-C39ik9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:03 INFO - Running setup.py (path:/tmp/pip-fYmyEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:03 INFO - Running setup.py (path:/tmp/pip-LAlaPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:03 INFO - Running setup.py (path:/tmp/pip-N11dBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:03 INFO - Running setup.py (path:/tmp/pip-Xy_iAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:03 INFO - Running setup.py (path:/tmp/pip-eiJh4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:03 INFO - Running setup.py (path:/tmp/pip-Odr8M6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:03 INFO - Running setup.py (path:/tmp/pip-6DKTvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:03 INFO - Running setup.py (path:/tmp/pip-7loX6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:03 INFO - Running setup.py (path:/tmp/pip-bbl1z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:03 INFO - Running setup.py (path:/tmp/pip-n7d2pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:03 INFO - Running setup.py (path:/tmp/pip-axfHh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:03 INFO - Running setup.py (path:/tmp/pip-KjubTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:03 INFO - Running setup.py (path:/tmp/pip-ktpMn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:04 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)) 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:04 INFO - Running setup.py (path:/tmp/pip-KjOdnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:04 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)) 15:48:04 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)) 15:48:04 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)) 15:48:04 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)) 15:48:04 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)) 15:48:04 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)) 15:48:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:05 INFO - Downloading blessings-1.6.tar.gz 15:48:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:48:06 INFO - Installing collected packages: blessings 15:48:06 INFO - Running setup.py install for blessings 15:48:06 INFO - Successfully installed blessings 15:48:06 INFO - Cleaning up... 15:48:06 INFO - Return code: 0 15:48:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:48:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:06 INFO - Reading from file tmpfile_stdout 15:48:06 INFO - Current package versions: 15:48:06 INFO - argparse == 1.2.1 15:48:06 INFO - blessings == 1.6 15:48:06 INFO - blobuploader == 1.2.4 15:48:06 INFO - docopt == 0.6.1 15:48:06 INFO - manifestparser == 1.1 15:48:06 INFO - mozInstall == 1.12 15:48:06 INFO - mozcrash == 0.16 15:48:06 INFO - mozdebug == 0.1 15:48:06 INFO - mozdevice == 0.48 15:48:06 INFO - mozfile == 1.2 15:48:06 INFO - mozhttpd == 0.7 15:48:06 INFO - mozinfo == 0.9 15:48:06 INFO - mozleak == 0.1 15:48:06 INFO - mozlog == 3.1 15:48:06 INFO - moznetwork == 0.27 15:48:06 INFO - mozprocess == 0.22 15:48:06 INFO - mozprofile == 0.28 15:48:06 INFO - mozrunner == 6.11 15:48:06 INFO - mozscreenshot == 0.1 15:48:06 INFO - mozsystemmonitor == 0.0 15:48:06 INFO - moztest == 0.7 15:48:06 INFO - mozversion == 1.4 15:48:06 INFO - psutil == 3.1.1 15:48:06 INFO - requests == 1.2.3 15:48:06 INFO - wsgiref == 0.1.2 15:48:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f79ba44cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29883b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a17100>, '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 0x2a18000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a18490>, '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': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', '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 15:48:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:06 INFO - Using env: {'DISPLAY': ':0', 15:48:06 INFO - 'HOME': '/home/cltbld', 15:48:06 INFO - 'LANG': 'en_US.UTF-8', 15:48:06 INFO - 'LANGUAGE': 'en_US:en', 15:48:06 INFO - 'LOGNAME': 'cltbld', 15:48:06 INFO - 'MAIL': '/var/mail/cltbld', 15:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:06 INFO - 'MOZ_NO_REMOTE': '1', 15:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:06 INFO - 'NO_EM_RESTART': '1', 15:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:06 INFO - 'PWD': '/builds/slave/test', 15:48:06 INFO - 'SHELL': '/bin/bash', 15:48:06 INFO - 'SHLVL': '1', 15:48:06 INFO - 'TERM': 'linux', 15:48:06 INFO - 'TMOUT': '86400', 15:48:06 INFO - 'USER': 'cltbld', 15:48:06 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', 15:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:06 INFO - '_': '/tools/buildbot/bin/python'} 15:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:48:06 INFO - Cleaning up... 15:48:06 INFO - Return code: 0 15:48:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f79ba44cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29883b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a17100>, '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 0x2a18000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a18490>, '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': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', '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 15:48:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:48:06 INFO - Using env: {'DISPLAY': ':0', 15:48:06 INFO - 'HOME': '/home/cltbld', 15:48:06 INFO - 'LANG': 'en_US.UTF-8', 15:48:06 INFO - 'LANGUAGE': 'en_US:en', 15:48:06 INFO - 'LOGNAME': 'cltbld', 15:48:06 INFO - 'MAIL': '/var/mail/cltbld', 15:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:06 INFO - 'MOZ_NO_REMOTE': '1', 15:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:06 INFO - 'NO_EM_RESTART': '1', 15:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:06 INFO - 'PWD': '/builds/slave/test', 15:48:06 INFO - 'SHELL': '/bin/bash', 15:48:06 INFO - 'SHLVL': '1', 15:48:06 INFO - 'TERM': 'linux', 15:48:06 INFO - 'TMOUT': '86400', 15:48:06 INFO - 'USER': 'cltbld', 15:48:06 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', 15:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:06 INFO - '_': '/tools/buildbot/bin/python'} 15:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:06 INFO - Downloading/unpacking jsonschema 15:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:48:08 INFO - Downloading/unpacking functools32 (from jsonschema) 15:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:08 INFO - Downloading functools32-3.2.3-2.tar.gz 15:48:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:48:08 INFO - warning: no files found matching '*.txt' 15:48:08 INFO - no previously-included directories found matching 'build' 15:48:08 INFO - no previously-included directories found matching 'dist' 15:48:08 INFO - no previously-included directories found matching '.git*' 15:48:08 INFO - Installing collected packages: jsonschema, functools32 15:48:08 INFO - Running setup.py install for functools32 15:48:09 INFO - warning: no files found matching '*.txt' 15:48:09 INFO - no previously-included directories found matching 'build' 15:48:09 INFO - no previously-included directories found matching 'dist' 15:48:09 INFO - no previously-included directories found matching '.git*' 15:48:09 INFO - Successfully installed jsonschema functools32 15:48:09 INFO - Cleaning up... 15:48:09 INFO - Return code: 0 15:48:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:48:09 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')]} 15:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:09 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')]} 15:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:09 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 0x7f79ba44cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29883b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a17100>, '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 0x2a18000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a18490>, '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': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', '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 15:48:09 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 15:48:09 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 15:48:09 INFO - Using env: {'DISPLAY': ':0', 15:48:09 INFO - 'HOME': '/home/cltbld', 15:48:09 INFO - 'LANG': 'en_US.UTF-8', 15:48:09 INFO - 'LANGUAGE': 'en_US:en', 15:48:09 INFO - 'LOGNAME': 'cltbld', 15:48:09 INFO - 'MAIL': '/var/mail/cltbld', 15:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:09 INFO - 'MOZ_NO_REMOTE': '1', 15:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:09 INFO - 'NO_EM_RESTART': '1', 15:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:09 INFO - 'PWD': '/builds/slave/test', 15:48:09 INFO - 'SHELL': '/bin/bash', 15:48:09 INFO - 'SHLVL': '1', 15:48:09 INFO - 'TERM': 'linux', 15:48:09 INFO - 'TMOUT': '86400', 15:48:09 INFO - 'USER': 'cltbld', 15:48:09 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', 15:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:09 INFO - '_': '/tools/buildbot/bin/python'} 15:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:09 INFO - Downloading/unpacking flake8 15:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:48:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:48:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:48:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:48:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:48:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:48:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:48:11 INFO - no previously-included directories found matching 'docs/_build' 15:48:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:48:11 INFO - Running setup.py install for pep8 15:48:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:48:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:48:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:48:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:48:12 INFO - no previously-included directories found matching 'docs/_build' 15:48:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:48:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:48:12 INFO - Cleaning up... 15:48:12 INFO - Return code: 0 15:48:12 INFO - Running post-action listener: _resource_record_post_action 15:48:12 INFO - Running post-action listener: _start_resource_monitoring 15:48:12 INFO - Starting resource monitoring. 15:48:12 INFO - ##### 15:48:12 INFO - ##### Running install step. 15:48:12 INFO - ##### 15:48:12 INFO - Running pre-action listener: _resource_record_pre_action 15:48:12 INFO - Running main action method: install 15:48:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:12 INFO - Reading from file tmpfile_stdout 15:48:12 INFO - Detecting whether we're running mozinstall >=1.0... 15:48:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:48:12 INFO - Reading from file tmpfile_stdout 15:48:12 INFO - Output received: 15:48:12 INFO - Usage: mozinstall [options] installer 15:48:12 INFO - Options: 15:48:12 INFO - -h, --help show this help message and exit 15:48:12 INFO - -d DEST, --destination=DEST 15:48:12 INFO - Directory to install application into. [default: 15:48:12 INFO - "/builds/slave/test"] 15:48:12 INFO - --app=APP Application being installed. [default: firefox] 15:48:12 INFO - mkdir: /builds/slave/test/build/application 15:48:12 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'] 15:48:12 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 15:48:28 INFO - Reading from file tmpfile_stdout 15:48:28 INFO - Output received: 15:48:28 INFO - /builds/slave/test/build/application/firefox/firefox 15:48:28 INFO - Running post-action listener: _resource_record_post_action 15:48:28 INFO - ##### 15:48:28 INFO - ##### Running run-tests step. 15:48:28 INFO - ##### 15:48:28 INFO - Running pre-action listener: _resource_record_pre_action 15:48:28 INFO - Running main action method: run_tests 15:48:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:48:28 INFO - Python 2.7.3 15:48:28 INFO - Return code: 0 15:48:28 INFO - grabbing minidump binary from tooltool 15:48:28 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')]} 15:48:28 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 0x2a17100>, '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 0x2a18000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a18490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:48:28 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 15:48:28 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 15:48:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:48:28 INFO - Return code: 0 15:48:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:48:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:48:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:48:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:48:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:48:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:48:29 INFO - Return code: 0 15:48:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 15:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 15:48:29 INFO - Using env: {'DISPLAY': ':0', 15:48:29 INFO - 'HOME': '/home/cltbld', 15:48:29 INFO - 'LANG': 'en_US.UTF-8', 15:48:29 INFO - 'LANGUAGE': 'en_US:en', 15:48:29 INFO - 'LOGNAME': 'cltbld', 15:48:29 INFO - 'MAIL': '/var/mail/cltbld', 15:48:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:48:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:29 INFO - 'MOZ_NO_REMOTE': '1', 15:48:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:48:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:29 INFO - 'NO_EM_RESTART': '1', 15:48:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:29 INFO - 'PWD': '/builds/slave/test', 15:48:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:48:29 INFO - 'SHELL': '/bin/bash', 15:48:29 INFO - 'SHLVL': '1', 15:48:29 INFO - 'TERM': 'linux', 15:48:29 INFO - 'TMOUT': '86400', 15:48:29 INFO - 'USER': 'cltbld', 15:48:29 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193', 15:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:29 INFO - '_': '/tools/buildbot/bin/python'} 15:48:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 15:48:29 INFO - mozversion application_buildid: 20160301142131 15:48:29 INFO - mozversion application_changeset: d6788a70c97b5ed250e65e4d83c435fc6791e3ff 15:48:29 INFO - mozversion application_display_name: Nightly 15:48:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:48:29 INFO - mozversion application_name: Firefox 15:48:29 INFO - mozversion application_remotingname: firefox 15:48:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:48:29 INFO - mozversion application_vendor: Mozilla 15:48:29 INFO - mozversion application_version: 47.0a1 15:48:29 INFO - mozversion platform_buildid: 20160301142131 15:48:29 INFO - mozversion platform_changeset: d6788a70c97b5ed250e65e4d83c435fc6791e3ff 15:48:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:48:29 INFO - mozversion platform_version: 47.0a1 15:48:29 INFO - using testdate: 1456876109 15:48:29 INFO - actual date: 1456876109 15:48:29 INFO - starting webserver on 'localhost:43434' 15:48:29 INFO - SUITE-START | Running 2 tests 15:48:29 INFO - TEST-START | dromaeo_css 15:48:29 INFO - operating with platform_type : linux_ 15:48:29 INFO - Initialising browser for dromaeo_css test... 15:48:29 INFO - TEST-INFO | started process 22618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1PVCct/profile http://localhost:43434/getInfo.html) 15:48:33 INFO - PROCESS | 22618 | 15:48:33 INFO - PROCESS | 22618 | (process:22697): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:48:34 INFO - PROCESS | 22618 | __metrics Screen width/height:1600/1200 15:48:34 INFO - PROCESS | 22618 | colorDepth:24 15:48:34 INFO - PROCESS | 22618 | Browser inner width/height: 1024/697 15:48:34 INFO - PROCESS | 22618 | __metrics 15:48:35 ERROR - PROCESS | 22618 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 15:48:35 INFO - PROCESS | 22618 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:48:35 INFO - PROCESS | 22618 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:48:35 INFO - PROCESS | 22618 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:48:35 INFO - PROCESS | 22618 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:48:35 INFO - PROCESS | 22618 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:48:35 INFO - PROCESS | 22618 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:48:35 INFO - PROCESS | 22618 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:48:35 INFO - PROCESS | 22618 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:48:35 INFO - PROCESS | 22618 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:48:36 INFO - TEST-INFO | 22618: exit 0 15:48:36 INFO - Browser initialized. 15:48:36 INFO - Running cycle 1/1 for dromaeo_css test... 15:48:36 INFO - TEST-INFO | started process 22748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1PVCct/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:48:37 INFO - PROCESS | 22748 | 15:48:37 INFO - PROCESS | 22748 | (process:22804): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:48:48 INFO - PROCESS | 22748 | RSS: Main: 160616448 15:48:48 INFO - PROCESS | 22748 | 15:49:37 INFO - PROCESS | 22748 | 1456876177916 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] 15:51:49 INFO - PROCESS | 22748 | Cycle 1(1): loaded http://localhost:43434/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43434/tests/dromaeo/cssquery-ext.html) 15:51:50 INFO - PROCESS | 22748 | RSS: Main: 168361984 15:51:50 INFO - PROCESS | 22748 | 15:54:52 INFO - PROCESS | 22748 | Cycle 1(1): loaded http://localhost:43434/tests/dromaeo/cssquery-ext.html (next: http://localhost:43434/tests/dromaeo/cssquery-jquery.html) 15:54:52 INFO - PROCESS | 22748 | RSS: Main: 166113280 15:54:52 INFO - PROCESS | 22748 | 15:57:54 INFO - PROCESS | 22748 | Cycle 1(1): loaded http://localhost:43434/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43434/tests/dromaeo/cssquery-mootools.html) 15:57:55 INFO - PROCESS | 22748 | RSS: Main: 167092224 15:57:55 INFO - PROCESS | 22748 | 16:00:57 INFO - PROCESS | 22748 | Cycle 1(1): loaded http://localhost:43434/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43434/tests/dromaeo/cssquery-prototype.html) 16:00:57 INFO - PROCESS | 22748 | RSS: Main: 163946496 16:00:57 INFO - PROCESS | 22748 | 16:04:00 INFO - PROCESS | 22748 | Cycle 1(1): loaded http://localhost:43434/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43434/tests/dromaeo/cssquery-yui.html) 16:04:01 INFO - PROCESS | 22748 | RSS: Main: 165498880 16:04:01 INFO - PROCESS | 22748 | 16:07:03 INFO - PROCESS | 22748 | Cycle 1(1): loaded http://localhost:43434/tests/dromaeo/cssquery-yui.html (next: http://localhost:43434/tests/dromaeo/cssquery-dojo.html) 16:07:03 INFO - PROCESS | 22748 | RSS: Main: 167022592 16:07:03 INFO - PROCESS | 22748 | 16:07:03 INFO - PROCESS | 22748 | __start_tp_report 16:07:03 INFO - PROCESS | 22748 | _x_x_mozilla_page_load 16:07:03 INFO - PROCESS | 22748 | _x_x_mozilla_page_load_details 16:07:03 INFO - PROCESS | 22748 | |i|pagename|runs| 16:07:03 INFO - PROCESS | 22748 | |0;dojo.html;2640.4059086705493;2646.9809123487453;2680.664916885389;2686.019602844961;2701.7433343832336;4528.501864794878;4542.841000564977;4595.356650068993;4604.792784324705;4651.627869770418;4572.154151481978;4580.725156490605;4615.307703844425;4618.884527886805;4640.071985602876;4218.2196293685765;4223.176480586287;4232.238197124509;4292.549282325358;4370.4099946507295;4117.155983023473;4170.562090980449;4261.105167914741;4294.506131794837;4305.138972205556;4194.391813187101;4210.073783767566;4226.513950895655;4229.78851057449;4242.724222925531;4213.599708027732;4234.026173980002;4241.575842415765;4249.553796851348;4265.1469706058915;4091.161311931047;4120.690948178899;4171.124063946575;4220.78896055196;4228.175505776375;4497.9775101124615;4500.549945005506;4514.300283456069;4531.909361812745;4532.977335113336;4827.227643577011;4837.298591704183;4868.148074087056;4873.171560834667;4879.951200487985;4679.204535229019;4834.975825120887;4925.950740492585;4935.3090567320605;4943.555080042777;4514.435695538058;4523.185826551252;4541.84103556374;4547.704399214041;4555.63554915606;4911.16510193268;4954.405471343462;4976.800927962913;4980.252962055721;5025.170846810309;4771;4832.251001094836;4840.128776820206;4854.611631069506;4881.804727810848;4765.9761701191965;4855.927161092586;4907.852764417074;4937.7777999990085;4983.252512123138;4690.15577196108;4853.611711063107;4857.9028419431415;4870.464248932614;4870.780814863339;4796.5203479651755;4882.2432522959;4885.389326334208;4892.339534162914;4933.703977761345;4074.246264441088;4086.162336720965;4093.7134400592267;4118.629323360912;4142.047329114261;3521.6126226115107;3593.4789455528803;3600.927981440409;3634.036980200249;3689.3912504437003;4250.744955302692;4253.340732186516;4258.212230737324;4271.935920961126;4280.957190428118;4843.2250839865455;4860.3195552622665;4900.4854490278;4915.877103072452;4948.604111671058;4155.833766649361;4171.812268447927;4228.746275223435;4233.894152646147;4251.298535741568;4328.242557552416;4358.694891357638;4377.299632058855;4379.343098535245;4432.246518091933;4624.653151013687;4713.717176969393;4716.056788642217;4717.764111794465;4751.548602882721;4790.688605240648;4892.290617860319;4926.605871530197;4956.355673762388;4969.378827646544;4677.579017888406;4681.648876334357;4681.742504162167;4683.742394168354;4714.764261786829;4828;4859.125357435695;4859.198232291632;4886.633502487257;4921.6062714982;4777.689450185727;4797.856064318076;4812.374391329105;4938.678985865908;4970.105381031304;4651.790669419816;4717.174494463524;4750.334953106637;4750.762461876823;4777.784999675093;4765.523447655345;4767.976160119316;4777.0684716479955;4782.928256076231;4792.904141917212;4510.571495707903;4610.769461526843;4672.462666793363;4673.836415725434;4696.178168820375;4722.315264286591;4763.857084287477;4764.8332308369045;4768.690035147704;4802.711837289774;4622.890506278536;4661.3707149534375;4665.113628410591;4665.370175026328;4695.295705644181 16:07:03 INFO - PROCESS | 22748 | |1;ext.html;471.8678769944417;490.3086647826563;496.20854736694963;520.3027942556973;566.74213232979;29720.55419168714;30293.848530757343;30434.847825760895;30485.542716859236;30529.694703052963;31199.532007019912;31660.208494787643;31787;31814.36371272573;31859.52210716841;7409;7602.2397760224085;7606.923930760705;7612.619369031554;7614.619269036553;7484;7689.577073260996;7748.341390981774;7752.612369381508;7768.300852923236;7736.110347310075;7812.80467988302;7825.5304681719;7827.491213071132;7831.9216807832045;7715.807104822368;7785.571793551352;7823.413244006694;7829.1779363166615;7843.058832940083;7645.694172233104;7738.961305193494;7793.727219547345;7797.064352277706;7797.727079552245;31194.064178074696;31381.37237255265;31504.527432088307;31581;31766.682333176603;2327.674125622414;2634.5784674451997;2745.2450576091533;2752.876120574579;2765.170448865332;23310.76689233103;25425.49149017028;25483.49033019348;25519.744802552108;25721.614175787377;3340.799552026862;3428.6057103432927;3465.1337165708574;3529.8411571479346;3574.070741607201;178586.10706946513;179978;180028;181069;181687;46134.30798538025;46535.767321163854;46626.76686616545;46633.53366466292;46704.76647616808;48202;54016;55957.44042559604;56042.439575604534;56216;12123.272603643809;12130.636080917586;12324.691882703004;12434.564790232298;12596.496140154475;8678.175573320525;8678.956605216934;8720.171583699665;8729.60716767747;8786.25316848075;17419.912900435418;17541.386051488138;17574.12129393525;17622.559436013948;17659.470215893543;7092.609906455092;7213.062301900824;7315.670794814246;7322.816929576803;7383.593902335316;747.0072462686929;816.282107096218;838.3209600223838;853.2491407561306;863.1972265792748;24551.63172552413;24603.384915377257;26680.19959401221;28425;29657.85171074131;835.8579041562949;871.3769654696922;879.9560021998874;890.1632465482426;958.0706714486937;12721.173123746927;12753.872461275269;12909.677258068436;12976.610701678965;13089.541866034833;312064;312562;316608;317152;317477;41497;41654.79172604118;41944.79027604842;42303.57696423058;42308.1538369237;1091.8853520380405;1101.7465982823996;1119.1438549509633;1120.7646394257133;1122.354646078508;23743.287701368987;24568.508629827662;24627.261182164562;24692.38269043288;24918.750812491642;36142.457863131545;36696.89909302725;36756.44865326969;36807.89576312715;36874.44688329624;242487;247005;247244;247776;248010;27063.45873082488;27197;27418.31454213581;27461.45077098487;27541;34573.11834402249;35084.64915350814;35406;35685.46471802873;35752.82123589469;29708.25729356697;29991.850040749658;30109.548356775103;30202.54696179515;30434.847825761615;30433.847830760704;30434.54348184823;31064.844675776476;31441.685583143877;31780;30020.549691754204;30919.690803091682;30939.381212376076;32590;33891.830540847135;27932.30169245785;30181.547276790425;30212.395752084394;30443.695563044086;30643.693563064975;21282.574348512633;21518.354449366543;21767.673484898056;21779.56440871142;21811.890940545196 16:07:03 INFO - PROCESS | 22748 | |2;jquery.html;301.84455005672066;305.1212507977026;311.43785467231646;315.1679565945903;316.65326467518076;14759.70480590389;14797.3341199646;15119;15254.161021143847;15254.542363729079;12754.489820407172;12860.935695321534;12872.935635321834;12913.806292905614;12941.288229147392;4853.490383509734;5036.445990940993;5074.264231686403;5076.720780357079;5094.439611642716;4882.096812089775;4948.208286674133;4960.87597810054;4968.229924361712;4982.825601103962;4784.40194975628;4953.281774142747;4990.975045124769;4992.600591952653;5003.12445322069;4906;4936.580390666815;4943.209086546153;4975.353204083446;4981.178105612569;4362.694611377205;4390.4511936008;4510.842120525798;4718.952810471886;4732.1482133216;10365.896341036569;10481.58073677052;10527.684169474927;10567.365958042543;11703.765924681544;1758.639478906821;1762.2510433065895;2043.6423625865414;2292.117534749117;2305.13557415969;7892.447528672995;8093.595320233965;8261.586920653943;8264.710735124241;8382.49115159271;1635.803703555581;1679.2863033210836;1713.2119225156318;1731.7748692669998;1762.55936015996;42640.11120840212;43084.138317233796;48644.99999999964;52914.470855291336;53224.46775532272;9276.582553785096;9352.67265645699;9369.765755856159;9506.524673766284;9520;11958.04335653163;11970.162088653884;11997.880021199677;12034.81947770784;12074.698132546757;5909.763609455659;5951.821445356646;6126.387361263838;6149;6181.81454556355;5593.972030139823;5761.48146666802;5816.854578635483;5831.679257640871;5841.532677385884;3912.158885839558;3922.3332033554366;3929.76421414716;4025.6175663311938;4054.8175332110127;1471.6909449015827;1513.6291608555755;1522.885783566237;1524.5273965070642;1532.862042416188;784.9764507064797;840.8318336332758;843.7131375332416;900.6442455230148;931.4504442379028;13299.335033248492;13562.254076025913;14334.928325358307;14660.193689347188;15027.774583381259;758.707897459471;776.8834674798712;785.8310463250428;793.8452001859697;842.2377748137945;8374.036985746718;8508.234258916727;8531.872021919677;8546.401751877433;8606.182412670787;351315;351803;352269;364423;366417;61008.69495652582;61792.382076179565;62988.370116299164;63637;64218.35781642217;746.0972223609385;827.1934863508152;861.2507118806553;862.491130233153;863.6588547523819;11602.419879005847;11914.16600837933;11920.344381058778;11934.104942129548;11965.641030769091;30553.388932220787;30559.847200763856;30634.234144146576;30731.692683072884;31023.0693079208;41209;43218.783906080265;43454.78272608617;43659;43919;6591.538592298493;6614.768483103068;6836.760713375008;6846.110005699227;6920.51556391068;9503.857442138511;10201.081902628799;10281.640142594973;10604.575816967235;10670.57317707314;9374.67188648394;9429.292803039936;9584.089511496397;9631.08504692053;9636.75908102303;8991.235744961752;9050.230730387728;9155.359124861196;9494.192993595621;9516.33385662997;9575.90424095778;9586.185174259987;9602.95198524003;9705.466199359103;9806.901930980599;6338.302786693368;6433.453156481752;6849.212340580897;6866.416354609914;6995.860082798417;8307.169283071886;9038.09619038091;9253.768655783659;9479.573419196015;9596.95201523988 16:07:03 INFO - PROCESS | 22748 | |3;mootools.html;1266.9429875655594;1270.4473554004012;1295.391166151909;1514.4699355225666;1515.719591875503;5827.184194212803;6486.5783724057965;6580.572262802914;6605.966970165155;6625.17185351831;6615.073889655452;6674.399304062634;6692.096566963459;6696.062551242818;6721.3950744433;2007.1870892288646;2048.8258498027685;2050.661640829261;2050.9794902051012;2052.48687828043;1996.5707372914821;2002.8898410587412;2019.2932473634185;2047.651899177136;2050.1184490669007;1996.6306233346877;2002.179106566308;2019.798020197983;2019.8182163605272;2020.4140799168224;2014.6977953307048;2024.4635171679517;2037.6943458481198;2037.8777273363646;2040.5918816236663;1965.1549833571557;1972.36884197057;2007.9196832126697;2019.9899000504904;2023.0592774359993;6867.862642747117;6897.275786042494;6901.965490172517;6906.620135892524;6943.166819981635;3749.643783840558;3805.809709514513;3822.8279727412055;3862.208247309295;3874.6900247980375;2541.606051062088;2646.338415396151;2665.2803742989286;2692.1250593557174;2692.488427198826;893.2318206342541;901.8692289618034;909.9909000909972;919.1543779722671;931.7065124485765;9180.678676246365;9234;9234.953825230898;9255.722328330161;9287.396319239228;3517.8944631661093;3630.6006339303185;3645.9453108203397;3703.500027496307;3713.442983552489;7865.764027079197;7916.050073991158;7935.960320198362;7947.9205207948335;7979.48133371329;3797.3924172132324;3840.5007349044445;3859.826307816099;3871.845126194921;3900.551436584829;2980.240038790138;3340.0981734931433;3387.458006718962;3442.7417943653827;3468.514407982884;3089.1968088296753;3134.81191128533;3140.6231252249418;3162.509810979302;3167.319026409333;987.3730181334761;996.3225006995312;1002.04304888831;1003.6336737090909;1004.6182450668845;1036.6734478639205;1043.118564812732;1044.1959691037857;1051.4847724614883;1051.831706926888;6149.96925015372;6172.166757487682;6214.130021796952;6227.844303892439;6235.407636274546;417.2864401872831;418.1949746737518;426.3774888662525;427.3674961057652;427.7305297662453;4901.485344038896;4922.630802689812;4930.383702037246;4932.580730637864;4946.925796112989;7738.187490313549;7863.9213607863185;8001.399895007898;8034.638441270157;8069.112397636255;7972.720954766555;8005.799855003672;8014.318782903402;8025.879611805711;8064.233897779702;6565.704543295563;6591.110200122922;6655.900161497581;6657.633830139389;6675.566088204251;6334.90497642545;6335.334789847;6387.105805187371;6396.968015159894;6453.193350831146;7287.380572651384;7334;7490.101187857492;7547.433942454448;7561.3950883928055;7554.2823431773895;7656.310932016146;7711.9614401929875;7850.2542258485355;7870.212978702084;5050.621203409833;5728.484436400744;5786.132080188006;5853.151293062568;5888.676122813286;6183.752649894134;6212.316645168938;6246.843828904313;6250;6263.812085637438;5709.400512946081;5716.114002329646;5782.074868021096;5795.594308398372;5842.883142337215;5480.616356854982;5566.832995010156;5597.63615365;5601.551875849841;5662.377138514842;5753.8561535961935;6084.39156084388;6258;6271.905921411091;6277.964135917522;5540.36285827135;5543.2793736815565;5547.362053363915;5562.193481945176;5599.32808063035;5586.748596313095;5654.264945557051;5680.318361796611;5688.687122208318;5698.772049118154 16:07:03 INFO - PROCESS | 22748 | |4;prototype.html;272.7749606574576;275.41749200441063;278.6391622848411;278.8006575298661;279.26274634963687;5501.229827824098;5590.077637189864;5593.188987596796;5628.549716022719;5666.858328541788;5547.1679248112805;5570.2480165177685;5573.637713548616;5618.775248990036;5654.123610840316;4218.915621687564;4223.282042052843;4224.577542245782;4226.4716910386205;4235.703500754948;4219.725717828347;4224.134052519226;4232.76719780412;4233.703640745149;4237.555056719047;4196.034911970249;4197.958020419787;4203.579642035803;4204.990802207479;4210.368444733299;4194.832206711728;4197.4753155855515;4199.118185181115;4206.453161089039;4208.053188032699;3429.7599168057995;3563.964360356389;3597.4244120940784;3605.56733192016;3621.311950729353;5313;5328.653637513549;5331.866703332447;5362.088444964365;5379.892402151974;4777.474477807438;4780.521947805191;4783.808647654089;4790.784414701312;4795.880102997418;5609.411011843779;5716.971415142898;5735.483806457439;5827.388124246978;5829.300483941955;3820.4269359596005;3824.0631045394057;3831.1379939513663;3834.616538346171;3834.8082595870374;6128.938710612882;6181.072839074175;6184.752609895599;6192.87614247717;6202.565820392574;3865.864694735727;3879.3017256893468;3883.9611603884164;3890.5525864525375;3892.0853599404118;3936.547297060875;3937.409388591734;3948.151147503243;3949.921001579952;3963.8810835674976;4662.300654901792;4681.32120842476;4682.08034705769;4682.906341873144;4688.085823264499;5704.258446401941;5885.823425297248;5887.8233652990475;5890.617109887844;5901.757332213731;1391.8468968413467;1401.474447082344;1401.8528054554329;1403.2702994443036;1403.8455769865307;892.0811564088999;904.0688091266006;914.6752902719572;921.3550514639645;924.3621900888365;5028.396592408934;5073.847784566469;5110.156824124052;5113.360829896263;5122.87192820175;6187.041008643668;6204.844878877974;6204.906926396107;6213.813585592439;6217.191765070512;5130.589552835764;5141.9742901286;5147.356580427447;5154.690718556899;5158.561522270574;3308.156420112904;3345.514900339437;3350.1289664687356;3352.245744707421;3352.580927384077;5830.038043722739;5844.211031510692;5893.911591326134;5902.61632993854;5909.054551271776;6130.724117414727;6284.591501552384;6376.202974628171;6381.266154392211;6391.265004524539;5742.885142297214;5763.88472230553;5781.132830075522;5797.217375654317;5809.186713860147;6109.45014948639;6149.907751383822;6184.041473571604;6186.10301506288;6196.287426945959;6008.609440386361;6028.367021462858;6032.426919442646;6041.305249896318;6046.183765191819;5742.425757424224;5767.971160144172;5811.128330750421;5820.563457740602;5833.416658334133;3777.301199278142;3879.398693202558;3890.396988466792;3963;3991.5409727881665;6088.786892458743;6096.0855871619615;6098.359672234352;6103.877922441615;6126.6017708848785;5822.3304320003745;5844.6785426801935;5853.736581853742;5879.412058794257;5881.7647294107755;5883.323417806836;5884.47039766423;5886.911696324644;5888.411158884077;5896.056630939029;5764.855878603068;5765;5766.221560089334;5767.971160144172;5782.10377391505;5744.885102297847;5956.374580668968;5977.491913187428;5991.041433370639;5996.2504686914135;5801.680907550125;5831.970840145772;5832.533397328119;5836.212111364912;5842.912356314574 16:07:03 INFO - PROCESS | 22748 | |5;yui.html;597.1848426897286;650.4633677216298;666.0741569218784;676.3101636330942;688.6591137386994;11136.721581960444;11153.442327883604;11221.887781122206;11250.26873253238;11281.266717663357;10165.898341016587;10634.149268058556;10651.041406273434;10669.946650266756;10693.625723099674;542.8371488553438;645.5706954875003;647.6437959122476;648.0764910003251;652.7911068458095;657.4805903336382;660.6762686283711;662.6322391072953;664.2029564522568;664.6610228783331;697.9720811167547;701.8315604254993;702.8032150997703;704.1093017333078;705.1432509500955;688.5730846874944;689.524228282486;690.2924502385046;690.3165865792879;691.965401729914;513.568602374004;513.6661170239374;514.3827407111444;516.0144124721801;518.044208435436;11077;11109.44452777366;11235.66293011211;11255.086635271942;11264.267822591506;11126.165537584713;11377.601783937522;11527.077833773277;11663.358515281656;11836.881631183664;9076.546172691405;9120.498372589505;9129.954350228207;9269.165775080208;9279.67521136757;3153.195935036574;3171.9682803171904;3177.9841100794347;3206.1663967368418;3228.7255583275214;38641;39083.41374879379;39221;39307;39336.606633933865;8292.58537073144;8570.614322355508;8696.826063478822;8704.825903482022;8822.691205807765;15265.160416177217;15332.386704531917;15406;15442.922785386001;15522;6059.8485037873525;6268.623882567061;6350.809475715736;6442.742290308429;6496.805095847038;3515.9472607910902;3520.8591656333974;3557.0395993081725;3569.714422846166;3582.0507565495163;2438.890249938757;2516.484120755241;2522.735112813128;2527.8230523863153;2527.936801579975;471.71225552413;485.45386440254714;489.0488000838406;489.63032910153316;494.15006189354256;469.68061718032067;539.6761942834268;557.565099222607;559.7732918168149;567.7615401531367;6912.239653638096;6974.197967233833;6994.370506654425;7131.500794944408;7206.711731530785;421.59105667502473;422.5964204184996;438.6556553105797;502;545.5053154357113;3065.3103051813164;3184.9616245602833;3187.346593948235;3212.3093534890113;3224.8871289504755;47120.29319560209;47189;47193;47214;48011.519884801404;41064.17871642551;41280.587194128275;41517.79241103775;41794.37308440376;41846.790766045975;38605.22789544193;39009.80495097506;39081.80459097686;39559.40660890089;39642.80178599146;6886.276940921131;6888.931110688829;6938.028675985265;7047.47143964215;7191.640417979184;28863.7113628861;29469.852650736608;29587.704122958494;29633.703662963093;30506.694933051273;33859.492107617916;34249.82875085609;34804.78183263675;38546.229075418894;38673.41989870098;8469;8655.221030107321;8730.825383492422;8827;8828.64685412602;10566.682999510027;10636.627718030142;10643.254972151875;10935;11065.723356916142;9580.568874400808;9592.280578956466;9620.37467564606;9772.85340719904;10014.599416023277;9252.907470925205;9351.766205844908;9452.149306562442;9464.905350946403;9612.423254604746;9421.340506164503;9506.382085164441;9508.572114254737;9557.713268601952;9652.420854748456;8513.06356300794;8681.435706679045;8816;8830.293576513992;8944.37389382737;8519.446235994888;8862.601182946912;8897.110288971051;8908.10918908104;8940.418872773249 16:07:03 INFO - PROCESS | 22748 | __end_tp_report 16:07:03 INFO - PROCESS | 22748 | __start_cc_report 16:07:03 INFO - PROCESS | 22748 | _x_x_mozilla_cycle_collect,349 16:07:03 INFO - PROCESS | 22748 | __end_cc_report 16:07:03 INFO - PROCESS | 22748 | __startTimestamp1456877223562__endTimestamp 16:07:03 INFO - PROCESS | 22748 | 16:07:03 INFO - PROCESS | 22748 | ------- Summary: start ------- 16:07:03 INFO - PROCESS | 22748 | Number of tests: 6 16:07:03 INFO - PROCESS | 22748 | 16:07:03 INFO - PROCESS | 22748 | [#0] dojo.html Cycles:165 Average:4521.47 Median:4665.37 stddev:455.92 (9.8%) stddev-sans-first:432.78 16:07:03 INFO - PROCESS | 22748 | Values: 2640.4 2647.0 2680.7 2686.0 2701.7 4528.5 4542.8 4595.4 4604.8 4651.6 4572.2 4580.7 4615.3 4618.9 4640.1 4218.2 4223.2 4232.2 4292.5 4370.4 4117.2 4170.6 4261.1 4294.5 4305.1 4194.4 4210.1 4226.5 4229.8 4242.7 4213.6 4234.0 4241.6 4249.6 4265.1 4091.2 4120.7 4171.1 4220.8 4228.2 4498.0 4500.5 4514.3 4531.9 4533.0 4827.2 4837.3 4868.1 4873.2 4880.0 4679.2 4835.0 4926.0 4935.3 4943.6 4514.4 4523.2 4541.8 4547.7 4555.6 4911.2 4954.4 4976.8 4980.3 5025.2 4771.0 4832.3 4840.1 4854.6 4881.8 4766.0 4855.9 4907.9 4937.8 4983.3 4690.2 4853.6 4857.9 4870.5 4870.8 4796.5 4882.2 4885.4 4892.3 4933.7 4074.2 4086.2 4093.7 4118.6 4142.0 3521.6 3593.5 3600.9 3634.0 3689.4 4250.7 4253.3 4258.2 4271.9 4281.0 4843.2 4860.3 4900.5 4915.9 4948.6 4155.8 4171.8 4228.7 4233.9 4251.3 4328.2 4358.7 4377.3 4379.3 4432.2 4624.7 4713.7 4716.1 4717.8 4751.5 4790.7 4892.3 4926.6 4956.4 4969.4 4677.6 4681.6 4681.7 4683.7 4714.8 4828.0 4859.1 4859.2 4886.6 4921.6 4777.7 4797.9 4812.4 4938.7 4970.1 4651.8 4717.2 4750.3 4750.8 4777.8 4765.5 4768.0 4777.1 4782.9 4792.9 4510.6 4610.8 4672.5 4673.8 4696.2 4722.3 4763.9 4764.8 4768.7 4802.7 4622.9 4661.4 4665.1 4665.4 4695.3 16:07:03 INFO - PROCESS | 22748 | 16:07:03 INFO - PROCESS | 22748 | [#1] ext.html Cycles:180 Average:39020.90 Median:316880.00 stddev:66467.84 (21.0%) stddev-sans-first:66591.28 16:07:03 INFO - PROCESS | 22748 | Values: 471.9 490.3 496.2 520.3 566.7 29720.6 30293.8 30434.8 30485.5 30529.7 31199.5 31660.2 31787.0 31814.4 31859.5 7409.0 7602.2 7606.9 7612.6 7614.6 7484.0 7689.6 7748.3 7752.6 7768.3 7736.1 7812.8 7825.5 7827.5 7831.9 7715.8 7785.6 7823.4 7829.2 7843.1 7645.7 7739.0 7793.7 7797.1 7797.7 31194.1 31381.4 31504.5 31581.0 31766.7 2327.7 2634.6 2745.2 2752.9 2765.2 23310.8 25425.5 25483.5 25519.7 25721.6 3340.8 3428.6 3465.1 3529.8 3574.1 178586.1 179978.0 180028.0 181069.0 181687.0 46134.3 46535.8 46626.8 46633.5 46704.8 48202.0 54016.0 55957.4 56042.4 56216.0 12123.3 12130.6 12324.7 12434.6 12596.5 8678.2 8679.0 8720.2 8729.6 8786.3 17419.9 17541.4 17574.1 17622.6 17659.5 7092.6 7213.1 7315.7 7322.8 7383.6 747.0 816.3 838.3 853.2 863.2 24551.6 24603.4 26680.2 28425.0 29657.9 835.9 871.4 880.0 890.2 958.1 12721.2 12753.9 12909.7 12976.6 13089.5 312064.0 312562.0 316608.0 317152.0 317477.0 41497.0 41654.8 41944.8 42303.6 42308.2 1091.9 1101.7 1119.1 1120.8 1122.4 23743.3 24568.5 24627.3 24692.4 24918.8 36142.5 36696.9 36756.4 36807.9 36874.4 242487.0 247005.0 247244.0 247776.0 248010.0 27063.5 27197.0 27418.3 27461.5 27541.0 34573.1 35084.6 35406.0 35685.5 35752.8 29708.3 29991.9 30109.5 30202.5 30434.8 30433.8 30434.5 31064.8 31441.7 31780.0 30020.5 30919.7 30939.4 32590.0 33891.8 27932.3 30181.5 30212.4 30443.7 30643.7 21282.6 21518.4 21767.7 21779.6 21811.9 16:07:03 INFO - PROCESS | 22748 | 16:07:03 INFO - PROCESS | 22748 | [#2] jquery.html Cycles:180 Average:20949.56 Median:4964.55 stddev:58598.21 (1180.3%) stddev-sans-first:58742.08 16:07:03 INFO - PROCESS | 22748 | Values: 301.8 305.1 311.4 315.2 316.7 14759.7 14797.3 15119.0 15254.2 15254.5 12754.5 12860.9 12872.9 12913.8 12941.3 4853.5 5036.4 5074.3 5076.7 5094.4 4882.1 4948.2 4960.9 4968.2 4982.8 4784.4 4953.3 4991.0 4992.6 5003.1 4906.0 4936.6 4943.2 4975.4 4981.2 4362.7 4390.5 4510.8 4719.0 4732.1 10365.9 10481.6 10527.7 10567.4 11703.8 1758.6 1762.3 2043.6 2292.1 2305.1 7892.4 8093.6 8261.6 8264.7 8382.5 1635.8 1679.3 1713.2 1731.8 1762.6 42640.1 43084.1 48645.0 52914.5 53224.5 9276.6 9352.7 9369.8 9506.5 9520.0 11958.0 11970.2 11997.9 12034.8 12074.7 5909.8 5951.8 6126.4 6149.0 6181.8 5594.0 5761.5 5816.9 5831.7 5841.5 3912.2 3922.3 3929.8 4025.6 4054.8 1471.7 1513.6 1522.9 1524.5 1532.9 785.0 840.8 843.7 900.6 931.5 13299.3 13562.3 14334.9 14660.2 15027.8 758.7 776.9 785.8 793.8 842.2 8374.0 8508.2 8531.9 8546.4 8606.2 351315.0 351803.0 352269.0 364423.0 366417.0 61008.7 61792.4 62988.4 63637.0 64218.4 746.1 827.2 861.3 862.5 863.7 11602.4 11914.2 11920.3 11934.1 11965.6 30553.4 30559.8 30634.2 30731.7 31023.1 41209.0 43218.8 43454.8 43659.0 43919.0 6591.5 6614.8 6836.8 6846.1 6920.5 9503.9 10201.1 10281.6 10604.6 10670.6 9374.7 9429.3 9584.1 9631.1 9636.8 8991.2 9050.2 9155.4 9494.2 9516.3 9575.9 9586.2 9603.0 9705.5 9806.9 6338.3 6433.5 6849.2 6866.4 6995.9 8307.2 9038.1 9253.8 9479.6 9597.0 16:07:03 INFO - PROCESS | 22748 | 16:07:03 INFO - PROCESS | 22748 | [#3] mootools.html Cycles:180 Average:4675.67 Median:5671.35 stddev:2461.19 (43.4%) stddev-sans-first:2454.76 16:07:03 INFO - PROCESS | 22748 | Values: 1266.9 1270.4 1295.4 1514.5 1515.7 5827.2 6486.6 6580.6 6606.0 6625.2 6615.1 6674.4 6692.1 6696.1 6721.4 2007.2 2048.8 2050.7 2051.0 2052.5 1996.6 2002.9 2019.3 2047.7 2050.1 1996.6 2002.2 2019.8 2019.8 2020.4 2014.7 2024.5 2037.7 2037.9 2040.6 1965.2 1972.4 2007.9 2020.0 2023.1 6867.9 6897.3 6902.0 6906.6 6943.2 3749.6 3805.8 3822.8 3862.2 3874.7 2541.6 2646.3 2665.3 2692.1 2692.5 893.2 901.9 910.0 919.2 931.7 9180.7 9234.0 9235.0 9255.7 9287.4 3517.9 3630.6 3645.9 3703.5 3713.4 7865.8 7916.1 7936.0 7947.9 7979.5 3797.4 3840.5 3859.8 3871.8 3900.6 2980.2 3340.1 3387.5 3442.7 3468.5 3089.2 3134.8 3140.6 3162.5 3167.3 987.4 996.3 1002.0 1003.6 1004.6 1036.7 1043.1 1044.2 1051.5 1051.8 6150.0 6172.2 6214.1 6227.8 6235.4 417.3 418.2 426.4 427.4 427.7 4901.5 4922.6 4930.4 4932.6 4946.9 7738.2 7863.9 8001.4 8034.6 8069.1 7972.7 8005.8 8014.3 8025.9 8064.2 6565.7 6591.1 6655.9 6657.6 6675.6 6334.9 6335.3 6387.1 6397.0 6453.2 7287.4 7334.0 7490.1 7547.4 7561.4 7554.3 7656.3 7712.0 7850.3 7870.2 5050.6 5728.5 5786.1 5853.2 5888.7 6183.8 6212.3 6246.8 6250.0 6263.8 5709.4 5716.1 5782.1 5795.6 5842.9 5480.6 5566.8 5597.6 5601.6 5662.4 5753.9 6084.4 6258.0 6271.9 6278.0 5540.4 5543.3 5547.4 5562.2 5599.3 5586.7 5654.3 5680.3 5688.7 5698.8 16:07:03 INFO - PROCESS | 22748 | 16:07:03 INFO - PROCESS | 22748 | [#4] prototype.html Cycles:180 Average:4818.46 Median:5601.30 stddev:1487.68 (26.6%) stddev-sans-first:1452.20 16:07:03 INFO - PROCESS | 22748 | Values: 272.8 275.4 278.6 278.8 279.3 5501.2 5590.1 5593.2 5628.5 5666.9 5547.2 5570.2 5573.6 5618.8 5654.1 4218.9 4223.3 4224.6 4226.5 4235.7 4219.7 4224.1 4232.8 4233.7 4237.6 4196.0 4198.0 4203.6 4205.0 4210.4 4194.8 4197.5 4199.1 4206.5 4208.1 3429.8 3564.0 3597.4 3605.6 3621.3 5313.0 5328.7 5331.9 5362.1 5379.9 4777.5 4780.5 4783.8 4790.8 4795.9 5609.4 5717.0 5735.5 5827.4 5829.3 3820.4 3824.1 3831.1 3834.6 3834.8 6128.9 6181.1 6184.8 6192.9 6202.6 3865.9 3879.3 3884.0 3890.6 3892.1 3936.5 3937.4 3948.2 3949.9 3963.9 4662.3 4681.3 4682.1 4682.9 4688.1 5704.3 5885.8 5887.8 5890.6 5901.8 1391.8 1401.5 1401.9 1403.3 1403.8 892.1 904.1 914.7 921.4 924.4 5028.4 5073.8 5110.2 5113.4 5122.9 6187.0 6204.8 6204.9 6213.8 6217.2 5130.6 5142.0 5147.4 5154.7 5158.6 3308.2 3345.5 3350.1 3352.2 3352.6 5830.0 5844.2 5893.9 5902.6 5909.1 6130.7 6284.6 6376.2 6381.3 6391.3 5742.9 5763.9 5781.1 5797.2 5809.2 6109.5 6149.9 6184.0 6186.1 6196.3 6008.6 6028.4 6032.4 6041.3 6046.2 5742.4 5768.0 5811.1 5820.6 5833.4 3777.3 3879.4 3890.4 3963.0 3991.5 6088.8 6096.1 6098.4 6103.9 6126.6 5822.3 5844.7 5853.7 5879.4 5881.8 5883.3 5884.5 5886.9 5888.4 5896.1 5764.9 5765.0 5766.2 5768.0 5782.1 5744.9 5956.4 5977.5 5991.0 5996.3 5801.7 5832.0 5832.5 5836.2 5842.9 16:07:03 INFO - PROCESS | 22748 | 16:07:03 INFO - PROCESS | 22748 | [#5] yui.html Cycles:180 Average:11507.84 Median:507.78 stddev:13089.17 (2577.7%) stddev-sans-first:13100.24 16:07:03 INFO - PROCESS | 22748 | Values: 597.2 650.5 666.1 676.3 688.7 11136.7 11153.4 11221.9 11250.3 11281.3 10165.9 10634.1 10651.0 10669.9 10693.6 542.8 645.6 647.6 648.1 652.8 657.5 660.7 662.6 664.2 664.7 698.0 701.8 702.8 704.1 705.1 688.6 689.5 690.3 690.3 692.0 513.6 513.7 514.4 516.0 518.0 11077.0 11109.4 11235.7 11255.1 11264.3 11126.2 11377.6 11527.1 11663.4 11836.9 9076.5 9120.5 9130.0 9269.2 9279.7 3153.2 3172.0 3178.0 3206.2 3228.7 38641.0 39083.4 39221.0 39307.0 39336.6 8292.6 8570.6 8696.8 8704.8 8822.7 15265.2 15332.4 15406.0 15442.9 15522.0 6059.8 6268.6 6350.8 6442.7 6496.8 3515.9 3520.9 3557.0 3569.7 3582.1 2438.9 2516.5 2522.7 2527.8 2527.9 471.7 485.5 489.0 489.6 494.2 469.7 539.7 557.6 559.8 567.8 6912.2 6974.2 6994.4 7131.5 7206.7 421.6 422.6 438.7 502.0 545.5 3065.3 3185.0 3187.3 3212.3 3224.9 47120.3 47189.0 47193.0 47214.0 48011.5 41064.2 41280.6 41517.8 41794.4 41846.8 38605.2 39009.8 39081.8 39559.4 39642.8 6886.3 6888.9 6938.0 7047.5 7191.6 28863.7 29469.9 29587.7 29633.7 30506.7 33859.5 34249.8 34804.8 38546.2 38673.4 8469.0 8655.2 8730.8 8827.0 8828.6 10566.7 10636.6 10643.3 10935.0 11065.7 9580.6 9592.3 9620.4 9772.9 10014.6 9252.9 9351.8 9452.1 9464.9 9612.4 9421.3 9506.4 9508.6 9557.7 9652.4 8513.1 8681.4 8816.0 8830.3 8944.4 8519.4 8862.6 8897.1 8908.1 8940.4 16:07:03 INFO - PROCESS | 22748 | -------- Summary: end -------- 16:07:03 INFO - PROCESS | 22748 | 16:07:03 INFO - PROCESS | 22748 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:07:03 INFO - PROCESS | 22748 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:07:03 INFO - PROCESS | 22748 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:07:03 INFO - PROCESS | 22748 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:07:03 INFO - PROCESS | 22748 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:07:03 INFO - PROCESS | 22748 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:07:03 INFO - PROCESS | 22748 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:07:03 INFO - PROCESS | 22748 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:07:04 INFO - TEST-INFO | 22748: exit 0 16:07:04 INFO - TEST-OK | dromaeo_css | took 1114811ms 16:07:04 INFO - TEST-START | kraken 16:07:04 INFO - operating with platform_type : linux_ 16:07:04 INFO - Initialising browser for kraken test... 16:07:04 INFO - TEST-INFO | started process 22983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF4Xwwt/profile http://localhost:43434/getInfo.html) 16:07:08 INFO - PROCESS | 22983 | 16:07:08 INFO - PROCESS | 22983 | (process:23053): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:07:09 INFO - PROCESS | 22983 | __metrics Screen width/height:1600/1200 16:07:09 INFO - PROCESS | 22983 | colorDepth:24 16:07:09 INFO - PROCESS | 22983 | Browser inner width/height: 1024/697 16:07:09 INFO - PROCESS | 22983 | __metrics 16:07:09 ERROR - PROCESS | 22983 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:07:09 INFO - PROCESS | 22983 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:07:09 INFO - PROCESS | 22983 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:07:09 INFO - PROCESS | 22983 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:07:09 INFO - PROCESS | 22983 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:07:09 INFO - PROCESS | 22983 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:07:09 INFO - PROCESS | 22983 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:07:09 INFO - PROCESS | 22983 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:07:09 INFO - PROCESS | 22983 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:07:09 INFO - PROCESS | 22983 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:07:10 INFO - TEST-INFO | 22983: exit 0 16:07:10 INFO - Browser initialized. 16:07:10 INFO - Running cycle 1/1 for kraken test... 16:07:10 INFO - TEST-INFO | started process 23104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF4Xwwt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:12 INFO - PROCESS | 23104 | 16:07:12 INFO - PROCESS | 23104 | (process:23162): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:07:22 INFO - PROCESS | 23104 | RSS: Main: 160681984 16:07:22 INFO - PROCESS | 23104 | 16:07:25 INFO - PROCESS | 23104 | Cycle 1(1): loaded http://localhost:43434/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43434/tests/kraken/driver.html?testName=audio-beat-detection) 16:07:26 INFO - PROCESS | 23104 | RSS: Main: 167956480 16:07:26 INFO - PROCESS | 23104 | 16:07:28 INFO - PROCESS | 23104 | Cycle 1(1): loaded http://localhost:43434/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43434/tests/kraken/driver.html?testName=audio-dft) 16:07:29 INFO - PROCESS | 23104 | RSS: Main: 169975808 16:07:29 INFO - PROCESS | 23104 | 16:07:32 INFO - PROCESS | 23104 | Cycle 1(1): loaded http://localhost:43434/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43434/tests/kraken/driver.html?testName=audio-fft) 16:07:33 INFO - PROCESS | 23104 | RSS: Main: 163319808 16:07:33 INFO - PROCESS | 23104 | 16:07:35 INFO - PROCESS | 23104 | Cycle 1(1): loaded http://localhost:43434/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43434/tests/kraken/driver.html?testName=audio-oscillator) 16:07:35 INFO - PROCESS | 23104 | RSS: Main: 162062336 16:07:35 INFO - PROCESS | 23104 | 16:07:37 INFO - PROCESS | 23104 | Cycle 1(1): loaded http://localhost:43434/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43434/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:07:38 INFO - PROCESS | 23104 | RSS: Main: 165040128 16:07:38 INFO - PROCESS | 23104 | 16:07:41 INFO - PROCESS | 23104 | Cycle 1(1): loaded http://localhost:43434/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43434/tests/kraken/driver.html?testName=imaging-darkroom) 16:07:42 INFO - PROCESS | 23104 | RSS: Main: 165261312 16:07:42 INFO - PROCESS | 23104 | 16:07:45 INFO - PROCESS | 23104 | Cycle 1(1): loaded http://localhost:43434/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43434/tests/kraken/driver.html?testName=imaging-desaturate) 16:07:46 INFO - PROCESS | 23104 | RSS: Main: 164106240 16:07:46 INFO - PROCESS | 23104 | 16:07:49 INFO - PROCESS | 23104 | Cycle 1(1): loaded http://localhost:43434/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43434/tests/kraken/driver.html?testName=json-parse-financial) 16:07:49 INFO - PROCESS | 23104 | RSS: Main: 165658624 16:07:49 INFO - PROCESS | 23104 | 16:07:51 INFO - PROCESS | 23104 | Cycle 1(1): loaded http://localhost:43434/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43434/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:07:52 INFO - PROCESS | 23104 | RSS: Main: 165318656 16:07:52 INFO - PROCESS | 23104 | 16:07:54 INFO - PROCESS | 23104 | Cycle 1(1): loaded http://localhost:43434/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43434/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:07:54 INFO - PROCESS | 23104 | RSS: Main: 164368384 16:07:54 INFO - PROCESS | 23104 | 16:07:56 INFO - PROCESS | 23104 | Cycle 1(1): loaded http://localhost:43434/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43434/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:07:57 INFO - PROCESS | 23104 | RSS: Main: 165847040 16:07:57 INFO - PROCESS | 23104 | 16:08:00 INFO - PROCESS | 23104 | Cycle 1(1): loaded http://localhost:43434/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:08:00 INFO - PROCESS | 23104 | RSS: Main: 166002688 16:08:00 INFO - PROCESS | 23104 | 16:08:03 INFO - PROCESS | 23104 | Cycle 1(1): loaded http://localhost:43434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:08:04 INFO - PROCESS | 23104 | RSS: Main: 164454400 16:08:04 INFO - PROCESS | 23104 | 16:08:05 INFO - PROCESS | 23104 | Cycle 1(1): loaded http://localhost:43434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43434/tests/kraken/driver.html?testName=ai-astar) 16:08:06 INFO - PROCESS | 23104 | RSS: Main: 167202816 16:08:06 INFO - PROCESS | 23104 | 16:08:06 INFO - PROCESS | 23104 | __start_tp_report 16:08:06 INFO - PROCESS | 23104 | _x_x_mozilla_page_load 16:08:06 INFO - PROCESS | 23104 | _x_x_mozilla_page_load_details 16:08:06 INFO - PROCESS | 23104 | |i|pagename|runs| 16:08:06 INFO - PROCESS | 23104 | |0;ai-astar;115;109;117;116;116;125;113;114;115;116 16:08:06 INFO - PROCESS | 23104 | |1;audio-beat-detection;163;136;156;167;134;167;160;136;168;134 16:08:06 INFO - PROCESS | 23104 | |2;audio-dft;162;164;164;164;163;168;168;162;166;163 16:08:06 INFO - PROCESS | 23104 | |3;audio-fft;73;76;74;74;74;153;73;73;77;74 16:08:06 INFO - PROCESS | 23104 | |4;audio-oscillator;96;96;134;95;96;95;142;95;96;132 16:08:06 INFO - PROCESS | 23104 | |5;imaging-gaussian-blur;118;120;117;117;118;118;119;119;117;118 16:08:06 INFO - PROCESS | 23104 | |6;imaging-darkroom;148;149;147;148;148;149;148;148;148;147 16:08:06 INFO - PROCESS | 23104 | |7;imaging-desaturate;95;96;96;95;97;96;97;96;96;97 16:08:06 INFO - PROCESS | 23104 | |8;json-parse-financial;75;70;68;68;70;69;69;76;67;67 16:08:06 INFO - PROCESS | 23104 | |9;json-stringify-tinderbox;71;73;70;71;71;71;71;71;71;71 16:08:06 INFO - PROCESS | 23104 | |10;stanford-crypto-aes;84;85;86;94;85;93;86;93;86;86 16:08:06 INFO - PROCESS | 23104 | |11;stanford-crypto-ccm;128;124;129;125;125;134;122;122;123;119 16:08:06 INFO - PROCESS | 23104 | |12;stanford-crypto-pbkdf2;141;151;152;154;146;152;152;154;151;141 16:08:06 INFO - PROCESS | 23104 | |13;stanford-crypto-sha256-iterative;73;72;73;72;72;74;71;71;72;71 16:08:06 INFO - PROCESS | 23104 | __end_tp_report 16:08:06 INFO - PROCESS | 23104 | __start_cc_report 16:08:06 INFO - PROCESS | 23104 | _x_x_mozilla_cycle_collect,851 16:08:06 INFO - PROCESS | 23104 | __end_cc_report 16:08:06 INFO - PROCESS | 23104 | __startTimestamp1456877286086__endTimestamp 16:08:06 INFO - PROCESS | 23104 | 16:08:06 INFO - PROCESS | 23104 | ------- Summary: start ------- 16:08:06 INFO - PROCESS | 23104 | Number of tests: 14 16:08:06 INFO - PROCESS | 23104 | 16:08:06 INFO - PROCESS | 23104 | [#0] ai-astar Cycles:10 Average:115.60 Median:116.00 stddev:4.01 (3.5%) stddev-sans-first:4.24 16:08:06 INFO - PROCESS | 23104 | Values: 115.0 109.0 117.0 116.0 116.0 125.0 113.0 114.0 115.0 116.0 16:08:06 INFO - PROCESS | 23104 | 16:08:06 INFO - PROCESS | 23104 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:161.50 stddev:15.15 (9.4%) stddev-sans-first:15.55 16:08:06 INFO - PROCESS | 23104 | Values: 163.0 136.0 156.0 167.0 134.0 167.0 160.0 136.0 168.0 134.0 16:08:06 INFO - PROCESS | 23104 | 16:08:06 INFO - PROCESS | 23104 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:2.22 (1.4%) stddev-sans-first:2.18 16:08:06 INFO - PROCESS | 23104 | Values: 162.0 164.0 164.0 164.0 163.0 168.0 168.0 162.0 166.0 163.0 16:08:06 INFO - PROCESS | 23104 | 16:08:06 INFO - PROCESS | 23104 | [#3] audio-fft Cycles:10 Average:82.10 Median:74.00 stddev:24.95 (33.7%) stddev-sans-first:26.24 16:08:06 INFO - PROCESS | 23104 | Values: 73.0 76.0 74.0 74.0 74.0 153.0 73.0 73.0 77.0 74.0 16:08:06 INFO - PROCESS | 23104 | 16:08:06 INFO - PROCESS | 23104 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:95.50 stddev:19.69 (20.6%) stddev-sans-first:20.43 16:08:06 INFO - PROCESS | 23104 | Values: 96.0 96.0 134.0 95.0 96.0 95.0 142.0 95.0 96.0 132.0 16:08:06 INFO - PROCESS | 23104 | 16:08:06 INFO - PROCESS | 23104 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:1.05 16:08:06 INFO - PROCESS | 23104 | Values: 118.0 120.0 117.0 117.0 118.0 118.0 119.0 119.0 117.0 118.0 16:08:06 INFO - PROCESS | 23104 | 16:08:06 INFO - PROCESS | 23104 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 16:08:06 INFO - PROCESS | 23104 | Values: 148.0 149.0 147.0 148.0 148.0 149.0 148.0 148.0 148.0 147.0 16:08:06 INFO - PROCESS | 23104 | 16:08:06 INFO - PROCESS | 23104 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 16:08:06 INFO - PROCESS | 23104 | Values: 95.0 96.0 96.0 95.0 97.0 96.0 97.0 96.0 96.0 97.0 16:08:06 INFO - PROCESS | 23104 | 16:08:06 INFO - PROCESS | 23104 | [#8] json-parse-financial Cycles:10 Average:69.90 Median:69.50 stddev:3.14 (4.5%) stddev-sans-first:2.74 16:08:06 INFO - PROCESS | 23104 | Values: 75.0 70.0 68.0 68.0 70.0 69.0 69.0 76.0 67.0 67.0 16:08:06 INFO - PROCESS | 23104 | 16:08:06 INFO - PROCESS | 23104 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.00 stddev:0.74 (1.0%) stddev-sans-first:0.78 16:08:06 INFO - PROCESS | 23104 | Values: 71.0 73.0 70.0 71.0 71.0 71.0 71.0 71.0 71.0 71.0 16:08:06 INFO - PROCESS | 23104 | 16:08:06 INFO - PROCESS | 23104 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:86.00 stddev:3.88 (4.5%) stddev-sans-first:3.87 16:08:06 INFO - PROCESS | 23104 | Values: 84.0 85.0 86.0 94.0 85.0 93.0 86.0 93.0 86.0 86.0 16:08:06 INFO - PROCESS | 23104 | 16:08:06 INFO - PROCESS | 23104 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:125.00 stddev:4.28 (3.4%) stddev-sans-first:4.41 16:08:06 INFO - PROCESS | 23104 | Values: 128.0 124.0 129.0 125.0 125.0 134.0 122.0 122.0 123.0 119.0 16:08:06 INFO - PROCESS | 23104 | 16:08:06 INFO - PROCESS | 23104 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:152.00 stddev:4.95 (3.3%) stddev-sans-first:4.21 16:08:06 INFO - PROCESS | 23104 | Values: 141.0 151.0 152.0 154.0 146.0 152.0 152.0 154.0 151.0 141.0 16:08:06 INFO - PROCESS | 23104 | 16:08:06 INFO - PROCESS | 23104 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.00 stddev:0.99 (1.4%) stddev-sans-first:1.00 16:08:06 INFO - PROCESS | 23104 | Values: 73.0 72.0 73.0 72.0 72.0 74.0 71.0 71.0 72.0 71.0 16:08:06 INFO - PROCESS | 23104 | -------- Summary: end -------- 16:08:06 INFO - PROCESS | 23104 | 16:08:06 INFO - PROCESS | 23104 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:08:06 INFO - PROCESS | 23104 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:08:06 INFO - PROCESS | 23104 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:08:06 INFO - PROCESS | 23104 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:08:06 INFO - PROCESS | 23104 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:08:06 INFO - PROCESS | 23104 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:08:06 INFO - PROCESS | 23104 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:08:07 INFO - TEST-INFO | 23104: exit 0 16:08:07 INFO - TEST-OK | kraken | took 62816ms 16:08:07 INFO - SUITE-END | took 1177s 16:08:07 INFO - Completed test suite (00:19:37) 16:08:07 INFO - Working with test: dromaeo_css 16:08:07 INFO - Generating results file: dromaeo_css 16:08:07 INFO - Working with test: kraken 16:08:07 INFO - Generating results file: kraken 16:08:07 INFO - javascript benchmark 16:08:07 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:08:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 16:08:07 INFO - process_Request line: dromaeo_css 5917.37 graph.html#tests=[[72,94,43]] 16:08:07 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:08:07 INFO - process_Request line: kraken 1559.50 graph.html#tests=[[232,94,43]] 16:08:07 INFO - RETURN: dromaeo_css: 5917.37 16:08:07 INFO - RETURN: kraken: 1559.50 16:08:07 INFO - javascript benchmark 16:08:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2640.4059086705493, 2646.9809123487453, 2680.664916885389, 2686.019602844961, 2701.7433343832336, 4528.501864794878, 4542.841000564977, 4595.356650068993, 4604.792784324705, 4651.627869770418, 4572.154151481978, 4580.725156490605, 4615.307703844425, 4618.884527886805, 4640.071985602876, 4218.2196293685765, 4223.176480586287, 4232.238197124509, 4292.549282325358, 4370.4099946507295, 4117.155983023473, 4170.562090980449, 4261.105167914741, 4294.506131794837, 4305.138972205556, 4194.391813187101, 4210.073783767566, 4226.513950895655, 4229.78851057449, 4242.724222925531, 4213.599708027732, 4234.026173980002, 4241.575842415765, 4249.553796851348, 4265.1469706058915, 4091.161311931047, 4120.690948178899, 4171.124063946575, 4220.78896055196, 4228.175505776375, 4497.9775101124615, 4500.549945005506, 4514.300283456069, 4531.909361812745, 4532.977335113336, 4827.227643577011, 4837.298591704183, 4868.148074087056, 4873.171560834667, 4879.951200487985, 4679.204535229019, 4834.975825120887, 4925.950740492585, 4935.3090567320605, 4943.555080042777, 4514.435695538058, 4523.185826551252, 4541.84103556374, 4547.704399214041, 4555.63554915606, 4911.16510193268, 4954.405471343462, 4976.800927962913, 4980.252962055721, 5025.170846810309, 4771.0, 4832.251001094836, 4840.128776820206, 4854.611631069506, 4881.804727810848, 4765.9761701191965, 4855.927161092586, 4907.852764417074, 4937.7777999990085, 4983.252512123138, 4690.15577196108, 4853.611711063107, 4857.9028419431415, 4870.464248932614, 4870.780814863339, 4796.5203479651755, 4882.2432522959, 4885.389326334208, 4892.339534162914, 4933.703977761345, 4074.246264441088, 4086.162336720965, 4093.7134400592267, 4118.629323360912, 4142.047329114261, 3521.6126226115107, 3593.4789455528803, 3600.927981440409, 3634.036980200249, 3689.3912504437003, 4250.744955302692, 4253.340732186516, 4258.212230737324, 4271.935920961126, 4280.957190428118, 4843.2250839865455, 4860.3195552622665, 4900.4854490278, 4915.877103072452, 4948.604111671058, 4155.833766649361, 4171.812268447927, 4228.746275223435, 4233.894152646147, 4251.298535741568, 4328.242557552416, 4358.694891357638, 4377.299632058855, 4379.343098535245, 4432.246518091933, 4624.653151013687, 4713.717176969393, 4716.056788642217, 4717.764111794465, 4751.548602882721, 4790.688605240648, 4892.290617860319, 4926.605871530197, 4956.355673762388, 4969.378827646544, 4677.579017888406, 4681.648876334357, 4681.742504162167, 4683.742394168354, 4714.764261786829, 4828.0, 4859.125357435695, 4859.198232291632, 4886.633502487257, 4921.6062714982, 4777.689450185727, 4797.856064318076, 4812.374391329105, 4938.678985865908, 4970.105381031304, 4651.790669419816, 4717.174494463524, 4750.334953106637, 4750.762461876823, 4777.784999675093, 4765.523447655345, 4767.976160119316, 4777.0684716479955, 4782.928256076231, 4792.904141917212, 4510.571495707903, 4610.769461526843, 4672.462666793363, 4673.836415725434, 4696.178168820375, 4722.315264286591, 4763.857084287477, 4764.8332308369045, 4768.690035147704, 4802.711837289774, 4622.890506278536, 4661.3707149534375, 4665.113628410591, 4665.370175026328, 4695.295705644181], "unit": "score", "name": "dojo.html", "value": 4494.065532851649}, {"lowerIsBetter": false, "replicates": [471.8678769944417, 490.3086647826563, 496.20854736694963, 520.3027942556973, 566.74213232979, 29720.55419168714, 30293.848530757343, 30434.847825760895, 30485.542716859236, 30529.694703052963, 31199.532007019912, 31660.208494787643, 31787.0, 31814.36371272573, 31859.52210716841, 7409.0, 7602.2397760224085, 7606.923930760705, 7612.619369031554, 7614.619269036553, 7484.0, 7689.577073260996, 7748.341390981774, 7752.612369381508, 7768.300852923236, 7736.110347310075, 7812.80467988302, 7825.5304681719, 7827.491213071132, 7831.9216807832045, 7715.807104822368, 7785.571793551352, 7823.413244006694, 7829.1779363166615, 7843.058832940083, 7645.694172233104, 7738.961305193494, 7793.727219547345, 7797.064352277706, 7797.727079552245, 31194.064178074696, 31381.37237255265, 31504.527432088307, 31581.0, 31766.682333176603, 2327.674125622414, 2634.5784674451997, 2745.2450576091533, 2752.876120574579, 2765.170448865332, 23310.76689233103, 25425.49149017028, 25483.49033019348, 25519.744802552108, 25721.614175787377, 3340.799552026862, 3428.6057103432927, 3465.1337165708574, 3529.8411571479346, 3574.070741607201, 178586.10706946513, 179978.0, 180028.0, 181069.0, 181687.0, 46134.30798538025, 46535.767321163854, 46626.76686616545, 46633.53366466292, 46704.76647616808, 48202.0, 54016.0, 55957.44042559604, 56042.439575604534, 56216.0, 12123.272603643809, 12130.636080917586, 12324.691882703004, 12434.564790232298, 12596.496140154475, 8678.175573320525, 8678.956605216934, 8720.171583699665, 8729.60716767747, 8786.25316848075, 17419.912900435418, 17541.386051488138, 17574.12129393525, 17622.559436013948, 17659.470215893543, 7092.609906455092, 7213.062301900824, 7315.670794814246, 7322.816929576803, 7383.593902335316, 747.0072462686929, 816.282107096218, 838.3209600223838, 853.2491407561306, 863.1972265792748, 24551.63172552413, 24603.384915377257, 26680.19959401221, 28425.0, 29657.85171074131, 835.8579041562949, 871.3769654696922, 879.9560021998874, 890.1632465482426, 958.0706714486937, 12721.173123746927, 12753.872461275269, 12909.677258068436, 12976.610701678965, 13089.541866034833, 312064.0, 312562.0, 316608.0, 317152.0, 317477.0, 41497.0, 41654.79172604118, 41944.79027604842, 42303.57696423058, 42308.1538369237, 1091.8853520380405, 1101.7465982823996, 1119.1438549509633, 1120.7646394257133, 1122.354646078508, 23743.287701368987, 24568.508629827662, 24627.261182164562, 24692.38269043288, 24918.750812491642, 36142.457863131545, 36696.89909302725, 36756.44865326969, 36807.89576312715, 36874.44688329624, 242487.0, 247005.0, 247244.0, 247776.0, 248010.0, 27063.45873082488, 27197.0, 27418.31454213581, 27461.45077098487, 27541.0, 34573.11834402249, 35084.64915350814, 35406.0, 35685.46471802873, 35752.82123589469, 29708.25729356697, 29991.850040749658, 30109.548356775103, 30202.54696179515, 30434.847825761615, 30433.847830760704, 30434.54348184823, 31064.844675776476, 31441.685583143877, 31780.0, 30020.549691754204, 30919.690803091682, 30939.381212376076, 32590.0, 33891.830540847135, 27932.30169245785, 30181.547276790425, 30212.395752084394, 30443.695563044086, 30643.693563064975, 21282.574348512633, 21518.354449366543, 21767.673484898056, 21779.56440871142, 21811.890940545196], "unit": "score", "name": "ext.html", "value": 15611.33730901656}, {"lowerIsBetter": false, "replicates": [301.84455005672066, 305.1212507977026, 311.43785467231646, 315.1679565945903, 316.65326467518076, 14759.70480590389, 14797.3341199646, 15119.0, 15254.161021143847, 15254.542363729079, 12754.489820407172, 12860.935695321534, 12872.935635321834, 12913.806292905614, 12941.288229147392, 4853.490383509734, 5036.445990940993, 5074.264231686403, 5076.720780357079, 5094.439611642716, 4882.096812089775, 4948.208286674133, 4960.87597810054, 4968.229924361712, 4982.825601103962, 4784.40194975628, 4953.281774142747, 4990.975045124769, 4992.600591952653, 5003.12445322069, 4906.0, 4936.580390666815, 4943.209086546153, 4975.353204083446, 4981.178105612569, 4362.694611377205, 4390.4511936008, 4510.842120525798, 4718.952810471886, 4732.1482133216, 10365.896341036569, 10481.58073677052, 10527.684169474927, 10567.365958042543, 11703.765924681544, 1758.639478906821, 1762.2510433065895, 2043.6423625865414, 2292.117534749117, 2305.13557415969, 7892.447528672995, 8093.595320233965, 8261.586920653943, 8264.710735124241, 8382.49115159271, 1635.803703555581, 1679.2863033210836, 1713.2119225156318, 1731.7748692669998, 1762.55936015996, 42640.11120840212, 43084.138317233796, 48644.99999999964, 52914.470855291336, 53224.46775532272, 9276.582553785096, 9352.67265645699, 9369.765755856159, 9506.524673766284, 9520.0, 11958.04335653163, 11970.162088653884, 11997.880021199677, 12034.81947770784, 12074.698132546757, 5909.763609455659, 5951.821445356646, 6126.387361263838, 6149.0, 6181.81454556355, 5593.972030139823, 5761.48146666802, 5816.854578635483, 5831.679257640871, 5841.532677385884, 3912.158885839558, 3922.3332033554366, 3929.76421414716, 4025.6175663311938, 4054.8175332110127, 1471.6909449015827, 1513.6291608555755, 1522.885783566237, 1524.5273965070642, 1532.862042416188, 784.9764507064797, 840.8318336332758, 843.7131375332416, 900.6442455230148, 931.4504442379028, 13299.335033248492, 13562.254076025913, 14334.928325358307, 14660.193689347188, 15027.774583381259, 758.707897459471, 776.8834674798712, 785.8310463250428, 793.8452001859697, 842.2377748137945, 8374.036985746718, 8508.234258916727, 8531.872021919677, 8546.401751877433, 8606.182412670787, 351315.0, 351803.0, 352269.0, 364423.0, 366417.0, 61008.69495652582, 61792.382076179565, 62988.370116299164, 63637.0, 64218.35781642217, 746.0972223609385, 827.1934863508152, 861.2507118806553, 862.491130233153, 863.6588547523819, 11602.419879005847, 11914.16600837933, 11920.344381058778, 11934.104942129548, 11965.641030769091, 30553.388932220787, 30559.847200763856, 30634.234144146576, 30731.692683072884, 31023.0693079208, 41209.0, 43218.783906080265, 43454.78272608617, 43659.0, 43919.0, 6591.538592298493, 6614.768483103068, 6836.760713375008, 6846.110005699227, 6920.51556391068, 9503.857442138511, 10201.081902628799, 10281.640142594973, 10604.575816967235, 10670.57317707314, 9374.67188648394, 9429.292803039936, 9584.089511496397, 9631.08504692053, 9636.75908102303, 8991.235744961752, 9050.230730387728, 9155.359124861196, 9494.192993595621, 9516.33385662997, 9575.90424095778, 9586.185174259987, 9602.95198524003, 9705.466199359103, 9806.901930980599, 6338.302786693368, 6433.453156481752, 6849.212340580897, 6866.416354609914, 6995.860082798417, 8307.169283071886, 9038.09619038091, 9253.768655783659, 9479.573419196015, 9596.95201523988], "unit": "score", "name": "jquery.html", "value": 7125.587376424214}, {"lowerIsBetter": false, "replicates": [1266.9429875655594, 1270.4473554004012, 1295.391166151909, 1514.4699355225666, 1515.719591875503, 5827.184194212803, 6486.5783724057965, 6580.572262802914, 6605.966970165155, 6625.17185351831, 6615.073889655452, 6674.399304062634, 6692.096566963459, 6696.062551242818, 6721.3950744433, 2007.1870892288646, 2048.8258498027685, 2050.661640829261, 2050.9794902051012, 2052.48687828043, 1996.5707372914821, 2002.8898410587412, 2019.2932473634185, 2047.651899177136, 2050.1184490669007, 1996.6306233346877, 2002.179106566308, 2019.798020197983, 2019.8182163605272, 2020.4140799168224, 2014.6977953307048, 2024.4635171679517, 2037.6943458481198, 2037.8777273363646, 2040.5918816236663, 1965.1549833571557, 1972.36884197057, 2007.9196832126697, 2019.9899000504904, 2023.0592774359993, 6867.862642747117, 6897.275786042494, 6901.965490172517, 6906.620135892524, 6943.166819981635, 3749.643783840558, 3805.809709514513, 3822.8279727412055, 3862.208247309295, 3874.6900247980375, 2541.606051062088, 2646.338415396151, 2665.2803742989286, 2692.1250593557174, 2692.488427198826, 893.2318206342541, 901.8692289618034, 909.9909000909972, 919.1543779722671, 931.7065124485765, 9180.678676246365, 9234.0, 9234.953825230898, 9255.722328330161, 9287.396319239228, 3517.8944631661093, 3630.6006339303185, 3645.9453108203397, 3703.500027496307, 3713.442983552489, 7865.764027079197, 7916.050073991158, 7935.960320198362, 7947.9205207948335, 7979.48133371329, 3797.3924172132324, 3840.5007349044445, 3859.826307816099, 3871.845126194921, 3900.551436584829, 2980.240038790138, 3340.0981734931433, 3387.458006718962, 3442.7417943653827, 3468.514407982884, 3089.1968088296753, 3134.81191128533, 3140.6231252249418, 3162.509810979302, 3167.319026409333, 987.3730181334761, 996.3225006995312, 1002.04304888831, 1003.6336737090909, 1004.6182450668845, 1036.6734478639205, 1043.118564812732, 1044.1959691037857, 1051.4847724614883, 1051.831706926888, 6149.96925015372, 6172.166757487682, 6214.130021796952, 6227.844303892439, 6235.407636274546, 417.2864401872831, 418.1949746737518, 426.3774888662525, 427.3674961057652, 427.7305297662453, 4901.485344038896, 4922.630802689812, 4930.383702037246, 4932.580730637864, 4946.925796112989, 7738.187490313549, 7863.9213607863185, 8001.399895007898, 8034.638441270157, 8069.112397636255, 7972.720954766555, 8005.799855003672, 8014.318782903402, 8025.879611805711, 8064.233897779702, 6565.704543295563, 6591.110200122922, 6655.900161497581, 6657.633830139389, 6675.566088204251, 6334.90497642545, 6335.334789847, 6387.105805187371, 6396.968015159894, 6453.193350831146, 7287.380572651384, 7334.0, 7490.101187857492, 7547.433942454448, 7561.3950883928055, 7554.2823431773895, 7656.310932016146, 7711.9614401929875, 7850.2542258485355, 7870.212978702084, 5050.621203409833, 5728.484436400744, 5786.132080188006, 5853.151293062568, 5888.676122813286, 6183.752649894134, 6212.316645168938, 6246.843828904313, 6250.0, 6263.812085637438, 5709.400512946081, 5716.114002329646, 5782.074868021096, 5795.594308398372, 5842.883142337215, 5480.616356854982, 5566.832995010156, 5597.63615365, 5601.551875849841, 5662.377138514842, 5753.8561535961935, 6084.39156084388, 6258.0, 6271.905921411091, 6277.964135917522, 5540.36285827135, 5543.2793736815565, 5547.362053363915, 5562.193481945176, 5599.32808063035, 5586.748596313095, 5654.264945557051, 5680.318361796611, 5688.687122208318, 5698.772049118154], "unit": "score", "name": "mootools.html", "value": 3781.446700128993}, {"lowerIsBetter": false, "replicates": [272.7749606574576, 275.41749200441063, 278.6391622848411, 278.8006575298661, 279.26274634963687, 5501.229827824098, 5590.077637189864, 5593.188987596796, 5628.549716022719, 5666.858328541788, 5547.1679248112805, 5570.2480165177685, 5573.637713548616, 5618.775248990036, 5654.123610840316, 4218.915621687564, 4223.282042052843, 4224.577542245782, 4226.4716910386205, 4235.703500754948, 4219.725717828347, 4224.134052519226, 4232.76719780412, 4233.703640745149, 4237.555056719047, 4196.034911970249, 4197.958020419787, 4203.579642035803, 4204.990802207479, 4210.368444733299, 4194.832206711728, 4197.4753155855515, 4199.118185181115, 4206.453161089039, 4208.053188032699, 3429.7599168057995, 3563.964360356389, 3597.4244120940784, 3605.56733192016, 3621.311950729353, 5313.0, 5328.653637513549, 5331.866703332447, 5362.088444964365, 5379.892402151974, 4777.474477807438, 4780.521947805191, 4783.808647654089, 4790.784414701312, 4795.880102997418, 5609.411011843779, 5716.971415142898, 5735.483806457439, 5827.388124246978, 5829.300483941955, 3820.4269359596005, 3824.0631045394057, 3831.1379939513663, 3834.616538346171, 3834.8082595870374, 6128.938710612882, 6181.072839074175, 6184.752609895599, 6192.87614247717, 6202.565820392574, 3865.864694735727, 3879.3017256893468, 3883.9611603884164, 3890.5525864525375, 3892.0853599404118, 3936.547297060875, 3937.409388591734, 3948.151147503243, 3949.921001579952, 3963.8810835674976, 4662.300654901792, 4681.32120842476, 4682.08034705769, 4682.906341873144, 4688.085823264499, 5704.258446401941, 5885.823425297248, 5887.8233652990475, 5890.617109887844, 5901.757332213731, 1391.8468968413467, 1401.474447082344, 1401.8528054554329, 1403.2702994443036, 1403.8455769865307, 892.0811564088999, 904.0688091266006, 914.6752902719572, 921.3550514639645, 924.3621900888365, 5028.396592408934, 5073.847784566469, 5110.156824124052, 5113.360829896263, 5122.87192820175, 6187.041008643668, 6204.844878877974, 6204.906926396107, 6213.813585592439, 6217.191765070512, 5130.589552835764, 5141.9742901286, 5147.356580427447, 5154.690718556899, 5158.561522270574, 3308.156420112904, 3345.514900339437, 3350.1289664687356, 3352.245744707421, 3352.580927384077, 5830.038043722739, 5844.211031510692, 5893.911591326134, 5902.61632993854, 5909.054551271776, 6130.724117414727, 6284.591501552384, 6376.202974628171, 6381.266154392211, 6391.265004524539, 5742.885142297214, 5763.88472230553, 5781.132830075522, 5797.217375654317, 5809.186713860147, 6109.45014948639, 6149.907751383822, 6184.041473571604, 6186.10301506288, 6196.287426945959, 6008.609440386361, 6028.367021462858, 6032.426919442646, 6041.305249896318, 6046.183765191819, 5742.425757424224, 5767.971160144172, 5811.128330750421, 5820.563457740602, 5833.416658334133, 3777.301199278142, 3879.398693202558, 3890.396988466792, 3963.0, 3991.5409727881665, 6088.786892458743, 6096.0855871619615, 6098.359672234352, 6103.877922441615, 6126.6017708848785, 5822.3304320003745, 5844.6785426801935, 5853.736581853742, 5879.412058794257, 5881.7647294107755, 5883.323417806836, 5884.47039766423, 5886.911696324644, 5888.411158884077, 5896.056630939029, 5764.855878603068, 5765.0, 5766.221560089334, 5767.971160144172, 5782.10377391505, 5744.885102297847, 5956.374580668968, 5977.491913187428, 5991.041433370639, 5996.2504686914135, 5801.680907550125, 5831.970840145772, 5832.533397328119, 5836.212111364912, 5842.912356314574], "unit": "score", "name": "prototype.html", "value": 4319.08819475247}, {"lowerIsBetter": false, "replicates": [597.1848426897286, 650.4633677216298, 666.0741569218784, 676.3101636330942, 688.6591137386994, 11136.721581960444, 11153.442327883604, 11221.887781122206, 11250.26873253238, 11281.266717663357, 10165.898341016587, 10634.149268058556, 10651.041406273434, 10669.946650266756, 10693.625723099674, 542.8371488553438, 645.5706954875003, 647.6437959122476, 648.0764910003251, 652.7911068458095, 657.4805903336382, 660.6762686283711, 662.6322391072953, 664.2029564522568, 664.6610228783331, 697.9720811167547, 701.8315604254993, 702.8032150997703, 704.1093017333078, 705.1432509500955, 688.5730846874944, 689.524228282486, 690.2924502385046, 690.3165865792879, 691.965401729914, 513.568602374004, 513.6661170239374, 514.3827407111444, 516.0144124721801, 518.044208435436, 11077.0, 11109.44452777366, 11235.66293011211, 11255.086635271942, 11264.267822591506, 11126.165537584713, 11377.601783937522, 11527.077833773277, 11663.358515281656, 11836.881631183664, 9076.546172691405, 9120.498372589505, 9129.954350228207, 9269.165775080208, 9279.67521136757, 3153.195935036574, 3171.9682803171904, 3177.9841100794347, 3206.1663967368418, 3228.7255583275214, 38641.0, 39083.41374879379, 39221.0, 39307.0, 39336.606633933865, 8292.58537073144, 8570.614322355508, 8696.826063478822, 8704.825903482022, 8822.691205807765, 15265.160416177217, 15332.386704531917, 15406.0, 15442.922785386001, 15522.0, 6059.8485037873525, 6268.623882567061, 6350.809475715736, 6442.742290308429, 6496.805095847038, 3515.9472607910902, 3520.8591656333974, 3557.0395993081725, 3569.714422846166, 3582.0507565495163, 2438.890249938757, 2516.484120755241, 2522.735112813128, 2527.8230523863153, 2527.936801579975, 471.71225552413, 485.45386440254714, 489.0488000838406, 489.63032910153316, 494.15006189354256, 469.68061718032067, 539.6761942834268, 557.565099222607, 559.7732918168149, 567.7615401531367, 6912.239653638096, 6974.197967233833, 6994.370506654425, 7131.500794944408, 7206.711731530785, 421.59105667502473, 422.5964204184996, 438.6556553105797, 502.0, 545.5053154357113, 3065.3103051813164, 3184.9616245602833, 3187.346593948235, 3212.3093534890113, 3224.8871289504755, 47120.29319560209, 47189.0, 47193.0, 47214.0, 48011.519884801404, 41064.17871642551, 41280.587194128275, 41517.79241103775, 41794.37308440376, 41846.790766045975, 38605.22789544193, 39009.80495097506, 39081.80459097686, 39559.40660890089, 39642.80178599146, 6886.276940921131, 6888.931110688829, 6938.028675985265, 7047.47143964215, 7191.640417979184, 28863.7113628861, 29469.852650736608, 29587.704122958494, 29633.703662963093, 30506.694933051273, 33859.492107617916, 34249.82875085609, 34804.78183263675, 38546.229075418894, 38673.41989870098, 8469.0, 8655.221030107321, 8730.825383492422, 8827.0, 8828.64685412602, 10566.682999510027, 10636.627718030142, 10643.254972151875, 10935.0, 11065.723356916142, 9580.568874400808, 9592.280578956466, 9620.37467564606, 9772.85340719904, 10014.599416023277, 9252.907470925205, 9351.766205844908, 9452.149306562442, 9464.905350946403, 9612.423254604746, 9421.340506164503, 9506.382085164441, 9508.572114254737, 9557.713268601952, 9652.420854748456, 8513.06356300794, 8681.435706679045, 8816.0, 8830.293576513992, 8944.37389382737, 8519.446235994888, 8862.601182946912, 8897.110288971051, 8908.10918908104, 8940.418872773249], "unit": "score", "name": "yui.html", "value": 5257.511434029956}], "name": "dromaeo_css", "value": 5917.37260025763}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 117.0, 116.0, 116.0, 125.0, 113.0, 114.0, 115.0, 116.0], "unit": "score", "name": "ai-astar", "value": 115.6}, {"lowerIsBetter": true, "replicates": [163.0, 136.0, 156.0, 167.0, 134.0, 167.0, 160.0, 136.0, 168.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 152.1}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 164.0, 164.0, 163.0, 168.0, 168.0, 162.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 74.0, 74.0, 74.0, 153.0, 73.0, 73.0, 77.0, 74.0], "unit": "score", "name": "audio-fft", "value": 82.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 134.0, 95.0, 96.0, 95.0, 142.0, 95.0, 96.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [118.0, 120.0, 117.0, 117.0, 118.0, 118.0, 119.0, 119.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 118.1}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 147.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 97.0, 96.0, 97.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [75.0, 70.0, 68.0, 68.0, 70.0, 69.0, 69.0, 76.0, 67.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 69.9}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 70.0, 71.0, 71.0, 71.0, 71.0, 71.0, 71.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.1}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 94.0, 85.0, 93.0, 86.0, 93.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [128.0, 124.0, 129.0, 125.0, 125.0, 134.0, 122.0, 122.0, 123.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.1}, {"lowerIsBetter": true, "replicates": [141.0, 151.0, 152.0, 154.0, 146.0, 152.0, 152.0, 154.0, 151.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 72.0, 72.0, 74.0, 71.0, 71.0, 72.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.1}], "name": "kraken", "value": 1559.5}]} 16:08:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1559.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "5917.37"}}} 16:08:07 INFO - Return code: 0 16:08:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:08:07 ERROR - # TBPL SUCCESS # 16:08:07 INFO - Running post-action listener: _resource_record_post_action 16:08:07 INFO - Running post-run listener: _resource_record_post_run 16:08:08 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 529625088; Read time: 0; Write time: 790520 16:08:08 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 240775168; Read time: 0; Write time: 433672 16:08:08 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 287535104; Read time: 0; Write time: 356520 16:08:08 INFO - Running post-run listener: _upload_blobber_files 16:08:08 INFO - Blob upload gear active. 16:08:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:08:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:08:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:08:08 INFO - (blobuploader) - INFO - Open directory for files ... 16:08:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:08:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:08:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:09 INFO - (blobuploader) - INFO - Done attempting. 16:08:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:08:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:08:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:10 INFO - (blobuploader) - INFO - Done attempting. 16:08:10 INFO - (blobuploader) - INFO - Iteration through files over. 16:08:10 INFO - Return code: 0 16:08:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:08:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:08:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35c5cbc03c25a7b3a12f8efe55a1bc3d6a233edc41a2630a2ed1479d19e21fc586d062d7585010f1b6bb8fecff5589f08ebcc72fa5a4e166430d4e87ca95208e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4821b07a5088993d8bb115c332bb5e89b871c495dd180df28912eebe69f58c4b4e9f80ad1ffc9dce87521a8ff7bd1020de0653d5cbb15bdd01966e19c63e860f"} 16:08:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:08:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:08:10 INFO - Contents: 16:08:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35c5cbc03c25a7b3a12f8efe55a1bc3d6a233edc41a2630a2ed1479d19e21fc586d062d7585010f1b6bb8fecff5589f08ebcc72fa5a4e166430d4e87ca95208e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4821b07a5088993d8bb115c332bb5e89b871c495dd180df28912eebe69f58c4b4e9f80ad1ffc9dce87521a8ff7bd1020de0653d5cbb15bdd01966e19c63e860f"} 16:08:10 INFO - Running post-run listener: copy_logs_to_upload_dir 16:08:10 INFO - Copying logs to upload dir... 16:08:10 INFO - mkdir: /builds/slave/test/build/upload/logs 16:08:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.381378 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-01 16:08:10.006922) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 16:08:10.010619) ========= 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=836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193 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/Firefox-Non-PGO/sha512/35c5cbc03c25a7b3a12f8efe55a1bc3d6a233edc41a2630a2ed1479d19e21fc586d062d7585010f1b6bb8fecff5589f08ebcc72fa5a4e166430d4e87ca95208e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4821b07a5088993d8bb115c332bb5e89b871c495dd180df28912eebe69f58c4b4e9f80ad1ffc9dce87521a8ff7bd1020de0653d5cbb15bdd01966e19c63e860f"} build_url:https://queue.taskcluster.net/v1/task/LflQATdaSQOV_E_BpeJ3XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/LflQATdaSQOV_E_BpeJ3XQ/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/Firefox-Non-PGO/sha512/35c5cbc03c25a7b3a12f8efe55a1bc3d6a233edc41a2630a2ed1479d19e21fc586d062d7585010f1b6bb8fecff5589f08ebcc72fa5a4e166430d4e87ca95208e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4821b07a5088993d8bb115c332bb5e89b871c495dd180df28912eebe69f58c4b4e9f80ad1ffc9dce87521a8ff7bd1020de0653d5cbb15bdd01966e19c63e860f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 16:08:10.034996) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 16:08:10.035306) ========= 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=836cfdc75598d54cb747368e000001a9-1456875731.842697-154885193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 16:08:10.118005) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 16:08:10.118410) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 16:08:10.118708) ========= ========= Total master_lag: 0.26 =========