builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1456834561.27 results: success (0) buildid: 20160301025941 builduid: 3e405c042b564da6938b55a324856315 revision: 8ef94be995a453f5c464278c53478ba8c8554f81 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.271175) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.271550) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.271831) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006395 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.364280) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.364618) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.407911) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.408285) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.477072) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.477382) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.477716) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.477987) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-01 04:16:01-- 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% 83.6M=0s 2016-03-01 04:16:02 (83.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131041 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.645987) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.646345) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013834 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.723061) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-01 04:16:01.726474) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8ef94be995a453f5c464278c53478ba8c8554f81 --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 8ef94be995a453f5c464278c53478ba8c8554f81 --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=9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-01 04:16:02,283 truncating revision to first 12 chars 2016-03-01 04:16:02,283 Setting DEBUG logging. 2016-03-01 04:16:02,283 attempt 1/10 2016-03-01 04:16:02,283 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8ef94be995a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-01 04:16:04,126 unpacking tar archive at: mozilla-central-8ef94be995a4/testing/mozharness/ program finished with exit code 0 elapsedTime=2.191473 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-01 04:16:03.937975) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:03.938375) ========= echo 8ef94be995a453f5c464278c53478ba8c8554f81 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8ef94be995a453f5c464278c53478ba8c8554f81'] 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=9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8ef94be995a453f5c464278c53478ba8c8554f81 program finished with exit code 0 elapsedTime=0.004785 script_repo_revision: '8ef94be995a453f5c464278c53478ba8c8554f81' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:03.991214) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:03.991528) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:04.009982) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-03-01 04:16:04.010408) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:16:04 INFO - MultiFileLogger online at 20160301 04:16:04 in /builds/slave/test 04:16:04 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 04:16:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:16:04 INFO - {'append_to_log': False, 04:16:04 INFO - 'base_work_dir': '/builds/slave/test', 04:16:04 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:16:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:16:04 INFO - 'branch': 'Firefox-Non-PGO', 04:16:04 INFO - 'buildbot_json_path': 'buildprops.json', 04:16:04 INFO - 'config_files': ('talos/linux_config.py',), 04:16:04 INFO - 'default_actions': ('clobber', 04:16:04 INFO - 'read-buildbot-config', 04:16:04 INFO - 'download-and-extract', 04:16:04 INFO - 'populate-webroot', 04:16:04 INFO - 'create-virtualenv', 04:16:04 INFO - 'install', 04:16:04 INFO - 'run-tests'), 04:16:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:16:04 INFO - 'download_minidump_stackwalk': True, 04:16:04 INFO - 'download_symbols': 'ondemand', 04:16:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:16:04 INFO - 'tooltool.py': '/tools/tooltool.py', 04:16:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:16:04 INFO - '/tools/misc-python/virtualenv.py')}, 04:16:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:16:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:16:04 INFO - 'installer_path': 'installer.exe', 04:16:04 INFO - 'log_level': 'info', 04:16:04 INFO - 'log_name': 'talos', 04:16:04 INFO - 'log_to_console': True, 04:16:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:16:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:16:04 INFO - 'opt_config_files': (), 04:16:04 INFO - 'pip_index': False, 04:16:04 INFO - 'sps_profile': False, 04:16:04 INFO - 'sps_profile_interval': 0, 04:16:04 INFO - 'suite': 'dromaeojs-e10s', 04:16:04 INFO - 'system_bits': '32', 04:16:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:16:04 INFO - 'title': 'talos-linux64-ix-022', 04:16:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:16:04 INFO - 'use_talos_json': True, 04:16:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:16:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:16:04 INFO - 'work_dir': 'build'} 04:16:04 INFO - ##### 04:16:04 INFO - ##### Running clobber step. 04:16:04 INFO - ##### 04:16:04 INFO - Running pre-action listener: _resource_record_pre_action 04:16:04 INFO - Running main action method: clobber 04:16:04 INFO - rmtree: /builds/slave/test/build 04:16:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:16:05 INFO - Running post-action listener: _resource_record_post_action 04:16:05 INFO - ##### 04:16:05 INFO - ##### Running read-buildbot-config step. 04:16:05 INFO - ##### 04:16:05 INFO - Running pre-action listener: _resource_record_pre_action 04:16:05 INFO - Running main action method: read_buildbot_config 04:16:05 INFO - Using buildbot properties: 04:16:05 INFO - { 04:16:05 INFO - "project": "", 04:16:05 INFO - "product": "firefox", 04:16:05 INFO - "script_repo_revision": "production", 04:16:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:16:05 INFO - "repository": "", 04:16:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:16:05 INFO - "buildid": "20160301025941", 04:16:05 INFO - "pgo_build": "False", 04:16:05 INFO - "basedir": "/builds/slave/test", 04:16:05 INFO - "buildnumber": 224, 04:16:05 INFO - "slavename": "talos-linux64-ix-022", 04:16:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:16:05 INFO - "platform": "ubuntu64_hw", 04:16:05 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:16:05 INFO - "branch": "mozilla-central", 04:16:05 INFO - "repo_path": "mozilla-central", 04:16:05 INFO - "revision": "8ef94be995a453f5c464278c53478ba8c8554f81", 04:16:05 INFO - "stage_platform": "linux64", 04:16:05 INFO - "builduid": "3e405c042b564da6938b55a324856315", 04:16:05 INFO - "slavebuilddir": "test" 04:16:05 INFO - } 04:16:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 04:16:05 INFO - Running post-action listener: _resource_record_post_action 04:16:05 INFO - ##### 04:16:05 INFO - ##### Running download-and-extract step. 04:16:05 INFO - ##### 04:16:05 INFO - Running pre-action listener: _resource_record_pre_action 04:16:05 INFO - Running main action method: download_and_extract 04:16:05 INFO - mkdir: /builds/slave/test/build/tests 04:16:05 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')]} 04:16:05 INFO - https://queue.taskcluster.net/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:16:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/test_packages.json 04:16:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/test_packages.json 04:16:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:16:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:16:13 INFO - Downloaded 1448 bytes. 04:16:13 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:16:13 INFO - Using the following test package requirements: 04:16:13 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:13 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:16:13 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:16:13 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:13 INFO - u'jsshell-linux-x86_64.zip'], 04:16:13 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:16:13 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:13 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:16:13 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:16:13 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:16:13 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:13 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:16:13 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:16:13 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')]} 04:16:13 INFO - https://queue.taskcluster.net/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:16:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:16:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:16:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/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 04:16:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/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 04:16:21 INFO - Downloaded 22064914 bytes. 04:16:21 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'] 04:16:21 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 04:16:22 INFO - Return code: 0 04:16:22 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 04:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:22 INFO - https://queue.taskcluster.net/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:16:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:16:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:16:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/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 04:16:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/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 04:16:24 INFO - Downloaded 22064914 bytes. 04:16:24 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'] 04:16:24 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 04:16:25 INFO - Return code: 0 04:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:25 INFO - https://queue.taskcluster.net/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:16:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/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 04:16:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/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 04:16:26 INFO - Downloaded 10713410 bytes. 04:16:26 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'] 04:16:26 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 04:16:26 INFO - Return code: 0 04:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:26 INFO - https://queue.taskcluster.net/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:16:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:16:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:16:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/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 04:16:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/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 04:16:28 INFO - Downloaded 54830545 bytes. 04:16:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:16:28 INFO - mkdir: /builds/slave/test/properties 04:16:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:16:28 INFO - Writing to file /builds/slave/test/properties/build_url 04:16:28 INFO - Contents: 04:16:28 INFO - build_url:https://queue.taskcluster.net/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:16:28 INFO - Running post-action listener: _resource_record_post_action 04:16:28 INFO - Running post-action listener: set_extra_try_arguments 04:16:28 INFO - ##### 04:16:28 INFO - ##### Running populate-webroot step. 04:16:28 INFO - ##### 04:16:28 INFO - Running pre-action listener: _resource_record_pre_action 04:16:28 INFO - Running main action method: populate_webroot 04:16:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:16:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:16:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:16:28 INFO - '--tppagecycles', 04:16:28 INFO - '7'], 04:16:28 INFO - 'tests': ['tsvgm']}}, 04:16:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:16:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:16:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:16:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:16:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:16:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:16:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:28 INFO - 'talos_options': ['--e10s'], 04:16:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:28 INFO - 'tests': ['damp', 'tps']}, 04:16:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:28 INFO - 'talos_options': ['--e10s'], 04:16:28 INFO - 'tests': ['damp', 'tps']}, 04:16:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:16:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:16:28 INFO - 'other': {'tests': ['a11yr', 04:16:28 INFO - 'ts_paint', 04:16:28 INFO - 'tpaint', 04:16:28 INFO - 'sessionrestore', 04:16:28 INFO - 'sessionrestore_no_auto_restore']}, 04:16:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:16:28 INFO - 'tests': ['a11yr', 04:16:28 INFO - 'ts_paint', 04:16:28 INFO - 'tpaint', 04:16:28 INFO - 'sessionrestore', 04:16:28 INFO - 'sessionrestore_no_auto_restore']}, 04:16:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:16:28 INFO - 'tests': ['a11yr', 04:16:28 INFO - 'ts_paint', 04:16:28 INFO - 'tpaint', 04:16:28 INFO - 'sessionrestore', 04:16:28 INFO - 'sessionrestore_no_auto_restore']}, 04:16:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:16:28 INFO - 'tests': ['a11yr', 04:16:28 INFO - 'ts_paint', 04:16:28 INFO - 'tpaint', 04:16:28 INFO - 'sessionrestore', 04:16:28 INFO - 'sessionrestore_no_auto_restore']}, 04:16:28 INFO - 'other_l64': {'tests': ['a11yr', 04:16:28 INFO - 'ts_paint', 04:16:28 INFO - 'tpaint', 04:16:28 INFO - 'sessionrestore', 04:16:28 INFO - 'sessionrestore_no_auto_restore']}, 04:16:28 INFO - 'other_nol64': {'tests': ['a11yr', 04:16:28 INFO - 'ts_paint', 04:16:28 INFO - 'tpaint', 04:16:28 INFO - 'sessionrestore', 04:16:28 INFO - 'sessionrestore_no_auto_restore']}, 04:16:28 INFO - 'svgr': {'tests': ['tsvgx', 04:16:28 INFO - 'tsvgr_opacity', 04:16:28 INFO - 'tart', 04:16:28 INFO - 'tscrollx', 04:16:28 INFO - 'cart']}, 04:16:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:16:28 INFO - 'tests': ['tsvgx', 04:16:28 INFO - 'tsvgr_opacity', 04:16:28 INFO - 'tart', 04:16:28 INFO - 'tscrollx', 04:16:28 INFO - 'cart']}, 04:16:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:28 INFO - 'tests': ['tp5o']}, 04:16:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:28 INFO - 'talos_options': ['--e10s'], 04:16:28 INFO - 'tests': ['tp5o']}, 04:16:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:28 INFO - 'talos_options': ['--xperf_path', 04:16:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:28 INFO - 'tests': ['tp5n']}, 04:16:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:28 INFO - 'talos_options': ['--e10s', 04:16:28 INFO - '--xperf_path', 04:16:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:28 INFO - 'tests': ['tp5n']}}, 04:16:28 INFO - 'talos.zip': {'path': '', 04:16:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:16:28 INFO - Running post-action listener: _resource_record_post_action 04:16:28 INFO - ##### 04:16:28 INFO - ##### Running create-virtualenv step. 04:16:28 INFO - ##### 04:16:28 INFO - Running pre-action listener: _resource_record_pre_action 04:16:28 INFO - Running main action method: create_virtualenv 04:16:28 INFO - Creating virtualenv /builds/slave/test/build/venv 04:16:28 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 04:16:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:16:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:16:29 INFO - Using real prefix '/usr' 04:16:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:16:29 INFO - Installing distribute.............................................................................................................................................................................................done. 04:16:31 INFO - Installing pip.................done. 04:16:31 INFO - Return code: 0 04:16:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:16:31 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')]} 04:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:31 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')]} 04:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:31 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 0x7f221ec5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089100>, '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 0x108a000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', '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 04:16:31 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 04:16:31 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 04:16:31 INFO - Using env: {'DISPLAY': ':0', 04:16:31 INFO - 'HOME': '/home/cltbld', 04:16:31 INFO - 'LANG': 'en_US.UTF-8', 04:16:31 INFO - 'LANGUAGE': 'en_US:en', 04:16:31 INFO - 'LOGNAME': 'cltbld', 04:16:31 INFO - 'MAIL': '/var/mail/cltbld', 04:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:31 INFO - 'MOZ_NO_REMOTE': '1', 04:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:31 INFO - 'NO_EM_RESTART': '1', 04:16:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:31 INFO - 'PWD': '/builds/slave/test', 04:16:31 INFO - 'SHELL': '/bin/bash', 04:16:31 INFO - 'SHLVL': '1', 04:16:31 INFO - 'TERM': 'linux', 04:16:31 INFO - 'TMOUT': '86400', 04:16:31 INFO - 'USER': 'cltbld', 04:16:31 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', 04:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:31 INFO - '_': '/tools/buildbot/bin/python'} 04:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:31 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 04:16:31 INFO - Cleaning up... 04:16:31 INFO - Return code: 0 04:16:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:16:31 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')]} 04:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:31 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')]} 04:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:31 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 0x7f221ec5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089100>, '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 0x108a000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', '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 04:16:31 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 04:16:31 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 04:16:31 INFO - Using env: {'DISPLAY': ':0', 04:16:31 INFO - 'HOME': '/home/cltbld', 04:16:31 INFO - 'LANG': 'en_US.UTF-8', 04:16:31 INFO - 'LANGUAGE': 'en_US:en', 04:16:31 INFO - 'LOGNAME': 'cltbld', 04:16:31 INFO - 'MAIL': '/var/mail/cltbld', 04:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:31 INFO - 'MOZ_NO_REMOTE': '1', 04:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:31 INFO - 'NO_EM_RESTART': '1', 04:16:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:31 INFO - 'PWD': '/builds/slave/test', 04:16:31 INFO - 'SHELL': '/bin/bash', 04:16:31 INFO - 'SHLVL': '1', 04:16:31 INFO - 'TERM': 'linux', 04:16:31 INFO - 'TMOUT': '86400', 04:16:31 INFO - 'USER': 'cltbld', 04:16:31 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', 04:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:31 INFO - '_': '/tools/buildbot/bin/python'} 04:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:31 INFO - Downloading/unpacking psutil>=0.7.1 04:16:31 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 04:16:31 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 04:16:31 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 04:16:31 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 04:16:31 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 04:16:31 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 04:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:16:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:33 INFO - Installing collected packages: psutil 04:16:33 INFO - Running setup.py install for psutil 04:16:33 INFO - building 'psutil._psutil_linux' extension 04:16:33 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 04:16:34 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 04:16:34 INFO - building 'psutil._psutil_posix' extension 04:16:34 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 04:16:34 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 04:16:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:34 INFO - Successfully installed psutil 04:16:34 INFO - Cleaning up... 04:16:34 INFO - Return code: 0 04:16:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:16:34 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')]} 04:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:34 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')]} 04:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:34 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 0x7f221ec5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089100>, '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 0x108a000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', '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 04:16:34 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 04:16:34 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 04:16:34 INFO - Using env: {'DISPLAY': ':0', 04:16:34 INFO - 'HOME': '/home/cltbld', 04:16:34 INFO - 'LANG': 'en_US.UTF-8', 04:16:34 INFO - 'LANGUAGE': 'en_US:en', 04:16:34 INFO - 'LOGNAME': 'cltbld', 04:16:34 INFO - 'MAIL': '/var/mail/cltbld', 04:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:34 INFO - 'MOZ_NO_REMOTE': '1', 04:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:34 INFO - 'NO_EM_RESTART': '1', 04:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:34 INFO - 'PWD': '/builds/slave/test', 04:16:34 INFO - 'SHELL': '/bin/bash', 04:16:34 INFO - 'SHLVL': '1', 04:16:34 INFO - 'TERM': 'linux', 04:16:34 INFO - 'TMOUT': '86400', 04:16:34 INFO - 'USER': 'cltbld', 04:16:34 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', 04:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:34 INFO - '_': '/tools/buildbot/bin/python'} 04:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:16:34 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 04:16:34 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 04:16:34 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 04:16:34 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 04:16:34 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 04:16:34 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 04:16:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:16:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:16:36 INFO - Installing collected packages: mozsystemmonitor 04:16:36 INFO - Running setup.py install for mozsystemmonitor 04:16:36 INFO - Successfully installed mozsystemmonitor 04:16:36 INFO - Cleaning up... 04:16:36 INFO - Return code: 0 04:16:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:36 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 0x7f221ec5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089100>, '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 0x108a000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', '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 04:16:36 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 04:16:36 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 04:16:36 INFO - Using env: {'DISPLAY': ':0', 04:16:36 INFO - 'HOME': '/home/cltbld', 04:16:36 INFO - 'LANG': 'en_US.UTF-8', 04:16:36 INFO - 'LANGUAGE': 'en_US:en', 04:16:36 INFO - 'LOGNAME': 'cltbld', 04:16:36 INFO - 'MAIL': '/var/mail/cltbld', 04:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:36 INFO - 'MOZ_NO_REMOTE': '1', 04:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:36 INFO - 'NO_EM_RESTART': '1', 04:16:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:36 INFO - 'PWD': '/builds/slave/test', 04:16:36 INFO - 'SHELL': '/bin/bash', 04:16:36 INFO - 'SHLVL': '1', 04:16:36 INFO - 'TERM': 'linux', 04:16:36 INFO - 'TMOUT': '86400', 04:16:36 INFO - 'USER': 'cltbld', 04:16:36 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', 04:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:36 INFO - '_': '/tools/buildbot/bin/python'} 04:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:36 INFO - Downloading/unpacking blobuploader==1.2.4 04:16:36 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 04:16:36 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 04:16:36 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 04:16:36 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 04:16:36 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 04:16:36 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 04:16:38 INFO - Downloading blobuploader-1.2.4.tar.gz 04:16:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:16:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:16:38 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 04:16:38 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 04:16:38 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 04:16:38 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 04:16:38 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 04:16:38 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 04:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:16:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:39 INFO - Downloading docopt-0.6.1.tar.gz 04:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:16:39 INFO - Installing collected packages: blobuploader, requests, docopt 04:16:39 INFO - Running setup.py install for blobuploader 04:16:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:16:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:16:39 INFO - Running setup.py install for requests 04:16:39 INFO - Running setup.py install for docopt 04:16:40 INFO - Successfully installed blobuploader requests docopt 04:16:40 INFO - Cleaning up... 04:16:40 INFO - Return code: 0 04:16:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:40 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 0x7f221ec5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089100>, '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 0x108a000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', '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 04:16:40 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 04:16:40 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 04:16:40 INFO - Using env: {'DISPLAY': ':0', 04:16:40 INFO - 'HOME': '/home/cltbld', 04:16:40 INFO - 'LANG': 'en_US.UTF-8', 04:16:40 INFO - 'LANGUAGE': 'en_US:en', 04:16:40 INFO - 'LOGNAME': 'cltbld', 04:16:40 INFO - 'MAIL': '/var/mail/cltbld', 04:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:40 INFO - 'MOZ_NO_REMOTE': '1', 04:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:40 INFO - 'NO_EM_RESTART': '1', 04:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:40 INFO - 'PWD': '/builds/slave/test', 04:16:40 INFO - 'SHELL': '/bin/bash', 04:16:40 INFO - 'SHLVL': '1', 04:16:40 INFO - 'TERM': 'linux', 04:16:40 INFO - 'TMOUT': '86400', 04:16:40 INFO - 'USER': 'cltbld', 04:16:40 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', 04:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:40 INFO - '_': '/tools/buildbot/bin/python'} 04:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:40 INFO - Running setup.py (path:/tmp/pip-sVChPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:40 INFO - Running setup.py (path:/tmp/pip-6Y4Nhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:40 INFO - Running setup.py (path:/tmp/pip-QPW3PF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:40 INFO - Running setup.py (path:/tmp/pip-iGfOGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:40 INFO - Running setup.py (path:/tmp/pip-fRjVp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:40 INFO - Running setup.py (path:/tmp/pip-deYEDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:40 INFO - Running setup.py (path:/tmp/pip-KDi8x1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:40 INFO - Running setup.py (path:/tmp/pip-mip5xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:40 INFO - Running setup.py (path:/tmp/pip-pd2E3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:40 INFO - Running setup.py (path:/tmp/pip-O61o95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:41 INFO - Running setup.py (path:/tmp/pip-jNev2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:41 INFO - Running setup.py (path:/tmp/pip-yti2cY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:41 INFO - Running setup.py (path:/tmp/pip-t5QG0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:41 INFO - Running setup.py (path:/tmp/pip-diim4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:41 INFO - Running setup.py (path:/tmp/pip-TosvSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:41 INFO - Running setup.py (path:/tmp/pip-YdbB4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:41 INFO - Running setup.py (path:/tmp/pip-PiXRnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:16:41 INFO - Running setup.py install for manifestparser 04:16:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:16:41 INFO - Running setup.py install for mozcrash 04:16:41 INFO - Running setup.py install for mozdebug 04:16:41 INFO - Running setup.py install for mozdevice 04:16:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:16:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:16:41 INFO - Running setup.py install for mozfile 04:16:42 INFO - Running setup.py install for mozhttpd 04:16:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:16:42 INFO - Running setup.py install for mozinfo 04:16:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:16:42 INFO - Running setup.py install for mozInstall 04:16:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:16:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:16:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:16:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:16:42 INFO - Running setup.py install for mozleak 04:16:42 INFO - Running setup.py install for mozlog 04:16:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:16:42 INFO - Running setup.py install for moznetwork 04:16:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:16:42 INFO - Running setup.py install for mozprocess 04:16:42 INFO - Running setup.py install for mozprofile 04:16:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:16:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:16:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:16:42 INFO - Running setup.py install for mozrunner 04:16:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:16:43 INFO - Running setup.py install for mozscreenshot 04:16:43 INFO - Running setup.py install for moztest 04:16:43 INFO - Running setup.py install for mozversion 04:16:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:16:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:16:43 INFO - Cleaning up... 04:16:43 INFO - Return code: 0 04:16:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:43 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 0x7f221ec5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089100>, '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 0x108a000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', '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 04:16:43 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 04:16:43 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 04:16:43 INFO - Using env: {'DISPLAY': ':0', 04:16:43 INFO - 'HOME': '/home/cltbld', 04:16:43 INFO - 'LANG': 'en_US.UTF-8', 04:16:43 INFO - 'LANGUAGE': 'en_US:en', 04:16:43 INFO - 'LOGNAME': 'cltbld', 04:16:43 INFO - 'MAIL': '/var/mail/cltbld', 04:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:43 INFO - 'MOZ_NO_REMOTE': '1', 04:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:43 INFO - 'NO_EM_RESTART': '1', 04:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:43 INFO - 'PWD': '/builds/slave/test', 04:16:43 INFO - 'SHELL': '/bin/bash', 04:16:43 INFO - 'SHLVL': '1', 04:16:43 INFO - 'TERM': 'linux', 04:16:43 INFO - 'TMOUT': '86400', 04:16:43 INFO - 'USER': 'cltbld', 04:16:43 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', 04:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:43 INFO - '_': '/tools/buildbot/bin/python'} 04:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:43 INFO - Running setup.py (path:/tmp/pip-U96c4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:43 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)) 04:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:43 INFO - Running setup.py (path:/tmp/pip-zQ_Hzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:43 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)) 04:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:43 INFO - Running setup.py (path:/tmp/pip-reQrVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:43 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)) 04:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:43 INFO - Running setup.py (path:/tmp/pip-DRcnpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:43 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)) 04:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:43 INFO - Running setup.py (path:/tmp/pip-QCB1r5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:43 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)) 04:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:43 INFO - Running setup.py (path:/tmp/pip-ehZrrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:44 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)) 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:44 INFO - Running setup.py (path:/tmp/pip-NkODJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:44 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)) 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:44 INFO - Running setup.py (path:/tmp/pip-NatEV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:44 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)) 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:44 INFO - Running setup.py (path:/tmp/pip-0Kzwm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:44 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)) 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:44 INFO - Running setup.py (path:/tmp/pip-Sfy3oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:44 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)) 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:44 INFO - Running setup.py (path:/tmp/pip-2hoaI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:44 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)) 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:44 INFO - Running setup.py (path:/tmp/pip-rRjn8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:44 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)) 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:44 INFO - Running setup.py (path:/tmp/pip-mUj0Uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:44 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)) 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:44 INFO - Running setup.py (path:/tmp/pip-qm0zu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:44 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)) 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:44 INFO - Running setup.py (path:/tmp/pip-fvZoFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:44 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)) 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:44 INFO - Running setup.py (path:/tmp/pip-tXmZj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:44 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)) 04:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:44 INFO - Running setup.py (path:/tmp/pip-J5UgXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:44 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)) 04:16:44 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)) 04:16:44 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)) 04:16:44 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)) 04:16:44 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)) 04:16:44 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)) 04:16:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:46 INFO - Downloading blessings-1.6.tar.gz 04:16:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:16:46 INFO - Installing collected packages: blessings 04:16:46 INFO - Running setup.py install for blessings 04:16:46 INFO - Successfully installed blessings 04:16:46 INFO - Cleaning up... 04:16:46 INFO - Return code: 0 04:16:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:16:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:47 INFO - Reading from file tmpfile_stdout 04:16:47 INFO - Current package versions: 04:16:47 INFO - argparse == 1.2.1 04:16:47 INFO - blessings == 1.6 04:16:47 INFO - blobuploader == 1.2.4 04:16:47 INFO - docopt == 0.6.1 04:16:47 INFO - manifestparser == 1.1 04:16:47 INFO - mozInstall == 1.12 04:16:47 INFO - mozcrash == 0.16 04:16:47 INFO - mozdebug == 0.1 04:16:47 INFO - mozdevice == 0.48 04:16:47 INFO - mozfile == 1.2 04:16:47 INFO - mozhttpd == 0.7 04:16:47 INFO - mozinfo == 0.9 04:16:47 INFO - mozleak == 0.1 04:16:47 INFO - mozlog == 3.1 04:16:47 INFO - moznetwork == 0.27 04:16:47 INFO - mozprocess == 0.22 04:16:47 INFO - mozprofile == 0.28 04:16:47 INFO - mozrunner == 6.11 04:16:47 INFO - mozscreenshot == 0.1 04:16:47 INFO - mozsystemmonitor == 0.0 04:16:47 INFO - moztest == 0.7 04:16:47 INFO - mozversion == 1.4 04:16:47 INFO - psutil == 3.1.1 04:16:47 INFO - requests == 1.2.3 04:16:47 INFO - wsgiref == 0.1.2 04:16:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:47 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 0x7f221ec5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089100>, '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 0x108a000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', '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 04:16:47 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 04:16:47 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 04:16:47 INFO - Using env: {'DISPLAY': ':0', 04:16:47 INFO - 'HOME': '/home/cltbld', 04:16:47 INFO - 'LANG': 'en_US.UTF-8', 04:16:47 INFO - 'LANGUAGE': 'en_US:en', 04:16:47 INFO - 'LOGNAME': 'cltbld', 04:16:47 INFO - 'MAIL': '/var/mail/cltbld', 04:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:47 INFO - 'MOZ_NO_REMOTE': '1', 04:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:47 INFO - 'NO_EM_RESTART': '1', 04:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:47 INFO - 'PWD': '/builds/slave/test', 04:16:47 INFO - 'SHELL': '/bin/bash', 04:16:47 INFO - 'SHLVL': '1', 04:16:47 INFO - 'TERM': 'linux', 04:16:47 INFO - 'TMOUT': '86400', 04:16:47 INFO - 'USER': 'cltbld', 04:16:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', 04:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:47 INFO - '_': '/tools/buildbot/bin/python'} 04:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:47 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)) 04:16:47 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)) 04:16:47 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)) 04:16:47 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)) 04:16:47 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)) 04:16:47 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)) 04:16:47 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)) 04:16:47 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)) 04:16:47 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)) 04:16:47 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)) 04:16:47 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)) 04:16:47 INFO - Cleaning up... 04:16:47 INFO - Return code: 0 04:16:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:47 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 0x7f221ec5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089100>, '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 0x108a000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', '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 04:16:47 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 04:16:47 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 04:16:47 INFO - Using env: {'DISPLAY': ':0', 04:16:47 INFO - 'HOME': '/home/cltbld', 04:16:47 INFO - 'LANG': 'en_US.UTF-8', 04:16:47 INFO - 'LANGUAGE': 'en_US:en', 04:16:47 INFO - 'LOGNAME': 'cltbld', 04:16:47 INFO - 'MAIL': '/var/mail/cltbld', 04:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:47 INFO - 'MOZ_NO_REMOTE': '1', 04:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:47 INFO - 'NO_EM_RESTART': '1', 04:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:47 INFO - 'PWD': '/builds/slave/test', 04:16:47 INFO - 'SHELL': '/bin/bash', 04:16:47 INFO - 'SHLVL': '1', 04:16:47 INFO - 'TERM': 'linux', 04:16:47 INFO - 'TMOUT': '86400', 04:16:47 INFO - 'USER': 'cltbld', 04:16:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', 04:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:47 INFO - '_': '/tools/buildbot/bin/python'} 04:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:47 INFO - Downloading/unpacking jsonschema 04:16:47 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 04:16:47 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 04:16:47 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 04:16:47 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 04:16:47 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 04:16:47 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 04:16:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:16:49 INFO - Downloading/unpacking functools32 (from jsonschema) 04:16:49 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 04:16:49 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 04:16:49 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 04:16:49 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 04:16:49 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 04:16:49 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 04:16:49 INFO - Downloading functools32-3.2.3-2.tar.gz 04:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:16:49 INFO - warning: no files found matching '*.txt' 04:16:49 INFO - no previously-included directories found matching 'build' 04:16:49 INFO - no previously-included directories found matching 'dist' 04:16:49 INFO - no previously-included directories found matching '.git*' 04:16:49 INFO - Installing collected packages: jsonschema, functools32 04:16:49 INFO - Running setup.py install for functools32 04:16:49 INFO - warning: no files found matching '*.txt' 04:16:49 INFO - no previously-included directories found matching 'build' 04:16:49 INFO - no previously-included directories found matching 'dist' 04:16:49 INFO - no previously-included directories found matching '.git*' 04:16:49 INFO - Successfully installed jsonschema functools32 04:16:49 INFO - Cleaning up... 04:16:49 INFO - Return code: 0 04:16:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:49 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 0x7f221ec5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089100>, '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 0x108a000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', '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 04:16:49 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 04:16:49 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 04:16:49 INFO - Using env: {'DISPLAY': ':0', 04:16:49 INFO - 'HOME': '/home/cltbld', 04:16:49 INFO - 'LANG': 'en_US.UTF-8', 04:16:49 INFO - 'LANGUAGE': 'en_US:en', 04:16:49 INFO - 'LOGNAME': 'cltbld', 04:16:49 INFO - 'MAIL': '/var/mail/cltbld', 04:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:49 INFO - 'MOZ_NO_REMOTE': '1', 04:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:49 INFO - 'NO_EM_RESTART': '1', 04:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:49 INFO - 'PWD': '/builds/slave/test', 04:16:49 INFO - 'SHELL': '/bin/bash', 04:16:49 INFO - 'SHLVL': '1', 04:16:49 INFO - 'TERM': 'linux', 04:16:49 INFO - 'TMOUT': '86400', 04:16:49 INFO - 'USER': 'cltbld', 04:16:49 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', 04:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:49 INFO - '_': '/tools/buildbot/bin/python'} 04:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:50 INFO - Downloading/unpacking flake8 04:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:16:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:16:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:16:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:16:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:16:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:16:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:16:52 INFO - no previously-included directories found matching 'docs/_build' 04:16:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:16:52 INFO - Running setup.py install for pep8 04:16:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:16:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:16:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:16:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:16:52 INFO - no previously-included directories found matching 'docs/_build' 04:16:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:16:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:16:52 INFO - Cleaning up... 04:16:52 INFO - Return code: 0 04:16:52 INFO - Running post-action listener: _resource_record_post_action 04:16:52 INFO - Running post-action listener: _start_resource_monitoring 04:16:52 INFO - Starting resource monitoring. 04:16:52 INFO - ##### 04:16:52 INFO - ##### Running install step. 04:16:52 INFO - ##### 04:16:52 INFO - Running pre-action listener: _resource_record_pre_action 04:16:52 INFO - Running main action method: install 04:16:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:53 INFO - Reading from file tmpfile_stdout 04:16:53 INFO - Detecting whether we're running mozinstall >=1.0... 04:16:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:16:53 INFO - Reading from file tmpfile_stdout 04:16:53 INFO - Output received: 04:16:53 INFO - Usage: mozinstall [options] installer 04:16:53 INFO - Options: 04:16:53 INFO - -h, --help show this help message and exit 04:16:53 INFO - -d DEST, --destination=DEST 04:16:53 INFO - Directory to install application into. [default: 04:16:53 INFO - "/builds/slave/test"] 04:16:53 INFO - --app=APP Application being installed. [default: firefox] 04:16:53 INFO - mkdir: /builds/slave/test/build/application 04:16:53 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'] 04:16:53 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 04:17:09 INFO - Reading from file tmpfile_stdout 04:17:09 INFO - Output received: 04:17:09 INFO - /builds/slave/test/build/application/firefox/firefox 04:17:09 INFO - Running post-action listener: _resource_record_post_action 04:17:09 INFO - ##### 04:17:09 INFO - ##### Running run-tests step. 04:17:09 INFO - ##### 04:17:09 INFO - Running pre-action listener: _resource_record_pre_action 04:17:09 INFO - Running main action method: run_tests 04:17:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:17:09 INFO - Python 2.7.3 04:17:09 INFO - Return code: 0 04:17:09 INFO - grabbing minidump binary from tooltool 04:17: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')]} 04:17:09 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 0x1089100>, '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 0x108a000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:17:09 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 04:17:09 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 04:17:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:17:09 INFO - Return code: 0 04:17:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:17:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:17:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:17:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:17:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:17:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:17:10 INFO - Return code: 0 04:17:10 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/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 04:17:10 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/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 04:17:10 INFO - Using env: {'DISPLAY': ':0', 04:17:10 INFO - 'HOME': '/home/cltbld', 04:17:10 INFO - 'LANG': 'en_US.UTF-8', 04:17:10 INFO - 'LANGUAGE': 'en_US:en', 04:17:10 INFO - 'LOGNAME': 'cltbld', 04:17:10 INFO - 'MAIL': '/var/mail/cltbld', 04:17:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:17:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:10 INFO - 'MOZ_NO_REMOTE': '1', 04:17:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:10 INFO - 'NO_EM_RESTART': '1', 04:17:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:10 INFO - 'PWD': '/builds/slave/test', 04:17:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:17:10 INFO - 'SHELL': '/bin/bash', 04:17:10 INFO - 'SHLVL': '1', 04:17:10 INFO - 'TERM': 'linux', 04:17:10 INFO - 'TMOUT': '86400', 04:17:10 INFO - 'USER': 'cltbld', 04:17:10 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268', 04:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:10 INFO - '_': '/tools/buildbot/bin/python'} 04:17:10 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/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 04:17:10 INFO - mozversion application_buildid: 20160301025941 04:17:10 INFO - mozversion application_changeset: 8ef94be995a453f5c464278c53478ba8c8554f81 04:17:10 INFO - mozversion application_display_name: Nightly 04:17:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:17:10 INFO - mozversion application_name: Firefox 04:17:10 INFO - mozversion application_remotingname: firefox 04:17:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:17:10 INFO - mozversion application_vendor: Mozilla 04:17:10 INFO - mozversion application_version: 47.0a1 04:17:10 INFO - mozversion platform_buildid: 20160301025941 04:17:10 INFO - mozversion platform_changeset: 8ef94be995a453f5c464278c53478ba8c8554f81 04:17:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:17:10 INFO - mozversion platform_version: 47.0a1 04:17:10 INFO - using testdate: 1456834630 04:17:10 INFO - actual date: 1456834630 04:17:10 INFO - starting webserver on 'localhost:41237' 04:17:10 INFO - SUITE-START | Running 2 tests 04:17:10 INFO - TEST-START | dromaeo_css 04:17:10 INFO - operating with platform_type : linux_ 04:17:10 INFO - Initialising browser for dromaeo_css test... 04:17:10 INFO - TEST-INFO | started process 9979 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKhMFxC/profile http://localhost:41237/getInfo.html) 04:17:14 INFO - PROCESS | 9979 | 04:17:14 INFO - PROCESS | 9979 | (process:10065): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:17:15 INFO - PROCESS | 9979 | __metrics Screen width/height:1600/1200 04:17:15 INFO - PROCESS | 9979 | colorDepth:24 04:17:15 INFO - PROCESS | 9979 | Browser inner width/height: 1024/697 04:17:15 INFO - PROCESS | 9979 | __metrics 04:17:15 ERROR - PROCESS | 9979 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:17:15 INFO - PROCESS | 9979 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:17:15 INFO - PROCESS | 9979 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:17:15 INFO - PROCESS | 9979 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:17:15 INFO - PROCESS | 9979 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:17:15 INFO - PROCESS | 9979 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:17:15 INFO - PROCESS | 9979 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:17:15 INFO - PROCESS | 9979 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:17:15 INFO - PROCESS | 9979 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:17:15 INFO - PROCESS | 9979 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:17:16 INFO - TEST-INFO | 9979: exit 0 04:17:16 INFO - Browser initialized. 04:17:16 INFO - Running cycle 1/1 for dromaeo_css test... 04:17:16 INFO - TEST-INFO | started process 10116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKhMFxC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:17:18 INFO - PROCESS | 10116 | 04:17:18 INFO - PROCESS | 10116 | (process:10171): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:17:28 INFO - PROCESS | 10116 | RSS: Main: 162004992 04:17:28 INFO - PROCESS | 10116 | 04:18:18 INFO - PROCESS | 10116 | 1456834698546 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] 04:20:30 INFO - PROCESS | 10116 | Cycle 1(1): loaded http://localhost:41237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41237/tests/dromaeo/cssquery-ext.html) 04:20:31 INFO - PROCESS | 10116 | RSS: Main: 169168896 04:20:31 INFO - PROCESS | 10116 | 04:23:33 INFO - PROCESS | 10116 | Cycle 1(1): loaded http://localhost:41237/tests/dromaeo/cssquery-ext.html (next: http://localhost:41237/tests/dromaeo/cssquery-jquery.html) 04:23:34 INFO - PROCESS | 10116 | RSS: Main: 166150144 04:23:34 INFO - PROCESS | 10116 | 04:26:35 INFO - PROCESS | 10116 | Cycle 1(1): loaded http://localhost:41237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41237/tests/dromaeo/cssquery-mootools.html) 04:26:36 INFO - PROCESS | 10116 | RSS: Main: 167145472 04:26:36 INFO - PROCESS | 10116 | 04:29:38 INFO - PROCESS | 10116 | Cycle 1(1): loaded http://localhost:41237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41237/tests/dromaeo/cssquery-prototype.html) 04:29:38 INFO - PROCESS | 10116 | RSS: Main: 164761600 04:29:38 INFO - PROCESS | 10116 | 04:32:41 INFO - PROCESS | 10116 | Cycle 1(1): loaded http://localhost:41237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41237/tests/dromaeo/cssquery-yui.html) 04:32:42 INFO - PROCESS | 10116 | RSS: Main: 164687872 04:32:42 INFO - PROCESS | 10116 | 04:35:44 INFO - PROCESS | 10116 | Cycle 1(1): loaded http://localhost:41237/tests/dromaeo/cssquery-yui.html (next: http://localhost:41237/tests/dromaeo/cssquery-dojo.html) 04:35:44 INFO - PROCESS | 10116 | RSS: Main: 167907328 04:35:44 INFO - PROCESS | 10116 | 04:35:44 INFO - PROCESS | 10116 | __start_tp_report 04:35:44 INFO - PROCESS | 10116 | _x_x_mozilla_page_load 04:35:44 INFO - PROCESS | 10116 | _x_x_mozilla_page_load_details 04:35:44 INFO - PROCESS | 10116 | |i|pagename|runs| 04:35:44 INFO - PROCESS | 10116 | |0;dojo.html;2667.4931762965034;2678.5580379237426;2726.045883940621;2729.60420738993;2743.903963361282;4497.955020449795;4643.4660014098345;4666.859994200176;4683.882902927428;4702.83540076097;4621.884452888679;4624.745638989854;4671.182543054969;4702.482726900038;4710.222813235812;4214.70497065204;4252.532221455637;4298.333758267474;4341.869743907688;4384.97807510962;4248.150369926012;4278.593533614302;4297.312430011199;4330.155619654169;4393.1213757248515;4204.26425375558;4207.179599978005;4222.218889505451;4271.530131685512;4274.1451709658195;4223.345381465878;4235.809388577491;4238.385434112068;4257.212415703105;4285.61429471349;4117.423560701474;4212.262854000568;4239.7668128252935;4268.0183557781575;4294.828206871722;4509.458864936196;4548.2495388260895;4548.2950142727595;4553.066621342617;4585.403897493338;4903.313536104948;4903.313536104948;4929.704217746947;4932.926006109911;4976.353074100344;4834.395700537433;4944.456109827916;4953.851384458472;4980.626453016002;5016.2224855147515;4590;4597.0346227291975;4602.079584083163;4625.028743963738;4651.465081515601;5050.823221187315;5069.315642388304;5080.13637681595;5083.694978301313;5137.691738495702;4750.857474275777;4873.4882837301575;4911.263310503382;4925.753712314442;4944.579710724557;4772.7136371817805;4944.777485013111;4985.027919555652;4988.152014157602;5040.873978150576;4924.3105965164905;4944.55499005084;4951.306817045616;4951.603871690329;4978.8755281118265;4773.522647735199;4912;4954.331165292711;4965.975170124127;4984.077945580079;3823.6749876260274;3826.0626146593704;3827.6363745444137;3842.1355195080882;3870.632289932452;3371.9325613487595;3408.1138903885167;3438.570178727659;3452.5856897172;3474.5483087198504;4313.741175529478;4365.978170109129;4373.234683930299;4382.912341753147;4408.360787685768;4914.213725803926;4926.507349265116;4930.630202734809;4941.802327906844;4945.67853089548;4225.936610950838;4306.966328081238;4309.741415515079;4315.913681726348;4320.4167437395545;4392.934105988413;4398.450193725785;4414.3157810539415;4422.027154026109;4429.49060857999;4691.132140554008;4708.128996135726;4710.6702530823195;4724.811007559659;4764.118638051971;4719.976400117977;4792.7124372537755;4957.305977163128;4961.851144465528;4979.278004689372;4703.553162449562;4724.503927087606;4728.0780247851335;4746.169420351355;4754.7384893829785;4889.926651100308;4905.681130726492;4907.68100073494;4907.779149938333;4970.552650261494;4754.762261886823;4907.975460122677;4954.133026720381;4993.500649935123;5026.52248036436;4598.770061496979;4772.976135119302;4799.424069111729;4806.543378379049;4852.199387101089;4775.689580177277;4789.3055506952;4791.353167322367;4806.855794326176;4814.975925120352;4593.586577208067;4714.104320179155;4714.127886341038;4765.5949244314625;4830.203016502238;4878.512148785093;4885.2427873679635;4903.166461701448;4903.53416425439;4917.6311776616185;4698.671093023456;4743.383360163157;4759.476457589732;4771.95228047729;4801.591864691541 04:35:44 INFO - PROCESS | 10116 | |1;ext.html;470.9004474551919;485.99641739807316;490.74971764400146;511.6086194061542;531.6411422289955;33025.66974330256;33450.163745906364;33470.66529334706;33551.66448335516;33604.83197584012;36596.81701591495;37497.812510937474;37620.43569346462;37683.811580942056;37796;7633;7690.423218258625;7809.765707028798;7840.607969601526;7847.372210223197;7611.353034992032;7702.922970770304;7743;7744.070711514626;7759.301662850342;7924.207579242087;7972.441929064968;7993.720219792309;7999.96000020002;8017.3586113111105;7889.684412623488;7924.48490848093;7927.128015918244;7930;7944.08643006053;7794.337481314095;7901.841963160705;7918.287354138155;7934.642941067666;7957.7612671619945;36253;36552.81723591391;36928.26143477116;37080.81459592712;37082.25835483302;2141.496748264157;2711.30861630283;2726.1003868723274;2730.0308390521277;2885.653721553406;25275.24174274775;26699.599506007424;26869.596956045676;27601.86199068992;27666.03168889079;2917.7082291770867;2930.5457654063653;2969.1092672198256;2986.8655910483862;3185.856636451342;219498;220676;221357;222281;222559.88720056458;55964.44035559674;56334.7183264081;56398.15402768962;56429;56436.153457698165;60866.08700869491;61350.69324653348;61521;61525;61540.69229653823;11893.583724569771;11971.820422693667;12136.332501712313;12145.939270303592;12157.817632735516;8884.911150888409;8908.55457227149;8981.236594889377;9002.009778924314;9032.45805251687;18939.43181704551;19207.423777286705;19357.612847742967;19370.41888743312;19466.318678846455;7611.733589324458;7818.387151580481;7887.802804929808;7897.3287270581495;7899.960500197577;823;834.2700137379793;900.9369344145978;948.8292107420592;1008.0977525114981;25831.61252581213;25897.74102258991;26022.86988565045;26340.20979370622;26401.47197056048;936.2089034765612;941.9199368053655;963.3786207895868;977.0961860279214;979.3389462113046;13587.456501740018;13939.860601393857;13986.370613322424;14101.717965640835;14136.929315353358;249913;251460;253690;254152;254339;44448.77775611166;44760.77619611881;44845;44848.3272750909;44852.55147448549;1195.8744331845205;1210.5399948019872;1214.4474264209764;1216.5073145376136;1217.4156404925686;24726.876365618056;25636.743632563437;25643.230703078938;25746.227613171635;25803;39268.2146357077;39505.209895802494;39785.60214397819;39839.2032159361;39853.40219896762;244398;245771;245956;246029;247431;29000.419991600473;29214.299216985644;29259.268518287212;29315.12054638364;29629.703702962695;38051.80974095112;38685.80657096697;38822.223555529294;38967.2206555873;39448.802755986035;32795.508067378534;32924.50613240755;33089.172770679965;33748.66251337554;33749.493757594144;32084.67915320817;32389;32673.836630816695;33094.50358244676;33299.500507491925;32904.177395565304;32945.505817413235;32985.34029319352;35281;35685.64314356823;27936.86031569829;29962.25094372658;30509.847450762605;30632.540511891893;30699.539506907862;23389.181378651665;23608.645870311615;23631.881840590686;23841.64237536473;23969.64045539353 04:35:44 INFO - PROCESS | 10116 | |2;jquery.html;325.8468519795695;332.7288260068044;332.86352595435875;342.8491463755947;343.91917899293645;14634.560963171121;14986.100833949971;15609.297581608826;15646.608834779136;15739.291731872065;13778;13959.790603140935;14125.505607303747;14741.41034358627;14806.25968701566;4839.612830973531;5021.472745361739;5030.245463180534;5045.293658887758;5092.898142037157;4912.164931961557;4919.4096708395045;5032.672876263049;5112.821051263207;5120.846374608767;5054.9494505054845;5079.288899554065;5095.108356037697;5114.02833461643;5125.179971204608;5088.898222035557;5330.333708286465;5352.91970620441;5362.785488580452;5364.865878353034;5191.818286359997;5256.0276348875195;5256.159014557652;5257.447967963385;5259.815906443256;15164.469243576532;18818.05909704523;19016.144273507725;19038.428847134608;19041.61916761657;1833.587442825367;1854.2675643120892;1857.0621835972881;1862.9999999999864;2152.612529744645;8746.518941458216;8965.148310910454;9486;10324.535395907202;11759.235649682829;1671.0391524873246;1721.3544920654754;1724.6119623084705;1728.1013872786207;1777.4578753480184;52232.47767522314;54917.45082549203;55095.449045509435;55435.722821385636;56502;9334.859977100348;9728.659496917715;9785.186218440616;9855.80288394228;9869.407835529892;12471.625851224479;12491.812622810665;12537;12554.372281385895;12571;6540.771073012422;6795.1845778506895;6809.965950170217;6896.517243792987;6902.861942761117;6372;6382.936170638327;6426.068220108058;6492.220933487917;6520.804375868732;4228.830846766156;4230.873073807791;4249.150169966019;4253.744775313491;4306.0957198987935;1724.7989643239425;1754.9912250438665;1794.7218181181938;1802.2070289072767;1809.6250492830775;339.1436622528087;359.60263908381387;370.60345430389225;813.6704634622987;890.7327801659476;8884.689035883714;9227;9477.336586439022;9523.857142142873;9701.951490242503;387.3995307273714;387.78477944740376;388.8775035863694;392.5956265047006;404.34496116291797;5098.745062746848;5142.074426603247;5143.742812859342;5152.124138896396;5179.611529135254;371966;378557;379762;386093;388082;52773.208401874006;61065.08402373968;66970.66514667396;68438.31561684319;70404.64797675979;391.89810649231407;401.56831406237825;405.71397164998604;406.9593040695966;407.87152047105064;9207.953960230156;9248.121428464285;9383.812323753624;9542.379745316532;9606.951965240129;31747.36505269928;31784.682153179096;31833.681663183997;31891.36217275688;32818;41583.37624935689;43271;44925.101497969205;45054.324185137906;45284;6686.063951046955;6870.31296870309;6899.70299291758;6900.551464154814;6922.757703480555;10038.949805251219;10604.787904242026;10662.466876656292;10934.578504794326;10978.451077445936;9096.135867092615;9176.265898727952;9296.860547091934;9467.905320946702;9557.952210238904;9081.909180908371;9227.3079519035;9346.485943273185;9442.38624489406;9544.665936692183;9324.813503730024;9402.34183607141;9589.232861371212;9728.805423891341;9843;6907.481938854707;7010.439164866696;7023.929760702327;7092.716291348288;7139.750108746169;9108.180263776292;9350;9497.14525692691;9893.950530247303;9899.109080182818 04:35:44 INFO - PROCESS | 10116 | |3;mootools.html;1362.71383009568;1368.1449094316056;1485.9331330090145;1700.651366469874;1733.8872973256746;5984.910226346608;6899.862002759942;6942.826429339263;7102.0412244347;7119.21688614252;7118.85762284754;7177.892331615017;7194.640267986593;7215.81960450989;7235.638218089088;2022.4842665120373;2072.367927782026;2072.6062048210865;2082.2920207129573;2083.374987503743;2040.2349119080345;2043.3665563675233;2046.8976551172457;2098.360000199946;2103.9474013149716;2054.3631474243034;2062.278202629083;2073.3054426767053;2074.4917495213695;2087.885166315852;2027.7870823563608;2032.979670203301;2040.2247146084467;2041.3467690339098;2044.5297581556326;2016.6470867598111;2037.2665840297482;2095.057224249094;2103.3689893032183;2113.947151321214;7303.488755787097;7340.192578816326;7350.52221605594;7356.963215183943;7379.6679149438405;4194.328907374806;4277.743335399855;4298.247806633858;4314.309710446313;4334.544872788343;2516.169664010872;2620.737926207383;2643.47130573886;2647.1529110684587;2647.364632488189;797.5573556676043;806.1011971651625;821.342925659476;828.5360198288918;1513.5610672904845;9825.213982881352;9904.801903961952;9964.05341492557;9985.101340879282;9995.450250236234;3597.6042635310096;3705.8517659293866;3743.1390780120723;3802.4296355546335;3808.638179372955;7769.106552746506;7791.026121734783;7841.5687137208;7849.725259615886;7851.136374998746;4151.024509240327;4161.729487583298;4169.45797046382;4172.91654166921;4182.309918863414;3115.9844200778853;3706.962930370662;3741.251749650081;3789.8484060637816;3808.7524310920257;3078.415101130778;3094.05631282461;3133.81197128173;3143.135637699651;3178.698023687746;908.8000639859221;913.3378300731916;913.3423934766957;924.1267002682534;927.846905260638;907.8138981508774;929.0894922975522;930.1442672741094;957.3155194036298;1213.0901823632275;6692.163479565054;6719.193696756421;6738.427233685192;6744.325567443315;6745.5952642841585;396.793667293006;396.9662578680787;400.89977505623597;402.23374471631587;403.59035578887455;5329.733513324396;5374.54316383104;5406.378266499403;5427.538659213932;5430.049741295257;8311.376646751518;8386.664533418718;8576.571171441403;8584.227419532272;8585.914140858637;8420.115887831813;8480.279176269964;8528.74413767588;8530.14698530142;8540.188682075193;6592;6711.496637752188;6721.26066132725;6733.427658648971;6769.8646027079185;6344.365563443804;6383.39357761012;6383.96808015957;6390.9041364378645;6400.455961243347;7402.6668799903055;7498;7594.202608726005;7634.122075961335;7670.539767613961;7592.050993625797;7657.57883316423;7674.386049115946;7809.492382995087;7907.84184316322;4782.139214941205;5556.805511807067;5772.913406298993;5816.331121921034;5826.417358264309;6697.564658297195;6720.361565651256;6761.492888033516;6782;6823.727050917908;5990.610610310316;6100.328963813889;6187.597806142587;6187.907181392193;6350.110984462087;5868.413158684098;5929.673867937305;5966.373530779206;6082.756689732361;6082.878342433038;6159.29168145669;6450.161479007699;6471.996840489732;6498.090267362668;6513.088167656437;5949.970250148722;6006.159137720635;6073.240844894388;6074.514038876968;6079.361667024898;5708.65748055118;5717.199592057199;5768.134779783066;5863.120531920246;6003.669798161143 04:35:44 INFO - PROCESS | 10116 | |4;prototype.html;284.2694275711421;285.33801580333625;289.29556529849805;292.9677735449101;295.13525370663945;5674.5744069194825;5698.914516282254;5700.6579605223715;5701.315842098954;5726.427357264266;5594.356648985368;5606.775728970846;5613.663180209191;5613.719314034292;5622.718864056791;4015.578364271746;4119.464469618961;4234.491860976687;4245.23585754564;4245.8089385977555;4213.7893105344765;4216.388623649569;4220.113776107021;4241.6818738594575;4241.936370954438;4152.2733521633745;4175.394567787669;4188.308929026707;4200.936985945214;4201.222773786844;4186.392973018896;4205.158968206371;4205.600467955539;4237.32202847546;4263.381809637585;3688.0595448160816;3701.592824789271;3711.758735682172;3715.1826598148364;3723.0320116769562;5399.514043736082;5402.405735369106;5418.756155972991;5426.403095659474;5428.67427954324;4640.419947506562;4798.448178459487;4810.06203790261;4841.7579121044155;4863.076015557032;5841.678707671076;5883.146943693183;5926.051831706949;5930.229070220887;5944.970275148597;3917.902052448683;3934.0951581136214;3934.213157368538;3940.4089386591954;3941.3299739044432;6165;6212.813615591494;6230.781922632731;6243.968780156116;6253.437190652818;4026.3960405939342;4030.7984600769846;4035.636792688672;4039.071013666873;4045.615666511677;4090.550039495653;4103.712740108223;4105.34314509683;4107.055377263247;4107.322291821816;4608.193566125915;4714.740689262055;4716.410448693913;4720.763961801897;4723.102610503994;5884.08796636522;5903.616264942851;5903.852403689856;5908.940910590925;5915.3788852170765;1430.5851303122186;1448.304813689435;1449.5506393018197;1449.8695117439481;1450.7098580283985;914.7347269291964;928.2713070239829;946.2619157057369;950.6910254167424;957.9808403831885;5108.157154069537;5179.456157103526;5184.092783762826;5199.350081239845;5199.532042116228;6054.909176362358;6128.724207410677;6131.448169664752;6133.754649814046;6136.325004249529;5009.724465154379;5134.640575159703;5188.922166167435;5189.584833213334;5262.842114736564;3322.1196382958537;3358;3364.6635336466156;3365.865365385357;3366.495025746158;5883.911741323884;5884.0585506318785;5884.529237660977;5886.58793884424;5895.233619629421;6368.235811702625;6382.776602818879;6386;6394.136791533084;6394.424501794861;5633.521150702236;5830.2420685310635;5863.5309175265875;5872.559558033165;5876.529877609781;6027.30685971119;6037;6184.165137706532;6199.969000154971;6204.441600255998;6068.7269072892705;6069.150318955438;6069.453749162597;6080.0575910733905;6088.178095957166;5832.679202643895;5842.620229685057;5852.063669812809;5862.149988251765;5863.589548731547;3967.5834037425657;3982.4225487303597;3987.6610488108836;3988.282109220368;3991.640752332304;5984;6109.84725381869;6132.6627035513475;6174.876502469836;6205.81382558524;5913.231279933581;5950.642961422329;5955.76176952917;5961.135635332766;5964.433378829004;5941.821745347646;5946.28644562638;5946.316173640087;5950.732217050329;5957.702114894151;5821.38875418075;5832.912506312324;5835.708214589338;5837.854053648693;5840.445157710011;5947.405259474018;5949.583529152917;5952.464278214981;5963.970180149245;5992.101184822312;5601.011640867597;5836.562257830595;5842.620229685057;5842.7662893485485;5843.386444423444 04:35:44 INFO - PROCESS | 10116 | |5;yui.html;620.8696173803501;633.9651319177443;634.4416913116456;653.2911790707083;680.1939701453778;9679.467629280387;9696.660616878411;9755.804883902327;9791.069848364394;10461.843072353911;11077.778444431107;11741;11748.353840538766;11750.059995200385;11765.529378824858;596.4810614765139;751.1324420294554;762.1273641680273;769.3268390158611;782.636074225485;758.9696412143508;765.1545042727789;767.1446337333861;767.6583920155505;769.7575263791915;796.6176235407008;799.7280924485674;801.070757920812;801.8235988082641;802.4022103532847;787.3189690917372;793.131520984521;795.5862951265367;797.5414136871293;797.7646594254709;559.1361346719287;585.7188549496266;590.3063899917622;593.6823799267371;595.0301009354768;11490.080793536497;11542;11542.653720388402;11561.190716649839;11579.594714185047;11534.192606517547;11835.171537992344;11846.408889287117;11876.52493900243;12071.275723456622;9180.770480737969;9222.815543689156;9275.304352173614;9316;9364.719058428258;2944.6319210098736;2955;2970.2574356410896;2973.8215707057648;2990.790644654875;39698;39915.40126898099;40028;40548.79725601383;42025.1594968102;8572.699955501652;8786.384953053224;8874.467531947974;8895.688650897187;8925.598348074353;14980.475683351031;15550.300236489385;15593.610159746097;15742.842571574367;15831.287592058155;5810.302763668386;5849.824505264849;5861.824145275648;5943.851403714942;5972.492338151219;3443.1908501502126;3462.740294477924;3492.1444246159344;3545.5745310562384;3584.1039740064984;2521.5083058803725;2530.7975361971367;2623.2130360891656;2628.3166376742183;2638.7888968882444;469.0993292877683;475.6717864673364;476.0550307639333;476.28794951547656;479.3576607346103;551.4210079416597;568.3038278109283;578.12702818744;585.9091840764688;592.1591340296789;7460.477766556398;7580.1661817200065;7715.1899050600005;7735.22647735222;7736.342410895025;529.7139544645925;556.0658094401364;558.5810642018486;562.8480310316191;568.5167607533564;3081.830499322514;3388.0724291491606;3395.1002984209204;3421.5723034620673;3499.772514786531;49940.75029624828;50028.749856250484;50510.74744626327;50519.24221136686;50588.494115058376;43734.343984840256;44515;44563;44921.326180107324;45362.092758145314;40385.798071010046;40508.59491405107;40545.797271014046;41028.589714102476;41280.1743965119;6713.53530539084;6791.320867913169;6793.320667933365;6914.9308506914285;7050.400715939202;30989.225269368446;31307.686923130477;31308.686913130576;31768.841155794074;32072.198195044377;38128.23743525059;39979.2004159921;40339.394909076975;40404.1919161621;40597.39103913384;8022.197780221931;8039.799005024921;8258.504489730394;8330.708425205332;8449.155084491502;8161.959190204011;8580.613872375883;8599.914000859912;8662.819406550923;8668.349873759367;8537.87193192115;8604.956975215084;8895.466272023441;9106.499142547224;9230.307726920373;8069.919300806917;8103.797405064921;8170.836583268182;8304.501729896225;8369.204925532309;8514.48913065218;9061.637534498546;9492.620295188115;9891.703248902544;10205.285630005828;8269.338452923872;8301.950620109128;8377.623006964579;8402.747917562483;8630.5253211074;8482.448640838325;8610.913890861262;8648.481091134301;8726.171013753683;8796.340274479568 04:35:44 INFO - PROCESS | 10116 | __end_tp_report 04:35:44 INFO - PROCESS | 10116 | __start_cc_report 04:35:44 INFO - PROCESS | 10116 | _x_x_mozilla_cycle_collect,356 04:35:44 INFO - PROCESS | 10116 | __end_cc_report 04:35:44 INFO - PROCESS | 10116 | __startTimestamp1456835744396__endTimestamp 04:35:44 INFO - PROCESS | 10116 | 04:35:44 INFO - PROCESS | 10116 | ------- Summary: start ------- 04:35:44 INFO - PROCESS | 10116 | Number of tests: 6 04:35:44 INFO - PROCESS | 10116 | 04:35:44 INFO - PROCESS | 10116 | [#0] dojo.html Cycles:165 Average:4561.80 Median:4714.10 stddev:488.70 (10.4%) stddev-sans-first:467.06 04:35:44 INFO - PROCESS | 10116 | Values: 2667.5 2678.6 2726.0 2729.6 2743.9 4498.0 4643.5 4666.9 4683.9 4702.8 4621.9 4624.7 4671.2 4702.5 4710.2 4214.7 4252.5 4298.3 4341.9 4385.0 4248.2 4278.6 4297.3 4330.2 4393.1 4204.3 4207.2 4222.2 4271.5 4274.1 4223.3 4235.8 4238.4 4257.2 4285.6 4117.4 4212.3 4239.8 4268.0 4294.8 4509.5 4548.2 4548.3 4553.1 4585.4 4903.3 4903.3 4929.7 4932.9 4976.4 4834.4 4944.5 4953.9 4980.6 5016.2 4590.0 4597.0 4602.1 4625.0 4651.5 5050.8 5069.3 5080.1 5083.7 5137.7 4750.9 4873.5 4911.3 4925.8 4944.6 4772.7 4944.8 4985.0 4988.2 5040.9 4924.3 4944.6 4951.3 4951.6 4978.9 4773.5 4912.0 4954.3 4966.0 4984.1 3823.7 3826.1 3827.6 3842.1 3870.6 3371.9 3408.1 3438.6 3452.6 3474.5 4313.7 4366.0 4373.2 4382.9 4408.4 4914.2 4926.5 4930.6 4941.8 4945.7 4225.9 4307.0 4309.7 4315.9 4320.4 4392.9 4398.5 4414.3 4422.0 4429.5 4691.1 4708.1 4710.7 4724.8 4764.1 4720.0 4792.7 4957.3 4961.9 4979.3 4703.6 4724.5 4728.1 4746.2 4754.7 4889.9 4905.7 4907.7 4907.8 4970.6 4754.8 4908.0 4954.1 4993.5 5026.5 4598.8 4773.0 4799.4 4806.5 4852.2 4775.7 4789.3 4791.4 4806.9 4815.0 4593.6 4714.1 4714.1 4765.6 4830.2 4878.5 4885.2 4903.2 4903.5 4917.6 4698.7 4743.4 4759.5 4772.0 4801.6 04:35:44 INFO - PROCESS | 10116 | 04:35:44 INFO - PROCESS | 10116 | [#1] ext.html Cycles:180 Average:40006.93 Median:33578.25 stddev:62636.50 (186.5%) stddev-sans-first:62741.87 04:35:44 INFO - PROCESS | 10116 | Values: 470.9 486.0 490.7 511.6 531.6 33025.7 33450.2 33470.7 33551.7 33604.8 36596.8 37497.8 37620.4 37683.8 37796.0 7633.0 7690.4 7809.8 7840.6 7847.4 7611.4 7702.9 7743.0 7744.1 7759.3 7924.2 7972.4 7993.7 8000.0 8017.4 7889.7 7924.5 7927.1 7930.0 7944.1 7794.3 7901.8 7918.3 7934.6 7957.8 36253.0 36552.8 36928.3 37080.8 37082.3 2141.5 2711.3 2726.1 2730.0 2885.7 25275.2 26699.6 26869.6 27601.9 27666.0 2917.7 2930.5 2969.1 2986.9 3185.9 219498.0 220676.0 221357.0 222281.0 222559.9 55964.4 56334.7 56398.2 56429.0 56436.2 60866.1 61350.7 61521.0 61525.0 61540.7 11893.6 11971.8 12136.3 12145.9 12157.8 8884.9 8908.6 8981.2 9002.0 9032.5 18939.4 19207.4 19357.6 19370.4 19466.3 7611.7 7818.4 7887.8 7897.3 7900.0 823.0 834.3 900.9 948.8 1008.1 25831.6 25897.7 26022.9 26340.2 26401.5 936.2 941.9 963.4 977.1 979.3 13587.5 13939.9 13986.4 14101.7 14136.9 249913.0 251460.0 253690.0 254152.0 254339.0 44448.8 44760.8 44845.0 44848.3 44852.6 1195.9 1210.5 1214.4 1216.5 1217.4 24726.9 25636.7 25643.2 25746.2 25803.0 39268.2 39505.2 39785.6 39839.2 39853.4 244398.0 245771.0 245956.0 246029.0 247431.0 29000.4 29214.3 29259.3 29315.1 29629.7 38051.8 38685.8 38822.2 38967.2 39448.8 32795.5 32924.5 33089.2 33748.7 33749.5 32084.7 32389.0 32673.8 33094.5 33299.5 32904.2 32945.5 32985.3 35281.0 35685.6 27936.9 29962.3 30509.8 30632.5 30699.5 23389.2 23608.6 23631.9 23841.6 23969.6 04:35:44 INFO - PROCESS | 10116 | 04:35:44 INFO - PROCESS | 10116 | [#2] jquery.html Cycles:180 Average:22002.02 Median:5094.00 stddev:62518.64 (1227.3%) stddev-sans-first:62672.84 04:35:44 INFO - PROCESS | 10116 | Values: 325.8 332.7 332.9 342.8 343.9 14634.6 14986.1 15609.3 15646.6 15739.3 13778.0 13959.8 14125.5 14741.4 14806.3 4839.6 5021.5 5030.2 5045.3 5092.9 4912.2 4919.4 5032.7 5112.8 5120.8 5054.9 5079.3 5095.1 5114.0 5125.2 5088.9 5330.3 5352.9 5362.8 5364.9 5191.8 5256.0 5256.2 5257.4 5259.8 15164.5 18818.1 19016.1 19038.4 19041.6 1833.6 1854.3 1857.1 1863.0 2152.6 8746.5 8965.1 9486.0 10324.5 11759.2 1671.0 1721.4 1724.6 1728.1 1777.5 52232.5 54917.5 55095.4 55435.7 56502.0 9334.9 9728.7 9785.2 9855.8 9869.4 12471.6 12491.8 12537.0 12554.4 12571.0 6540.8 6795.2 6810.0 6896.5 6902.9 6372.0 6382.9 6426.1 6492.2 6520.8 4228.8 4230.9 4249.2 4253.7 4306.1 1724.8 1755.0 1794.7 1802.2 1809.6 339.1 359.6 370.6 813.7 890.7 8884.7 9227.0 9477.3 9523.9 9702.0 387.4 387.8 388.9 392.6 404.3 5098.7 5142.1 5143.7 5152.1 5179.6 371966.0 378557.0 379762.0 386093.0 388082.0 52773.2 61065.1 66970.7 68438.3 70404.6 391.9 401.6 405.7 407.0 407.9 9208.0 9248.1 9383.8 9542.4 9607.0 31747.4 31784.7 31833.7 31891.4 32818.0 41583.4 43271.0 44925.1 45054.3 45284.0 6686.1 6870.3 6899.7 6900.6 6922.8 10038.9 10604.8 10662.5 10934.6 10978.5 9096.1 9176.3 9296.9 9467.9 9558.0 9081.9 9227.3 9346.5 9442.4 9544.7 9324.8 9402.3 9589.2 9728.8 9843.0 6907.5 7010.4 7023.9 7092.7 7139.8 9108.2 9350.0 9497.1 9894.0 9899.1 04:35:44 INFO - PROCESS | 10116 | 04:35:44 INFO - PROCESS | 10116 | [#3] mootools.html Cycles:180 Average:4888.01 Median:6076.94 stddev:2596.02 (42.7%) stddev-sans-first:2589.78 04:35:44 INFO - PROCESS | 10116 | Values: 1362.7 1368.1 1485.9 1700.7 1733.9 5984.9 6899.9 6942.8 7102.0 7119.2 7118.9 7177.9 7194.6 7215.8 7235.6 2022.5 2072.4 2072.6 2082.3 2083.4 2040.2 2043.4 2046.9 2098.4 2103.9 2054.4 2062.3 2073.3 2074.5 2087.9 2027.8 2033.0 2040.2 2041.3 2044.5 2016.6 2037.3 2095.1 2103.4 2113.9 7303.5 7340.2 7350.5 7357.0 7379.7 4194.3 4277.7 4298.2 4314.3 4334.5 2516.2 2620.7 2643.5 2647.2 2647.4 797.6 806.1 821.3 828.5 1513.6 9825.2 9904.8 9964.1 9985.1 9995.5 3597.6 3705.9 3743.1 3802.4 3808.6 7769.1 7791.0 7841.6 7849.7 7851.1 4151.0 4161.7 4169.5 4172.9 4182.3 3116.0 3707.0 3741.3 3789.8 3808.8 3078.4 3094.1 3133.8 3143.1 3178.7 908.8 913.3 913.3 924.1 927.8 907.8 929.1 930.1 957.3 1213.1 6692.2 6719.2 6738.4 6744.3 6745.6 396.8 397.0 400.9 402.2 403.6 5329.7 5374.5 5406.4 5427.5 5430.0 8311.4 8386.7 8576.6 8584.2 8585.9 8420.1 8480.3 8528.7 8530.1 8540.2 6592.0 6711.5 6721.3 6733.4 6769.9 6344.4 6383.4 6384.0 6390.9 6400.5 7402.7 7498.0 7594.2 7634.1 7670.5 7592.1 7657.6 7674.4 7809.5 7907.8 4782.1 5556.8 5772.9 5816.3 5826.4 6697.6 6720.4 6761.5 6782.0 6823.7 5990.6 6100.3 6187.6 6187.9 6350.1 5868.4 5929.7 5966.4 6082.8 6082.9 6159.3 6450.2 6472.0 6498.1 6513.1 5950.0 6006.2 6073.2 6074.5 6079.4 5708.7 5717.2 5768.1 5863.1 6003.7 04:35:44 INFO - PROCESS | 10116 | 04:35:44 INFO - PROCESS | 10116 | [#4] prototype.html Cycles:180 Average:4862.15 Median:5628.12 stddev:1485.12 (26.4%) stddev-sans-first:1448.99 04:35:44 INFO - PROCESS | 10116 | Values: 284.3 285.3 289.3 293.0 295.1 5674.6 5698.9 5700.7 5701.3 5726.4 5594.4 5606.8 5613.7 5613.7 5622.7 4015.6 4119.5 4234.5 4245.2 4245.8 4213.8 4216.4 4220.1 4241.7 4241.9 4152.3 4175.4 4188.3 4200.9 4201.2 4186.4 4205.2 4205.6 4237.3 4263.4 3688.1 3701.6 3711.8 3715.2 3723.0 5399.5 5402.4 5418.8 5426.4 5428.7 4640.4 4798.4 4810.1 4841.8 4863.1 5841.7 5883.1 5926.1 5930.2 5945.0 3917.9 3934.1 3934.2 3940.4 3941.3 6165.0 6212.8 6230.8 6244.0 6253.4 4026.4 4030.8 4035.6 4039.1 4045.6 4090.6 4103.7 4105.3 4107.1 4107.3 4608.2 4714.7 4716.4 4720.8 4723.1 5884.1 5903.6 5903.9 5908.9 5915.4 1430.6 1448.3 1449.6 1449.9 1450.7 914.7 928.3 946.3 950.7 958.0 5108.2 5179.5 5184.1 5199.4 5199.5 6054.9 6128.7 6131.4 6133.8 6136.3 5009.7 5134.6 5188.9 5189.6 5262.8 3322.1 3358.0 3364.7 3365.9 3366.5 5883.9 5884.1 5884.5 5886.6 5895.2 6368.2 6382.8 6386.0 6394.1 6394.4 5633.5 5830.2 5863.5 5872.6 5876.5 6027.3 6037.0 6184.2 6200.0 6204.4 6068.7 6069.2 6069.5 6080.1 6088.2 5832.7 5842.6 5852.1 5862.1 5863.6 3967.6 3982.4 3987.7 3988.3 3991.6 5984.0 6109.8 6132.7 6174.9 6205.8 5913.2 5950.6 5955.8 5961.1 5964.4 5941.8 5946.3 5946.3 5950.7 5957.7 5821.4 5832.9 5835.7 5837.9 5840.4 5947.4 5949.6 5952.5 5964.0 5992.1 5601.0 5836.6 5842.6 5842.8 5843.4 04:35:44 INFO - PROCESS | 10116 | 04:35:44 INFO - PROCESS | 10116 | [#5] yui.html Cycles:180 Average:11806.89 Median:3226.07 stddev:13984.29 (433.5%) stddev-sans-first:13998.29 04:35:44 INFO - PROCESS | 10116 | Values: 620.9 634.0 634.4 653.3 680.2 9679.5 9696.7 9755.8 9791.1 10461.8 11077.8 11741.0 11748.4 11750.1 11765.5 596.5 751.1 762.1 769.3 782.6 759.0 765.2 767.1 767.7 769.8 796.6 799.7 801.1 801.8 802.4 787.3 793.1 795.6 797.5 797.8 559.1 585.7 590.3 593.7 595.0 11490.1 11542.0 11542.7 11561.2 11579.6 11534.2 11835.2 11846.4 11876.5 12071.3 9180.8 9222.8 9275.3 9316.0 9364.7 2944.6 2955.0 2970.3 2973.8 2990.8 39698.0 39915.4 40028.0 40548.8 42025.2 8572.7 8786.4 8874.5 8895.7 8925.6 14980.5 15550.3 15593.6 15742.8 15831.3 5810.3 5849.8 5861.8 5943.9 5972.5 3443.2 3462.7 3492.1 3545.6 3584.1 2521.5 2530.8 2623.2 2628.3 2638.8 469.1 475.7 476.1 476.3 479.4 551.4 568.3 578.1 585.9 592.2 7460.5 7580.2 7715.2 7735.2 7736.3 529.7 556.1 558.6 562.8 568.5 3081.8 3388.1 3395.1 3421.6 3499.8 49940.8 50028.7 50510.7 50519.2 50588.5 43734.3 44515.0 44563.0 44921.3 45362.1 40385.8 40508.6 40545.8 41028.6 41280.2 6713.5 6791.3 6793.3 6914.9 7050.4 30989.2 31307.7 31308.7 31768.8 32072.2 38128.2 39979.2 40339.4 40404.2 40597.4 8022.2 8039.8 8258.5 8330.7 8449.2 8162.0 8580.6 8599.9 8662.8 8668.3 8537.9 8605.0 8895.5 9106.5 9230.3 8069.9 8103.8 8170.8 8304.5 8369.2 8514.5 9061.6 9492.6 9891.7 10205.3 8269.3 8302.0 8377.6 8402.7 8630.5 8482.4 8610.9 8648.5 8726.2 8796.3 04:35:44 INFO - PROCESS | 10116 | -------- Summary: end -------- 04:35:44 INFO - PROCESS | 10116 | 04:35:44 INFO - PROCESS | 10116 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:44 INFO - PROCESS | 10116 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:44 INFO - PROCESS | 10116 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:44 INFO - PROCESS | 10116 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:44 INFO - PROCESS | 10116 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:44 INFO - PROCESS | 10116 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:44 INFO - PROCESS | 10116 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:44 INFO - PROCESS | 10116 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:44 INFO - PROCESS | 10116 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:44 INFO - PROCESS | 10116 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:45 INFO - TEST-INFO | 10116: exit 0 04:35:45 INFO - TEST-OK | dromaeo_css | took 1114648ms 04:35:45 INFO - TEST-START | kraken 04:35:45 INFO - operating with platform_type : linux_ 04:35:45 INFO - Initialising browser for kraken test... 04:35:45 INFO - TEST-INFO | started process 10344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZhfmx0/profile http://localhost:41237/getInfo.html) 04:35:49 INFO - PROCESS | 10344 | 04:35:49 INFO - PROCESS | 10344 | (process:10413): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:35:50 INFO - PROCESS | 10344 | __metrics Screen width/height:1600/1200 04:35:50 INFO - PROCESS | 10344 | colorDepth:24 04:35:50 INFO - PROCESS | 10344 | Browser inner width/height: 1024/697 04:35:50 INFO - PROCESS | 10344 | __metrics 04:35:50 ERROR - PROCESS | 10344 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:35:50 INFO - PROCESS | 10344 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:50 INFO - PROCESS | 10344 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:50 INFO - PROCESS | 10344 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:50 INFO - PROCESS | 10344 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:50 INFO - PROCESS | 10344 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:50 INFO - PROCESS | 10344 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:50 INFO - PROCESS | 10344 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:50 INFO - PROCESS | 10344 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:50 INFO - PROCESS | 10344 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:51 INFO - TEST-INFO | 10344: exit 0 04:35:51 INFO - Browser initialized. 04:35:51 INFO - Running cycle 1/1 for kraken test... 04:35:51 INFO - TEST-INFO | started process 10464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZhfmx0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:35:53 INFO - PROCESS | 10464 | 04:35:53 INFO - PROCESS | 10464 | (process:10522): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:36:03 INFO - PROCESS | 10464 | RSS: Main: 161464320 04:36:03 INFO - PROCESS | 10464 | 04:36:06 INFO - PROCESS | 10464 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41237/tests/kraken/driver.html?testName=audio-beat-detection) 04:36:06 INFO - PROCESS | 10464 | RSS: Main: 167579648 04:36:06 INFO - PROCESS | 10464 | 04:36:09 INFO - PROCESS | 10464 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41237/tests/kraken/driver.html?testName=audio-dft) 04:36:10 INFO - PROCESS | 10464 | RSS: Main: 168923136 04:36:10 INFO - PROCESS | 10464 | 04:36:13 INFO - PROCESS | 10464 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41237/tests/kraken/driver.html?testName=audio-fft) 04:36:13 INFO - PROCESS | 10464 | RSS: Main: 165957632 04:36:13 INFO - PROCESS | 10464 | 04:36:15 INFO - PROCESS | 10464 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41237/tests/kraken/driver.html?testName=audio-oscillator) 04:36:16 INFO - PROCESS | 10464 | RSS: Main: 166232064 04:36:16 INFO - PROCESS | 10464 | 04:36:18 INFO - PROCESS | 10464 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:36:19 INFO - PROCESS | 10464 | RSS: Main: 165838848 04:36:19 INFO - PROCESS | 10464 | 04:36:22 INFO - PROCESS | 10464 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41237/tests/kraken/driver.html?testName=imaging-darkroom) 04:36:23 INFO - PROCESS | 10464 | RSS: Main: 166514688 04:36:23 INFO - PROCESS | 10464 | 04:36:26 INFO - PROCESS | 10464 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41237/tests/kraken/driver.html?testName=imaging-desaturate) 04:36:27 INFO - PROCESS | 10464 | RSS: Main: 166207488 04:36:27 INFO - PROCESS | 10464 | 04:36:30 INFO - PROCESS | 10464 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41237/tests/kraken/driver.html?testName=json-parse-financial) 04:36:30 INFO - PROCESS | 10464 | RSS: Main: 166674432 04:36:30 INFO - PROCESS | 10464 | 04:36:32 INFO - PROCESS | 10464 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:36:33 INFO - PROCESS | 10464 | RSS: Main: 165208064 04:36:33 INFO - PROCESS | 10464 | 04:36:34 INFO - PROCESS | 10464 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41237/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:36:35 INFO - PROCESS | 10464 | RSS: Main: 165400576 04:36:35 INFO - PROCESS | 10464 | 04:36:37 INFO - PROCESS | 10464 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:36:38 INFO - PROCESS | 10464 | RSS: Main: 165736448 04:36:38 INFO - PROCESS | 10464 | 04:36:40 INFO - PROCESS | 10464 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:36:41 INFO - PROCESS | 10464 | RSS: Main: 165715968 04:36:41 INFO - PROCESS | 10464 | 04:36:44 INFO - PROCESS | 10464 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:36:44 INFO - PROCESS | 10464 | RSS: Main: 165568512 04:36:44 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | Cycle 1(1): loaded http://localhost:41237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41237/tests/kraken/driver.html?testName=ai-astar) 04:36:46 INFO - PROCESS | 10464 | RSS: Main: 167956480 04:36:46 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | __start_tp_report 04:36:46 INFO - PROCESS | 10464 | _x_x_mozilla_page_load 04:36:46 INFO - PROCESS | 10464 | _x_x_mozilla_page_load_details 04:36:46 INFO - PROCESS | 10464 | |i|pagename|runs| 04:36:46 INFO - PROCESS | 10464 | |0;ai-astar;117;111;115;115;117;131;115;114;115;114 04:36:46 INFO - PROCESS | 10464 | |1;audio-beat-detection;164;136;161;169;149;165;157;140;179;133 04:36:46 INFO - PROCESS | 10464 | |2;audio-dft;164;164;162;164;165;175;163;163;166;165 04:36:46 INFO - PROCESS | 10464 | |3;audio-fft;76;75;75;154;77;73;75;75;156;74 04:36:46 INFO - PROCESS | 10464 | |4;audio-oscillator;98;99;150;99;99;98;139;98;99;147 04:36:46 INFO - PROCESS | 10464 | |5;imaging-gaussian-blur;119;116;116;116;116;115;116;118;117;115 04:36:46 INFO - PROCESS | 10464 | |6;imaging-darkroom;149;148;149;149;149;149;149;149;148;147 04:36:46 INFO - PROCESS | 10464 | |7;imaging-desaturate;97;97;97;97;96;97;97;97;96;96 04:36:46 INFO - PROCESS | 10464 | |8;json-parse-financial;68;68;67;68;68;67;71;76;68;66 04:36:46 INFO - PROCESS | 10464 | |9;json-stringify-tinderbox;71;72;71;72;72;72;71;71;72;71 04:36:46 INFO - PROCESS | 10464 | |10;stanford-crypto-aes;84;85;85;85;86;94;85;87;86;85 04:36:46 INFO - PROCESS | 10464 | |11;stanford-crypto-ccm;129;123;122;126;125;126;131;121;133;130 04:36:46 INFO - PROCESS | 10464 | |12;stanford-crypto-pbkdf2;143;153;155;164;155;141;155;157;154;142 04:36:46 INFO - PROCESS | 10464 | |13;stanford-crypto-sha256-iterative;71;71;75;73;73;73;72;73;71;69 04:36:46 INFO - PROCESS | 10464 | __end_tp_report 04:36:46 INFO - PROCESS | 10464 | __start_cc_report 04:36:46 INFO - PROCESS | 10464 | _x_x_mozilla_cycle_collect,853 04:36:46 INFO - PROCESS | 10464 | __end_cc_report 04:36:46 INFO - PROCESS | 10464 | __startTimestamp1456835806892__endTimestamp 04:36:46 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | ------- Summary: start ------- 04:36:46 INFO - PROCESS | 10464 | Number of tests: 14 04:36:46 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | [#0] ai-astar Cycles:10 Average:116.40 Median:115.00 stddev:5.40 (4.7%) stddev-sans-first:5.72 04:36:46 INFO - PROCESS | 10464 | Values: 117.0 111.0 115.0 115.0 117.0 131.0 115.0 114.0 115.0 114.0 04:36:46 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | [#1] audio-beat-detection Cycles:10 Average:155.30 Median:162.50 stddev:15.27 (9.4%) stddev-sans-first:15.87 04:36:46 INFO - PROCESS | 10464 | Values: 164.0 136.0 161.0 169.0 149.0 165.0 157.0 140.0 179.0 133.0 04:36:46 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.50 stddev:3.67 (2.2%) stddev-sans-first:3.87 04:36:46 INFO - PROCESS | 10464 | Values: 164.0 164.0 162.0 164.0 165.0 175.0 163.0 163.0 166.0 165.0 04:36:46 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | [#3] audio-fft Cycles:10 Average:91.00 Median:75.00 stddev:33.75 (45.0%) stddev-sans-first:35.36 04:36:46 INFO - PROCESS | 10464 | Values: 76.0 75.0 75.0 154.0 77.0 73.0 75.0 75.0 156.0 74.0 04:36:46 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | [#4] audio-oscillator Cycles:10 Average:112.60 Median:98.50 stddev:22.75 (23.1%) stddev-sans-first:23.51 04:36:46 INFO - PROCESS | 10464 | Values: 98.0 99.0 150.0 99.0 99.0 98.0 139.0 98.0 99.0 147.0 04:36:46 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.00 stddev:1.26 (1.1%) stddev-sans-first:0.93 04:36:46 INFO - PROCESS | 10464 | Values: 119.0 116.0 116.0 116.0 116.0 115.0 116.0 118.0 117.0 115.0 04:36:46 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 04:36:46 INFO - PROCESS | 10464 | Values: 149.0 148.0 149.0 149.0 149.0 149.0 149.0 149.0 148.0 147.0 04:36:46 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:36:46 INFO - PROCESS | 10464 | Values: 97.0 97.0 97.0 97.0 96.0 97.0 97.0 97.0 96.0 96.0 04:36:46 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | [#8] json-parse-financial Cycles:10 Average:68.70 Median:68.00 stddev:2.87 (4.2%) stddev-sans-first:3.03 04:36:46 INFO - PROCESS | 10464 | Values: 68.0 68.0 67.0 68.0 68.0 67.0 71.0 76.0 68.0 66.0 04:36:46 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:72.00 stddev:0.53 (0.7%) stddev-sans-first:0.53 04:36:46 INFO - PROCESS | 10464 | Values: 71.0 72.0 71.0 72.0 72.0 72.0 71.0 71.0 72.0 71.0 04:36:46 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:85.50 stddev:2.86 (3.3%) stddev-sans-first:2.92 04:36:46 INFO - PROCESS | 10464 | Values: 84.0 85.0 85.0 85.0 86.0 94.0 85.0 87.0 86.0 85.0 04:36:46 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:127.50 stddev:4.03 (3.2%) stddev-sans-first:4.18 04:36:46 INFO - PROCESS | 10464 | Values: 129.0 123.0 122.0 126.0 125.0 126.0 131.0 121.0 133.0 130.0 04:36:46 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:155.00 stddev:7.48 (4.8%) stddev-sans-first:7.20 04:36:46 INFO - PROCESS | 10464 | Values: 143.0 153.0 155.0 164.0 155.0 141.0 155.0 157.0 154.0 142.0 04:36:46 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:73.00 stddev:1.66 (2.3%) stddev-sans-first:1.72 04:36:46 INFO - PROCESS | 10464 | Values: 71.0 71.0 75.0 73.0 73.0 73.0 72.0 73.0 71.0 69.0 04:36:46 INFO - PROCESS | 10464 | -------- Summary: end -------- 04:36:46 INFO - PROCESS | 10464 | 04:36:46 INFO - PROCESS | 10464 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:36:46 INFO - PROCESS | 10464 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:36:46 INFO - PROCESS | 10464 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:36:46 INFO - PROCESS | 10464 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:36:46 INFO - PROCESS | 10464 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:36:46 INFO - PROCESS | 10464 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:36:46 INFO - PROCESS | 10464 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:36:47 INFO - TEST-INFO | 10464: exit 0 04:36:47 INFO - TEST-OK | kraken | took 62815ms 04:36:47 INFO - SUITE-END | took 1177s 04:36:48 INFO - Completed test suite (00:19:37) 04:36:48 INFO - Working with test: dromaeo_css 04:36:48 INFO - Generating results file: dromaeo_css 04:36:48 INFO - Working with test: kraken 04:36:48 INFO - Generating results file: kraken 04:36:48 INFO - javascript benchmark 04:36:48 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:36:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:36:48 INFO - process_Request line: dromaeo_css 6017.02 graph.html#tests=[[72,94,43]] 04:36:48 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:36:48 INFO - process_Request line: kraken 1579.10 graph.html#tests=[[232,94,43]] 04:36:48 INFO - RETURN: dromaeo_css: 6017.02 04:36:48 INFO - RETURN: kraken: 1579.10 04:36:48 INFO - javascript benchmark 04:36:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2667.4931762965034, 2678.5580379237426, 2726.045883940621, 2729.60420738993, 2743.903963361282, 4497.955020449795, 4643.4660014098345, 4666.859994200176, 4683.882902927428, 4702.83540076097, 4621.884452888679, 4624.745638989854, 4671.182543054969, 4702.482726900038, 4710.222813235812, 4214.70497065204, 4252.532221455637, 4298.333758267474, 4341.869743907688, 4384.97807510962, 4248.150369926012, 4278.593533614302, 4297.312430011199, 4330.155619654169, 4393.1213757248515, 4204.26425375558, 4207.179599978005, 4222.218889505451, 4271.530131685512, 4274.1451709658195, 4223.345381465878, 4235.809388577491, 4238.385434112068, 4257.212415703105, 4285.61429471349, 4117.423560701474, 4212.262854000568, 4239.7668128252935, 4268.0183557781575, 4294.828206871722, 4509.458864936196, 4548.2495388260895, 4548.2950142727595, 4553.066621342617, 4585.403897493338, 4903.313536104948, 4903.313536104948, 4929.704217746947, 4932.926006109911, 4976.353074100344, 4834.395700537433, 4944.456109827916, 4953.851384458472, 4980.626453016002, 5016.2224855147515, 4590.0, 4597.0346227291975, 4602.079584083163, 4625.028743963738, 4651.465081515601, 5050.823221187315, 5069.315642388304, 5080.13637681595, 5083.694978301313, 5137.691738495702, 4750.857474275777, 4873.4882837301575, 4911.263310503382, 4925.753712314442, 4944.579710724557, 4772.7136371817805, 4944.777485013111, 4985.027919555652, 4988.152014157602, 5040.873978150576, 4924.3105965164905, 4944.55499005084, 4951.306817045616, 4951.603871690329, 4978.8755281118265, 4773.522647735199, 4912.0, 4954.331165292711, 4965.975170124127, 4984.077945580079, 3823.6749876260274, 3826.0626146593704, 3827.6363745444137, 3842.1355195080882, 3870.632289932452, 3371.9325613487595, 3408.1138903885167, 3438.570178727659, 3452.5856897172, 3474.5483087198504, 4313.741175529478, 4365.978170109129, 4373.234683930299, 4382.912341753147, 4408.360787685768, 4914.213725803926, 4926.507349265116, 4930.630202734809, 4941.802327906844, 4945.67853089548, 4225.936610950838, 4306.966328081238, 4309.741415515079, 4315.913681726348, 4320.4167437395545, 4392.934105988413, 4398.450193725785, 4414.3157810539415, 4422.027154026109, 4429.49060857999, 4691.132140554008, 4708.128996135726, 4710.6702530823195, 4724.811007559659, 4764.118638051971, 4719.976400117977, 4792.7124372537755, 4957.305977163128, 4961.851144465528, 4979.278004689372, 4703.553162449562, 4724.503927087606, 4728.0780247851335, 4746.169420351355, 4754.7384893829785, 4889.926651100308, 4905.681130726492, 4907.68100073494, 4907.779149938333, 4970.552650261494, 4754.762261886823, 4907.975460122677, 4954.133026720381, 4993.500649935123, 5026.52248036436, 4598.770061496979, 4772.976135119302, 4799.424069111729, 4806.543378379049, 4852.199387101089, 4775.689580177277, 4789.3055506952, 4791.353167322367, 4806.855794326176, 4814.975925120352, 4593.586577208067, 4714.104320179155, 4714.127886341038, 4765.5949244314625, 4830.203016502238, 4878.512148785093, 4885.2427873679635, 4903.166461701448, 4903.53416425439, 4917.6311776616185, 4698.671093023456, 4743.383360163157, 4759.476457589732, 4771.95228047729, 4801.591864691541], "unit": "score", "name": "dojo.html", "value": 4530.8469550233685}, {"lowerIsBetter": false, "replicates": [470.9004474551919, 485.99641739807316, 490.74971764400146, 511.6086194061542, 531.6411422289955, 33025.66974330256, 33450.163745906364, 33470.66529334706, 33551.66448335516, 33604.83197584012, 36596.81701591495, 37497.812510937474, 37620.43569346462, 37683.811580942056, 37796.0, 7633.0, 7690.423218258625, 7809.765707028798, 7840.607969601526, 7847.372210223197, 7611.353034992032, 7702.922970770304, 7743.0, 7744.070711514626, 7759.301662850342, 7924.207579242087, 7972.441929064968, 7993.720219792309, 7999.96000020002, 8017.3586113111105, 7889.684412623488, 7924.48490848093, 7927.128015918244, 7930.0, 7944.08643006053, 7794.337481314095, 7901.841963160705, 7918.287354138155, 7934.642941067666, 7957.7612671619945, 36253.0, 36552.81723591391, 36928.26143477116, 37080.81459592712, 37082.25835483302, 2141.496748264157, 2711.30861630283, 2726.1003868723274, 2730.0308390521277, 2885.653721553406, 25275.24174274775, 26699.599506007424, 26869.596956045676, 27601.86199068992, 27666.03168889079, 2917.7082291770867, 2930.5457654063653, 2969.1092672198256, 2986.8655910483862, 3185.856636451342, 219498.0, 220676.0, 221357.0, 222281.0, 222559.88720056458, 55964.44035559674, 56334.7183264081, 56398.15402768962, 56429.0, 56436.153457698165, 60866.08700869491, 61350.69324653348, 61521.0, 61525.0, 61540.69229653823, 11893.583724569771, 11971.820422693667, 12136.332501712313, 12145.939270303592, 12157.817632735516, 8884.911150888409, 8908.55457227149, 8981.236594889377, 9002.009778924314, 9032.45805251687, 18939.43181704551, 19207.423777286705, 19357.612847742967, 19370.41888743312, 19466.318678846455, 7611.733589324458, 7818.387151580481, 7887.802804929808, 7897.3287270581495, 7899.960500197577, 823.0, 834.2700137379793, 900.9369344145978, 948.8292107420592, 1008.0977525114981, 25831.61252581213, 25897.74102258991, 26022.86988565045, 26340.20979370622, 26401.47197056048, 936.2089034765612, 941.9199368053655, 963.3786207895868, 977.0961860279214, 979.3389462113046, 13587.456501740018, 13939.860601393857, 13986.370613322424, 14101.717965640835, 14136.929315353358, 249913.0, 251460.0, 253690.0, 254152.0, 254339.0, 44448.77775611166, 44760.77619611881, 44845.0, 44848.3272750909, 44852.55147448549, 1195.8744331845205, 1210.5399948019872, 1214.4474264209764, 1216.5073145376136, 1217.4156404925686, 24726.876365618056, 25636.743632563437, 25643.230703078938, 25746.227613171635, 25803.0, 39268.2146357077, 39505.209895802494, 39785.60214397819, 39839.2032159361, 39853.40219896762, 244398.0, 245771.0, 245956.0, 246029.0, 247431.0, 29000.419991600473, 29214.299216985644, 29259.268518287212, 29315.12054638364, 29629.703702962695, 38051.80974095112, 38685.80657096697, 38822.223555529294, 38967.2206555873, 39448.802755986035, 32795.508067378534, 32924.50613240755, 33089.172770679965, 33748.66251337554, 33749.493757594144, 32084.67915320817, 32389.0, 32673.836630816695, 33094.50358244676, 33299.500507491925, 32904.177395565304, 32945.505817413235, 32985.34029319352, 35281.0, 35685.64314356823, 27936.86031569829, 29962.25094372658, 30509.847450762605, 30632.540511891893, 30699.539506907862, 23389.181378651665, 23608.645870311615, 23631.881840590686, 23841.64237536473, 23969.64045539353], "unit": "score", "name": "ext.html", "value": 16433.079950092273}, {"lowerIsBetter": false, "replicates": [325.8468519795695, 332.7288260068044, 332.86352595435875, 342.8491463755947, 343.91917899293645, 14634.560963171121, 14986.100833949971, 15609.297581608826, 15646.608834779136, 15739.291731872065, 13778.0, 13959.790603140935, 14125.505607303747, 14741.41034358627, 14806.25968701566, 4839.612830973531, 5021.472745361739, 5030.245463180534, 5045.293658887758, 5092.898142037157, 4912.164931961557, 4919.4096708395045, 5032.672876263049, 5112.821051263207, 5120.846374608767, 5054.9494505054845, 5079.288899554065, 5095.108356037697, 5114.02833461643, 5125.179971204608, 5088.898222035557, 5330.333708286465, 5352.91970620441, 5362.785488580452, 5364.865878353034, 5191.818286359997, 5256.0276348875195, 5256.159014557652, 5257.447967963385, 5259.815906443256, 15164.469243576532, 18818.05909704523, 19016.144273507725, 19038.428847134608, 19041.61916761657, 1833.587442825367, 1854.2675643120892, 1857.0621835972881, 1862.9999999999864, 2152.612529744645, 8746.518941458216, 8965.148310910454, 9486.0, 10324.535395907202, 11759.235649682829, 1671.0391524873246, 1721.3544920654754, 1724.6119623084705, 1728.1013872786207, 1777.4578753480184, 52232.47767522314, 54917.45082549203, 55095.449045509435, 55435.722821385636, 56502.0, 9334.859977100348, 9728.659496917715, 9785.186218440616, 9855.80288394228, 9869.407835529892, 12471.625851224479, 12491.812622810665, 12537.0, 12554.372281385895, 12571.0, 6540.771073012422, 6795.1845778506895, 6809.965950170217, 6896.517243792987, 6902.861942761117, 6372.0, 6382.936170638327, 6426.068220108058, 6492.220933487917, 6520.804375868732, 4228.830846766156, 4230.873073807791, 4249.150169966019, 4253.744775313491, 4306.0957198987935, 1724.7989643239425, 1754.9912250438665, 1794.7218181181938, 1802.2070289072767, 1809.6250492830775, 339.1436622528087, 359.60263908381387, 370.60345430389225, 813.6704634622987, 890.7327801659476, 8884.689035883714, 9227.0, 9477.336586439022, 9523.857142142873, 9701.951490242503, 387.3995307273714, 387.78477944740376, 388.8775035863694, 392.5956265047006, 404.34496116291797, 5098.745062746848, 5142.074426603247, 5143.742812859342, 5152.124138896396, 5179.611529135254, 371966.0, 378557.0, 379762.0, 386093.0, 388082.0, 52773.208401874006, 61065.08402373968, 66970.66514667396, 68438.31561684319, 70404.64797675979, 391.89810649231407, 401.56831406237825, 405.71397164998604, 406.9593040695966, 407.87152047105064, 9207.953960230156, 9248.121428464285, 9383.812323753624, 9542.379745316532, 9606.951965240129, 31747.36505269928, 31784.682153179096, 31833.681663183997, 31891.36217275688, 32818.0, 41583.37624935689, 43271.0, 44925.101497969205, 45054.324185137906, 45284.0, 6686.063951046955, 6870.31296870309, 6899.70299291758, 6900.551464154814, 6922.757703480555, 10038.949805251219, 10604.787904242026, 10662.466876656292, 10934.578504794326, 10978.451077445936, 9096.135867092615, 9176.265898727952, 9296.860547091934, 9467.905320946702, 9557.952210238904, 9081.909180908371, 9227.3079519035, 9346.485943273185, 9442.38624489406, 9544.665936692183, 9324.813503730024, 9402.34183607141, 9589.232861371212, 9728.805423891341, 9843.0, 6907.481938854707, 7010.439164866696, 7023.929760702327, 7092.716291348288, 7139.750108746169, 9108.180263776292, 9350.0, 9497.14525692691, 9893.950530247303, 9899.109080182818], "unit": "score", "name": "jquery.html", "value": 6936.8554937331855}, {"lowerIsBetter": false, "replicates": [1362.71383009568, 1368.1449094316056, 1485.9331330090145, 1700.651366469874, 1733.8872973256746, 5984.910226346608, 6899.862002759942, 6942.826429339263, 7102.0412244347, 7119.21688614252, 7118.85762284754, 7177.892331615017, 7194.640267986593, 7215.81960450989, 7235.638218089088, 2022.4842665120373, 2072.367927782026, 2072.6062048210865, 2082.2920207129573, 2083.374987503743, 2040.2349119080345, 2043.3665563675233, 2046.8976551172457, 2098.360000199946, 2103.9474013149716, 2054.3631474243034, 2062.278202629083, 2073.3054426767053, 2074.4917495213695, 2087.885166315852, 2027.7870823563608, 2032.979670203301, 2040.2247146084467, 2041.3467690339098, 2044.5297581556326, 2016.6470867598111, 2037.2665840297482, 2095.057224249094, 2103.3689893032183, 2113.947151321214, 7303.488755787097, 7340.192578816326, 7350.52221605594, 7356.963215183943, 7379.6679149438405, 4194.328907374806, 4277.743335399855, 4298.247806633858, 4314.309710446313, 4334.544872788343, 2516.169664010872, 2620.737926207383, 2643.47130573886, 2647.1529110684587, 2647.364632488189, 797.5573556676043, 806.1011971651625, 821.342925659476, 828.5360198288918, 1513.5610672904845, 9825.213982881352, 9904.801903961952, 9964.05341492557, 9985.101340879282, 9995.450250236234, 3597.6042635310096, 3705.8517659293866, 3743.1390780120723, 3802.4296355546335, 3808.638179372955, 7769.106552746506, 7791.026121734783, 7841.5687137208, 7849.725259615886, 7851.136374998746, 4151.024509240327, 4161.729487583298, 4169.45797046382, 4172.91654166921, 4182.309918863414, 3115.9844200778853, 3706.962930370662, 3741.251749650081, 3789.8484060637816, 3808.7524310920257, 3078.415101130778, 3094.05631282461, 3133.81197128173, 3143.135637699651, 3178.698023687746, 908.8000639859221, 913.3378300731916, 913.3423934766957, 924.1267002682534, 927.846905260638, 907.8138981508774, 929.0894922975522, 930.1442672741094, 957.3155194036298, 1213.0901823632275, 6692.163479565054, 6719.193696756421, 6738.427233685192, 6744.325567443315, 6745.5952642841585, 396.793667293006, 396.9662578680787, 400.89977505623597, 402.23374471631587, 403.59035578887455, 5329.733513324396, 5374.54316383104, 5406.378266499403, 5427.538659213932, 5430.049741295257, 8311.376646751518, 8386.664533418718, 8576.571171441403, 8584.227419532272, 8585.914140858637, 8420.115887831813, 8480.279176269964, 8528.74413767588, 8530.14698530142, 8540.188682075193, 6592.0, 6711.496637752188, 6721.26066132725, 6733.427658648971, 6769.8646027079185, 6344.365563443804, 6383.39357761012, 6383.96808015957, 6390.9041364378645, 6400.455961243347, 7402.6668799903055, 7498.0, 7594.202608726005, 7634.122075961335, 7670.539767613961, 7592.050993625797, 7657.57883316423, 7674.386049115946, 7809.492382995087, 7907.84184316322, 4782.139214941205, 5556.805511807067, 5772.913406298993, 5816.331121921034, 5826.417358264309, 6697.564658297195, 6720.361565651256, 6761.492888033516, 6782.0, 6823.727050917908, 5990.610610310316, 6100.328963813889, 6187.597806142587, 6187.907181392193, 6350.110984462087, 5868.413158684098, 5929.673867937305, 5966.373530779206, 6082.756689732361, 6082.878342433038, 6159.29168145669, 6450.161479007699, 6471.996840489732, 6498.090267362668, 6513.088167656437, 5949.970250148722, 6006.159137720635, 6073.240844894388, 6074.514038876968, 6079.361667024898, 5708.65748055118, 5717.199592057199, 5768.134779783066, 5863.120531920246, 6003.669798161143], "unit": "score", "name": "mootools.html", "value": 3917.7932319236033}, {"lowerIsBetter": false, "replicates": [284.2694275711421, 285.33801580333625, 289.29556529849805, 292.9677735449101, 295.13525370663945, 5674.5744069194825, 5698.914516282254, 5700.6579605223715, 5701.315842098954, 5726.427357264266, 5594.356648985368, 5606.775728970846, 5613.663180209191, 5613.719314034292, 5622.718864056791, 4015.578364271746, 4119.464469618961, 4234.491860976687, 4245.23585754564, 4245.8089385977555, 4213.7893105344765, 4216.388623649569, 4220.113776107021, 4241.6818738594575, 4241.936370954438, 4152.2733521633745, 4175.394567787669, 4188.308929026707, 4200.936985945214, 4201.222773786844, 4186.392973018896, 4205.158968206371, 4205.600467955539, 4237.32202847546, 4263.381809637585, 3688.0595448160816, 3701.592824789271, 3711.758735682172, 3715.1826598148364, 3723.0320116769562, 5399.514043736082, 5402.405735369106, 5418.756155972991, 5426.403095659474, 5428.67427954324, 4640.419947506562, 4798.448178459487, 4810.06203790261, 4841.7579121044155, 4863.076015557032, 5841.678707671076, 5883.146943693183, 5926.051831706949, 5930.229070220887, 5944.970275148597, 3917.902052448683, 3934.0951581136214, 3934.213157368538, 3940.4089386591954, 3941.3299739044432, 6165.0, 6212.813615591494, 6230.781922632731, 6243.968780156116, 6253.437190652818, 4026.3960405939342, 4030.7984600769846, 4035.636792688672, 4039.071013666873, 4045.615666511677, 4090.550039495653, 4103.712740108223, 4105.34314509683, 4107.055377263247, 4107.322291821816, 4608.193566125915, 4714.740689262055, 4716.410448693913, 4720.763961801897, 4723.102610503994, 5884.08796636522, 5903.616264942851, 5903.852403689856, 5908.940910590925, 5915.3788852170765, 1430.5851303122186, 1448.304813689435, 1449.5506393018197, 1449.8695117439481, 1450.7098580283985, 914.7347269291964, 928.2713070239829, 946.2619157057369, 950.6910254167424, 957.9808403831885, 5108.157154069537, 5179.456157103526, 5184.092783762826, 5199.350081239845, 5199.532042116228, 6054.909176362358, 6128.724207410677, 6131.448169664752, 6133.754649814046, 6136.325004249529, 5009.724465154379, 5134.640575159703, 5188.922166167435, 5189.584833213334, 5262.842114736564, 3322.1196382958537, 3358.0, 3364.6635336466156, 3365.865365385357, 3366.495025746158, 5883.911741323884, 5884.0585506318785, 5884.529237660977, 5886.58793884424, 5895.233619629421, 6368.235811702625, 6382.776602818879, 6386.0, 6394.136791533084, 6394.424501794861, 5633.521150702236, 5830.2420685310635, 5863.5309175265875, 5872.559558033165, 5876.529877609781, 6027.30685971119, 6037.0, 6184.165137706532, 6199.969000154971, 6204.441600255998, 6068.7269072892705, 6069.150318955438, 6069.453749162597, 6080.0575910733905, 6088.178095957166, 5832.679202643895, 5842.620229685057, 5852.063669812809, 5862.149988251765, 5863.589548731547, 3967.5834037425657, 3982.4225487303597, 3987.6610488108836, 3988.282109220368, 3991.640752332304, 5984.0, 6109.84725381869, 6132.6627035513475, 6174.876502469836, 6205.81382558524, 5913.231279933581, 5950.642961422329, 5955.76176952917, 5961.135635332766, 5964.433378829004, 5941.821745347646, 5946.28644562638, 5946.316173640087, 5950.732217050329, 5957.702114894151, 5821.38875418075, 5832.912506312324, 5835.708214589338, 5837.854053648693, 5840.445157710011, 5947.405259474018, 5949.583529152917, 5952.464278214981, 5963.970180149245, 5992.101184822312, 5601.011640867597, 5836.562257830595, 5842.620229685057, 5842.7662893485485, 5843.386444423444], "unit": "score", "name": "prototype.html", "value": 4369.522393278961}, {"lowerIsBetter": false, "replicates": [620.8696173803501, 633.9651319177443, 634.4416913116456, 653.2911790707083, 680.1939701453778, 9679.467629280387, 9696.660616878411, 9755.804883902327, 9791.069848364394, 10461.843072353911, 11077.778444431107, 11741.0, 11748.353840538766, 11750.059995200385, 11765.529378824858, 596.4810614765139, 751.1324420294554, 762.1273641680273, 769.3268390158611, 782.636074225485, 758.9696412143508, 765.1545042727789, 767.1446337333861, 767.6583920155505, 769.7575263791915, 796.6176235407008, 799.7280924485674, 801.070757920812, 801.8235988082641, 802.4022103532847, 787.3189690917372, 793.131520984521, 795.5862951265367, 797.5414136871293, 797.7646594254709, 559.1361346719287, 585.7188549496266, 590.3063899917622, 593.6823799267371, 595.0301009354768, 11490.080793536497, 11542.0, 11542.653720388402, 11561.190716649839, 11579.594714185047, 11534.192606517547, 11835.171537992344, 11846.408889287117, 11876.52493900243, 12071.275723456622, 9180.770480737969, 9222.815543689156, 9275.304352173614, 9316.0, 9364.719058428258, 2944.6319210098736, 2955.0, 2970.2574356410896, 2973.8215707057648, 2990.790644654875, 39698.0, 39915.40126898099, 40028.0, 40548.79725601383, 42025.1594968102, 8572.699955501652, 8786.384953053224, 8874.467531947974, 8895.688650897187, 8925.598348074353, 14980.475683351031, 15550.300236489385, 15593.610159746097, 15742.842571574367, 15831.287592058155, 5810.302763668386, 5849.824505264849, 5861.824145275648, 5943.851403714942, 5972.492338151219, 3443.1908501502126, 3462.740294477924, 3492.1444246159344, 3545.5745310562384, 3584.1039740064984, 2521.5083058803725, 2530.7975361971367, 2623.2130360891656, 2628.3166376742183, 2638.7888968882444, 469.0993292877683, 475.6717864673364, 476.0550307639333, 476.28794951547656, 479.3576607346103, 551.4210079416597, 568.3038278109283, 578.12702818744, 585.9091840764688, 592.1591340296789, 7460.477766556398, 7580.1661817200065, 7715.1899050600005, 7735.22647735222, 7736.342410895025, 529.7139544645925, 556.0658094401364, 558.5810642018486, 562.8480310316191, 568.5167607533564, 3081.830499322514, 3388.0724291491606, 3395.1002984209204, 3421.5723034620673, 3499.772514786531, 49940.75029624828, 50028.749856250484, 50510.74744626327, 50519.24221136686, 50588.494115058376, 43734.343984840256, 44515.0, 44563.0, 44921.326180107324, 45362.092758145314, 40385.798071010046, 40508.59491405107, 40545.797271014046, 41028.589714102476, 41280.1743965119, 6713.53530539084, 6791.320867913169, 6793.320667933365, 6914.9308506914285, 7050.400715939202, 30989.225269368446, 31307.686923130477, 31308.686913130576, 31768.841155794074, 32072.198195044377, 38128.23743525059, 39979.2004159921, 40339.394909076975, 40404.1919161621, 40597.39103913384, 8022.197780221931, 8039.799005024921, 8258.504489730394, 8330.708425205332, 8449.155084491502, 8161.959190204011, 8580.613872375883, 8599.914000859912, 8662.819406550923, 8668.349873759367, 8537.87193192115, 8604.956975215084, 8895.466272023441, 9106.499142547224, 9230.307726920373, 8069.919300806917, 8103.797405064921, 8170.836583268182, 8304.501729896225, 8369.204925532309, 8514.48913065218, 9061.637534498546, 9492.620295188115, 9891.703248902544, 10205.285630005828, 8269.338452923872, 8301.950620109128, 8377.623006964579, 8402.747917562483, 8630.5253211074, 8482.448640838325, 8610.913890861262, 8648.481091134301, 8726.171013753683, 8796.340274479568], "unit": "score", "name": "yui.html", "value": 5366.729344075049}], "name": "dromaeo_css", "value": 6017.020989138175}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 111.0, 115.0, 115.0, 117.0, 131.0, 115.0, 114.0, 115.0, 114.0], "unit": "score", "name": "ai-astar", "value": 116.4}, {"lowerIsBetter": true, "replicates": [164.0, 136.0, 161.0, 169.0, 149.0, 165.0, 157.0, 140.0, 179.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 155.3}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 162.0, 164.0, 165.0, 175.0, 163.0, 163.0, 166.0, 165.0], "unit": "score", "name": "audio-dft", "value": 165.1}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 75.0, 154.0, 77.0, 73.0, 75.0, 75.0, 156.0, 74.0], "unit": "score", "name": "audio-fft", "value": 91.0}, {"lowerIsBetter": true, "replicates": [98.0, 99.0, 150.0, 99.0, 99.0, 98.0, 139.0, 98.0, 99.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 112.6}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 116.0, 116.0, 116.0, 115.0, 116.0, 118.0, 117.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.4}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 149.0, 149.0, 149.0, 149.0, 149.0, 149.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.6}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 68.0, 67.0, 71.0, 76.0, 68.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 68.7}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 72.0, 72.0, 72.0, 71.0, 71.0, 72.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.5}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 85.0, 86.0, 94.0, 85.0, 87.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [129.0, 123.0, 122.0, 126.0, 125.0, 126.0, 131.0, 121.0, 133.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.6}, {"lowerIsBetter": true, "replicates": [143.0, 153.0, 155.0, 164.0, 155.0, 141.0, 155.0, 157.0, 154.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.9}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 75.0, 73.0, 73.0, 73.0, 72.0, 73.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.1}], "name": "kraken", "value": 1579.1000000000001}]} 04:36:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1579.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6017.02"}}} 04:36:48 INFO - Return code: 0 04:36:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:36:48 ERROR - # TBPL SUCCESS # 04:36:48 INFO - Running post-action listener: _resource_record_post_action 04:36:48 INFO - Running post-run listener: _resource_record_post_run 04:36:49 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 525660160; Read time: 0; Write time: 492628 04:36:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233680896; Read time: 0; Write time: 307888 04:36:49 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 291979264; Read time: 0; Write time: 184740 04:36:49 INFO - Running post-run listener: _upload_blobber_files 04:36:49 INFO - Blob upload gear active. 04:36:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:36:49 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 04:36:49 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'] 04:36:49 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 04:36:49 INFO - (blobuploader) - INFO - Open directory for files ... 04:36:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:36:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:36:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:36:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:36:50 INFO - (blobuploader) - INFO - Done attempting. 04:36:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:36:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:36:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:36:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:36:51 INFO - (blobuploader) - INFO - Done attempting. 04:36:51 INFO - (blobuploader) - INFO - Iteration through files over. 04:36:51 INFO - Return code: 0 04:36:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:36:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:36:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/876f19b211445514a1757316f464c2f78103e5158401421257240bb2394338aee1853f7fe7f5fdfada33133b96703b9b1a2de6cc663d6b3d644af03f1a5b1e12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f156f54001f56a58e29fc73ede4366cdaa4a9c21a4d21133a40f7a61a6b529fa27da2810aaa03eb6ad0434581dbf53c50dbf7d558e46ee30ddae04fbbc1903da"} 04:36:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:36:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:36:51 INFO - Contents: 04:36:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/876f19b211445514a1757316f464c2f78103e5158401421257240bb2394338aee1853f7fe7f5fdfada33133b96703b9b1a2de6cc663d6b3d644af03f1a5b1e12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f156f54001f56a58e29fc73ede4366cdaa4a9c21a4d21133a40f7a61a6b529fa27da2810aaa03eb6ad0434581dbf53c50dbf7d558e46ee30ddae04fbbc1903da"} 04:36:51 INFO - Running post-run listener: copy_logs_to_upload_dir 04:36:51 INFO - Copying logs to upload dir... 04:36:51 INFO - mkdir: /builds/slave/test/build/upload/logs 04:36:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.924694 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-03-01 04:36:50.957218) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 04:36:50.960625) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268 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/876f19b211445514a1757316f464c2f78103e5158401421257240bb2394338aee1853f7fe7f5fdfada33133b96703b9b1a2de6cc663d6b3d644af03f1a5b1e12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f156f54001f56a58e29fc73ede4366cdaa4a9c21a4d21133a40f7a61a6b529fa27da2810aaa03eb6ad0434581dbf53c50dbf7d558e46ee30ddae04fbbc1903da"} build_url:https://queue.taskcluster.net/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/Wwmz4rpNTseVBtYbbRPgyg/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/876f19b211445514a1757316f464c2f78103e5158401421257240bb2394338aee1853f7fe7f5fdfada33133b96703b9b1a2de6cc663d6b3d644af03f1a5b1e12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f156f54001f56a58e29fc73ede4366cdaa4a9c21a4d21133a40f7a61a6b529fa27da2810aaa03eb6ad0434581dbf53c50dbf7d558e46ee30ddae04fbbc1903da"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 04:36:50.989437) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:36:50.989763) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456834209.292278-828473268 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 04:36:51.073803) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 04:36:51.074574) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 04:36:51.075238) ========= ========= Total master_lag: 0.44 =========