builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1456834560.77 results: success (0) buildid: 20160301025941 builduid: 3e405c042b564da6938b55a324856315 revision: 8ef94be995a453f5c464278c53478ba8c8554f81 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:00.769974) ========= 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:00.770525) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:00.771017) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006374 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:00.794418) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:00.794727) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:00.808397) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:00.808775) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:00.858128) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:00.858427) ========= 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:00.858769) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:00.859039) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432 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% 35.3M=0s 2016-03-01 04:16:01 (35.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113150 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.136167) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.136482) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015553 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.212165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.212530) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-01 04:16:01,879 truncating revision to first 12 chars 2016-03-01 04:16:01,879 Setting DEBUG logging. 2016-03-01 04:16:01,879 attempt 1/10 2016-03-01 04:16:01,879 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:02,151 unpacking tar archive at: mozilla-central-8ef94be995a4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.592530 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.845554) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.845934) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8ef94be995a453f5c464278c53478ba8c8554f81 program finished with exit code 0 elapsedTime=0.004712 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:01.899924) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.900312) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 04:16:01.911817) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-01 04:16:01.912207) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:16:02 INFO - MultiFileLogger online at 20160301 04:16:02 in /builds/slave/test 04:16:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:16:02 INFO - {'append_to_log': False, 04:16:02 INFO - 'base_work_dir': '/builds/slave/test', 04:16:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:16:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:16:02 INFO - 'branch': 'Firefox-Non-PGO', 04:16:02 INFO - 'buildbot_json_path': 'buildprops.json', 04:16:02 INFO - 'config_files': ('talos/linux_config.py',), 04:16:02 INFO - 'default_actions': ('clobber', 04:16:02 INFO - 'read-buildbot-config', 04:16:02 INFO - 'download-and-extract', 04:16:02 INFO - 'populate-webroot', 04:16:02 INFO - 'create-virtualenv', 04:16:02 INFO - 'install', 04:16:02 INFO - 'run-tests'), 04:16:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:16:02 INFO - 'download_minidump_stackwalk': True, 04:16:02 INFO - 'download_symbols': 'ondemand', 04:16:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:16:02 INFO - 'tooltool.py': '/tools/tooltool.py', 04:16:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:16:02 INFO - '/tools/misc-python/virtualenv.py')}, 04:16:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:16:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:16:02 INFO - 'installer_path': 'installer.exe', 04:16:02 INFO - 'log_level': 'info', 04:16:02 INFO - 'log_name': 'talos', 04:16:02 INFO - 'log_to_console': True, 04:16:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:16:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:16:02 INFO - 'opt_config_files': (), 04:16:02 INFO - 'pip_index': False, 04:16:02 INFO - 'sps_profile': False, 04:16:02 INFO - 'sps_profile_interval': 0, 04:16:02 INFO - 'suite': 'dromaeojs', 04:16:02 INFO - 'system_bits': '32', 04:16:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:16:02 INFO - 'title': 'talos-linux64-ix-012', 04:16:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:16:02 INFO - 'use_talos_json': True, 04:16:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:16:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:16:02 INFO - 'work_dir': 'build'} 04:16:02 INFO - ##### 04:16:02 INFO - ##### Running clobber step. 04:16:02 INFO - ##### 04:16:02 INFO - Running pre-action listener: _resource_record_pre_action 04:16:02 INFO - Running main action method: clobber 04:16:02 INFO - rmtree: /builds/slave/test/build 04:16:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:16:03 INFO - Running post-action listener: _resource_record_post_action 04:16:03 INFO - ##### 04:16:03 INFO - ##### Running read-buildbot-config step. 04:16:03 INFO - ##### 04:16:03 INFO - Running pre-action listener: _resource_record_pre_action 04:16:03 INFO - Running main action method: read_buildbot_config 04:16:03 INFO - Using buildbot properties: 04:16:03 INFO - { 04:16:03 INFO - "project": "", 04:16:03 INFO - "product": "firefox", 04:16:03 INFO - "script_repo_revision": "production", 04:16:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:16:03 INFO - "repository": "", 04:16:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:16:03 INFO - "buildid": "20160301025941", 04:16:03 INFO - "pgo_build": "False", 04:16:03 INFO - "basedir": "/builds/slave/test", 04:16:03 INFO - "buildnumber": 3, 04:16:03 INFO - "slavename": "talos-linux64-ix-012", 04:16:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:16:03 INFO - "platform": "ubuntu64_hw", 04:16:03 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:16:03 INFO - "branch": "mozilla-central", 04:16:03 INFO - "repo_path": "mozilla-central", 04:16:03 INFO - "revision": "8ef94be995a453f5c464278c53478ba8c8554f81", 04:16:03 INFO - "stage_platform": "linux64", 04:16:03 INFO - "builduid": "3e405c042b564da6938b55a324856315", 04:16:03 INFO - "slavebuilddir": "test" 04:16:03 INFO - } 04:16:03 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:03 INFO - Running post-action listener: _resource_record_post_action 04:16:03 INFO - ##### 04:16:03 INFO - ##### Running download-and-extract step. 04:16:03 INFO - ##### 04:16:03 INFO - Running pre-action listener: _resource_record_pre_action 04:16:03 INFO - Running main action method: download_and_extract 04:16:03 INFO - mkdir: /builds/slave/test/build/tests 04:16:03 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:03 INFO - https://queue.taskcluster.net/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:16:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/test_packages.json 04:16:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wwmz4rpNTseVBtYbbRPgyg/artifacts/public/build/test_packages.json 04:16:03 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:03 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:03 INFO - Downloaded 1448 bytes. 04:16:03 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:16:03 INFO - Using the following test package requirements: 04:16:03 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:03 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:16:03 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:16:03 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:03 INFO - u'jsshell-linux-x86_64.zip'], 04:16:03 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:16:03 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:03 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:16:03 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:16:03 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:16:03 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:03 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:16:03 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:16:03 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:03 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:03 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:03 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:03 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:03 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:05 INFO - Downloaded 22064914 bytes. 04:16:05 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:05 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:06 INFO - Return code: 0 04:16:06 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:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:06 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:06 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:06 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:06 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:06 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:14 INFO - Downloaded 22064914 bytes. 04:16:14 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:14 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:16 INFO - Return code: 0 04:16:16 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:16 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:16 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:16 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:16 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:16 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:17 INFO - Downloaded 10713410 bytes. 04:16:17 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:17 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:17 INFO - Return code: 0 04:16:17 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:17 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:17 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:17 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:17 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:17 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:18 INFO - Downloaded 54830545 bytes. 04:16:18 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:18 INFO - mkdir: /builds/slave/test/properties 04:16:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:16:18 INFO - Writing to file /builds/slave/test/properties/build_url 04:16:18 INFO - Contents: 04:16:18 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:19 INFO - Running post-action listener: _resource_record_post_action 04:16:19 INFO - Running post-action listener: set_extra_try_arguments 04:16:19 INFO - ##### 04:16:19 INFO - ##### Running populate-webroot step. 04:16:19 INFO - ##### 04:16:19 INFO - Running pre-action listener: _resource_record_pre_action 04:16:19 INFO - Running main action method: populate_webroot 04:16:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:16:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:16:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:16:19 INFO - '--tppagecycles', 04:16:19 INFO - '7'], 04:16:19 INFO - 'tests': ['tsvgm']}}, 04:16:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:16:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:16:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:16:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:16:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:16:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:16:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:19 INFO - 'talos_options': ['--e10s'], 04:16:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:19 INFO - 'tests': ['damp', 'tps']}, 04:16:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:19 INFO - 'talos_options': ['--e10s'], 04:16:19 INFO - 'tests': ['damp', 'tps']}, 04:16:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:16:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:16:19 INFO - 'other': {'tests': ['a11yr', 04:16:19 INFO - 'ts_paint', 04:16:19 INFO - 'tpaint', 04:16:19 INFO - 'sessionrestore', 04:16:19 INFO - 'sessionrestore_no_auto_restore']}, 04:16:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:16:19 INFO - 'tests': ['a11yr', 04:16:19 INFO - 'ts_paint', 04:16:19 INFO - 'tpaint', 04:16:19 INFO - 'sessionrestore', 04:16:19 INFO - 'sessionrestore_no_auto_restore']}, 04:16:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:16:19 INFO - 'tests': ['a11yr', 04:16:19 INFO - 'ts_paint', 04:16:19 INFO - 'tpaint', 04:16:19 INFO - 'sessionrestore', 04:16:19 INFO - 'sessionrestore_no_auto_restore']}, 04:16:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:16:19 INFO - 'tests': ['a11yr', 04:16:19 INFO - 'ts_paint', 04:16:19 INFO - 'tpaint', 04:16:19 INFO - 'sessionrestore', 04:16:19 INFO - 'sessionrestore_no_auto_restore']}, 04:16:19 INFO - 'other_l64': {'tests': ['a11yr', 04:16:19 INFO - 'ts_paint', 04:16:19 INFO - 'tpaint', 04:16:19 INFO - 'sessionrestore', 04:16:19 INFO - 'sessionrestore_no_auto_restore']}, 04:16:19 INFO - 'other_nol64': {'tests': ['a11yr', 04:16:19 INFO - 'ts_paint', 04:16:19 INFO - 'tpaint', 04:16:19 INFO - 'sessionrestore', 04:16:19 INFO - 'sessionrestore_no_auto_restore']}, 04:16:19 INFO - 'svgr': {'tests': ['tsvgx', 04:16:19 INFO - 'tsvgr_opacity', 04:16:19 INFO - 'tart', 04:16:19 INFO - 'tscrollx', 04:16:19 INFO - 'cart']}, 04:16:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:16:19 INFO - 'tests': ['tsvgx', 04:16:19 INFO - 'tsvgr_opacity', 04:16:19 INFO - 'tart', 04:16:19 INFO - 'tscrollx', 04:16:19 INFO - 'cart']}, 04:16:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:19 INFO - 'tests': ['tp5o']}, 04:16:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:19 INFO - 'talos_options': ['--e10s'], 04:16:19 INFO - 'tests': ['tp5o']}, 04:16:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:19 INFO - 'talos_options': ['--xperf_path', 04:16:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:19 INFO - 'tests': ['tp5n']}, 04:16:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:19 INFO - 'talos_options': ['--e10s', 04:16:19 INFO - '--xperf_path', 04:16:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:19 INFO - 'tests': ['tp5n']}}, 04:16:19 INFO - 'talos.zip': {'path': '', 04:16:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:16:19 INFO - Running post-action listener: _resource_record_post_action 04:16:19 INFO - ##### 04:16:19 INFO - ##### Running create-virtualenv step. 04:16:19 INFO - ##### 04:16:19 INFO - Running pre-action listener: _resource_record_pre_action 04:16:19 INFO - Running main action method: create_virtualenv 04:16:19 INFO - Creating virtualenv /builds/slave/test/build/venv 04:16:19 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:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:16:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:16:19 INFO - Using real prefix '/usr' 04:16:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:16:20 INFO - Installing distribute.............................................................................................................................................................................................done. 04:16:22 INFO - Installing pip.................done. 04:16:22 INFO - Return code: 0 04:16:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:22 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 0x7f02cb296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed100>, '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 0x22ee000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ee490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', '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:22 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:22 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:22 INFO - Using env: {'DISPLAY': ':0', 04:16:22 INFO - 'HOME': '/home/cltbld', 04:16:22 INFO - 'LANG': 'en_US.UTF-8', 04:16:22 INFO - 'LANGUAGE': 'en_US:en', 04:16:22 INFO - 'LOGNAME': 'cltbld', 04:16:22 INFO - 'MAIL': '/var/mail/cltbld', 04:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:22 INFO - 'MOZ_NO_REMOTE': '1', 04:16:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:22 INFO - 'NO_EM_RESTART': '1', 04:16:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:22 INFO - 'PWD': '/builds/slave/test', 04:16:22 INFO - 'SHELL': '/bin/bash', 04:16:22 INFO - 'SHLVL': '1', 04:16:22 INFO - 'TERM': 'linux', 04:16:22 INFO - 'TMOUT': '86400', 04:16:22 INFO - 'USER': 'cltbld', 04:16:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', 04:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:22 INFO - '_': '/tools/buildbot/bin/python'} 04:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:22 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:22 INFO - Cleaning up... 04:16:22 INFO - Return code: 0 04:16:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:22 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 0x7f02cb296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed100>, '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 0x22ee000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ee490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', '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:22 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:22 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:22 INFO - Using env: {'DISPLAY': ':0', 04:16:22 INFO - 'HOME': '/home/cltbld', 04:16:22 INFO - 'LANG': 'en_US.UTF-8', 04:16:22 INFO - 'LANGUAGE': 'en_US:en', 04:16:22 INFO - 'LOGNAME': 'cltbld', 04:16:22 INFO - 'MAIL': '/var/mail/cltbld', 04:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:22 INFO - 'MOZ_NO_REMOTE': '1', 04:16:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:22 INFO - 'NO_EM_RESTART': '1', 04:16:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:22 INFO - 'PWD': '/builds/slave/test', 04:16:22 INFO - 'SHELL': '/bin/bash', 04:16:22 INFO - 'SHLVL': '1', 04:16:22 INFO - 'TERM': 'linux', 04:16:22 INFO - 'TMOUT': '86400', 04:16:22 INFO - 'USER': 'cltbld', 04:16:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', 04:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:22 INFO - '_': '/tools/buildbot/bin/python'} 04:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:22 INFO - Downloading/unpacking psutil>=0.7.1 04:16:22 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:22 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:22 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:22 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:22 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:22 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:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:16:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:24 INFO - Installing collected packages: psutil 04:16:24 INFO - Running setup.py install for psutil 04:16:24 INFO - building 'psutil._psutil_linux' extension 04:16:24 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:24 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:24 INFO - building 'psutil._psutil_posix' extension 04:16:24 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:24 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:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:24 INFO - Successfully installed psutil 04:16:24 INFO - Cleaning up... 04:16:24 INFO - Return code: 0 04:16:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:16:24 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:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:24 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:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:24 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 0x7f02cb296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed100>, '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 0x22ee000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ee490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', '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:24 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:24 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:24 INFO - Using env: {'DISPLAY': ':0', 04:16:24 INFO - 'HOME': '/home/cltbld', 04:16:24 INFO - 'LANG': 'en_US.UTF-8', 04:16:24 INFO - 'LANGUAGE': 'en_US:en', 04:16:24 INFO - 'LOGNAME': 'cltbld', 04:16:24 INFO - 'MAIL': '/var/mail/cltbld', 04:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:24 INFO - 'MOZ_NO_REMOTE': '1', 04:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:24 INFO - 'NO_EM_RESTART': '1', 04:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:24 INFO - 'PWD': '/builds/slave/test', 04:16:24 INFO - 'SHELL': '/bin/bash', 04:16:24 INFO - 'SHLVL': '1', 04:16:24 INFO - 'TERM': 'linux', 04:16:24 INFO - 'TMOUT': '86400', 04:16:24 INFO - 'USER': 'cltbld', 04:16:24 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', 04:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:24 INFO - '_': '/tools/buildbot/bin/python'} 04:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:16:27 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:27 INFO - Installing collected packages: mozsystemmonitor 04:16:27 INFO - Running setup.py install for mozsystemmonitor 04:16:27 INFO - Successfully installed mozsystemmonitor 04:16:27 INFO - Cleaning up... 04:16:27 INFO - Return code: 0 04:16:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:27 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 0x7f02cb296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed100>, '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 0x22ee000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ee490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', '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:27 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:27 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:27 INFO - Using env: {'DISPLAY': ':0', 04:16:27 INFO - 'HOME': '/home/cltbld', 04:16:27 INFO - 'LANG': 'en_US.UTF-8', 04:16:27 INFO - 'LANGUAGE': 'en_US:en', 04:16:27 INFO - 'LOGNAME': 'cltbld', 04:16:27 INFO - 'MAIL': '/var/mail/cltbld', 04:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:27 INFO - 'MOZ_NO_REMOTE': '1', 04:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:27 INFO - 'NO_EM_RESTART': '1', 04:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:27 INFO - 'PWD': '/builds/slave/test', 04:16:27 INFO - 'SHELL': '/bin/bash', 04:16:27 INFO - 'SHLVL': '1', 04:16:27 INFO - 'TERM': 'linux', 04:16:27 INFO - 'TMOUT': '86400', 04:16:27 INFO - 'USER': 'cltbld', 04:16:27 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', 04:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:27 INFO - '_': '/tools/buildbot/bin/python'} 04:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:27 INFO - Downloading/unpacking blobuploader==1.2.4 04:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:29 INFO - Downloading blobuploader-1.2.4.tar.gz 04:16:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:16:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:16:29 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:29 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:29 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:29 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:29 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:29 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:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:16:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:16:29 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:29 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:29 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:29 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:29 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:29 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:29 INFO - Downloading docopt-0.6.1.tar.gz 04:16:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:16:29 INFO - Installing collected packages: blobuploader, requests, docopt 04:16:29 INFO - Running setup.py install for blobuploader 04:16:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:16:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:16:30 INFO - Running setup.py install for requests 04:16:30 INFO - Running setup.py install for docopt 04:16:30 INFO - Successfully installed blobuploader requests docopt 04:16:30 INFO - Cleaning up... 04:16:30 INFO - Return code: 0 04:16:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:30 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 0x7f02cb296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed100>, '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 0x22ee000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ee490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', '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:30 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:30 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:30 INFO - Using env: {'DISPLAY': ':0', 04:16:30 INFO - 'HOME': '/home/cltbld', 04:16:30 INFO - 'LANG': 'en_US.UTF-8', 04:16:30 INFO - 'LANGUAGE': 'en_US:en', 04:16:30 INFO - 'LOGNAME': 'cltbld', 04:16:30 INFO - 'MAIL': '/var/mail/cltbld', 04:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:30 INFO - 'MOZ_NO_REMOTE': '1', 04:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:30 INFO - 'NO_EM_RESTART': '1', 04:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:30 INFO - 'PWD': '/builds/slave/test', 04:16:30 INFO - 'SHELL': '/bin/bash', 04:16:30 INFO - 'SHLVL': '1', 04:16:30 INFO - 'TERM': 'linux', 04:16:30 INFO - 'TMOUT': '86400', 04:16:30 INFO - 'USER': 'cltbld', 04:16:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', 04:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:30 INFO - '_': '/tools/buildbot/bin/python'} 04:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:30 INFO - Running setup.py (path:/tmp/pip-uPUzmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:30 INFO - Running setup.py (path:/tmp/pip-eMA7uP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:30 INFO - Running setup.py (path:/tmp/pip-xPzy30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:30 INFO - Running setup.py (path:/tmp/pip-gIo4sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:31 INFO - Running setup.py (path:/tmp/pip-x7ryfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:31 INFO - Running setup.py (path:/tmp/pip-NJbQ1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:31 INFO - Running setup.py (path:/tmp/pip-_BdUjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:31 INFO - Running setup.py (path:/tmp/pip-lv1X8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:31 INFO - Running setup.py (path:/tmp/pip-qU_r66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:31 INFO - Running setup.py (path:/tmp/pip-35NDCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:31 INFO - Running setup.py (path:/tmp/pip-WuOBdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:31 INFO - Running setup.py (path:/tmp/pip-G6_fsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:31 INFO - Running setup.py (path:/tmp/pip-v7pM8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:31 INFO - Running setup.py (path:/tmp/pip-1TIjsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:31 INFO - Running setup.py (path:/tmp/pip-o3T92O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:31 INFO - Running setup.py (path:/tmp/pip-Io1wrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:31 INFO - Running setup.py (path:/tmp/pip-hsMo2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:16:32 INFO - Running setup.py install for manifestparser 04:16:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:16:32 INFO - Running setup.py install for mozcrash 04:16:32 INFO - Running setup.py install for mozdebug 04:16:32 INFO - Running setup.py install for mozdevice 04:16:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:16:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:16:32 INFO - Running setup.py install for mozfile 04:16:32 INFO - Running setup.py install for mozhttpd 04:16:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:16:32 INFO - Running setup.py install for mozinfo 04:16:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:16:32 INFO - Running setup.py install for mozInstall 04:16:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:16:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:16:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:16:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:16:32 INFO - Running setup.py install for mozleak 04:16:32 INFO - Running setup.py install for mozlog 04:16:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:16:33 INFO - Running setup.py install for moznetwork 04:16:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:16:33 INFO - Running setup.py install for mozprocess 04:16:33 INFO - Running setup.py install for mozprofile 04:16:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:16:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:16:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:16:33 INFO - Running setup.py install for mozrunner 04:16:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:16:33 INFO - Running setup.py install for mozscreenshot 04:16:33 INFO - Running setup.py install for moztest 04:16:33 INFO - Running setup.py install for mozversion 04:16:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:16:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:16:33 INFO - Cleaning up... 04:16:33 INFO - Return code: 0 04:16:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:33 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:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:33 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:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:33 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 0x7f02cb296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed100>, '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 0x22ee000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ee490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', '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:33 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:33 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:33 INFO - Using env: {'DISPLAY': ':0', 04:16:33 INFO - 'HOME': '/home/cltbld', 04:16:33 INFO - 'LANG': 'en_US.UTF-8', 04:16:33 INFO - 'LANGUAGE': 'en_US:en', 04:16:33 INFO - 'LOGNAME': 'cltbld', 04:16:33 INFO - 'MAIL': '/var/mail/cltbld', 04:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:33 INFO - 'MOZ_NO_REMOTE': '1', 04:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:33 INFO - 'NO_EM_RESTART': '1', 04:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:33 INFO - 'PWD': '/builds/slave/test', 04:16:33 INFO - 'SHELL': '/bin/bash', 04:16:33 INFO - 'SHLVL': '1', 04:16:33 INFO - 'TERM': 'linux', 04:16:33 INFO - 'TMOUT': '86400', 04:16:33 INFO - 'USER': 'cltbld', 04:16:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', 04:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:33 INFO - '_': '/tools/buildbot/bin/python'} 04:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:34 INFO - Running setup.py (path:/tmp/pip-qwXbm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:34 INFO - Running setup.py (path:/tmp/pip-oTPnIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:34 INFO - Running setup.py (path:/tmp/pip-ic_XZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:34 INFO - Running setup.py (path:/tmp/pip-v5jIa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:34 INFO - Running setup.py (path:/tmp/pip-A42vl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:34 INFO - Running setup.py (path:/tmp/pip-XKj_xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:34 INFO - Running setup.py (path:/tmp/pip-Du3fDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:34 INFO - Running setup.py (path:/tmp/pip-jFOx9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:34 INFO - Running setup.py (path:/tmp/pip-xtztkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:34 INFO - Running setup.py (path:/tmp/pip-IQGd72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:34 INFO - Running setup.py (path:/tmp/pip-d2cfZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:34 INFO - Running setup.py (path:/tmp/pip-P2gQ_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:34 INFO - Running setup.py (path:/tmp/pip-t7Swcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:34 INFO - Running setup.py (path:/tmp/pip-w4Zxex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:35 INFO - Running setup.py (path:/tmp/pip-PZS5p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:35 INFO - Running setup.py (path:/tmp/pip-RRsds9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:35 INFO - Running setup.py (path:/tmp/pip-STday_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:35 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:35 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:35 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:35 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:35 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:35 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:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:16:35 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:35 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:35 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:35 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:35 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:35 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:37 INFO - Downloading blessings-1.6.tar.gz 04:16:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:16:37 INFO - Installing collected packages: blessings 04:16:37 INFO - Running setup.py install for blessings 04:16:37 INFO - Successfully installed blessings 04:16:37 INFO - Cleaning up... 04:16:37 INFO - Return code: 0 04:16:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:16:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:37 INFO - Reading from file tmpfile_stdout 04:16:37 INFO - Current package versions: 04:16:37 INFO - argparse == 1.2.1 04:16:37 INFO - blessings == 1.6 04:16:37 INFO - blobuploader == 1.2.4 04:16:37 INFO - docopt == 0.6.1 04:16:37 INFO - manifestparser == 1.1 04:16:37 INFO - mozInstall == 1.12 04:16:37 INFO - mozcrash == 0.16 04:16:37 INFO - mozdebug == 0.1 04:16:37 INFO - mozdevice == 0.48 04:16:37 INFO - mozfile == 1.2 04:16:37 INFO - mozhttpd == 0.7 04:16:37 INFO - mozinfo == 0.9 04:16:37 INFO - mozleak == 0.1 04:16:37 INFO - mozlog == 3.1 04:16:37 INFO - moznetwork == 0.27 04:16:37 INFO - mozprocess == 0.22 04:16:37 INFO - mozprofile == 0.28 04:16:37 INFO - mozrunner == 6.11 04:16:37 INFO - mozscreenshot == 0.1 04:16:37 INFO - mozsystemmonitor == 0.0 04:16:37 INFO - moztest == 0.7 04:16:37 INFO - mozversion == 1.4 04:16:37 INFO - psutil == 3.1.1 04:16:37 INFO - requests == 1.2.3 04:16:37 INFO - wsgiref == 0.1.2 04:16:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:37 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 0x7f02cb296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed100>, '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 0x22ee000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ee490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', '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:37 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:37 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:37 INFO - Using env: {'DISPLAY': ':0', 04:16:37 INFO - 'HOME': '/home/cltbld', 04:16:37 INFO - 'LANG': 'en_US.UTF-8', 04:16:37 INFO - 'LANGUAGE': 'en_US:en', 04:16:37 INFO - 'LOGNAME': 'cltbld', 04:16:37 INFO - 'MAIL': '/var/mail/cltbld', 04:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:37 INFO - 'MOZ_NO_REMOTE': '1', 04:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:37 INFO - 'NO_EM_RESTART': '1', 04:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:37 INFO - 'PWD': '/builds/slave/test', 04:16:37 INFO - 'SHELL': '/bin/bash', 04:16:37 INFO - 'SHLVL': '1', 04:16:37 INFO - 'TERM': 'linux', 04:16:37 INFO - 'TMOUT': '86400', 04:16:37 INFO - 'USER': 'cltbld', 04:16:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', 04:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:37 INFO - '_': '/tools/buildbot/bin/python'} 04:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:37 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:37 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:37 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:37 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:37 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:37 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:37 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:37 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:37 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:37 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:37 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:37 INFO - Cleaning up... 04:16:37 INFO - Return code: 0 04:16:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:37 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 0x7f02cb296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed100>, '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 0x22ee000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ee490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', '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:37 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:37 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:37 INFO - Using env: {'DISPLAY': ':0', 04:16:37 INFO - 'HOME': '/home/cltbld', 04:16:37 INFO - 'LANG': 'en_US.UTF-8', 04:16:37 INFO - 'LANGUAGE': 'en_US:en', 04:16:37 INFO - 'LOGNAME': 'cltbld', 04:16:37 INFO - 'MAIL': '/var/mail/cltbld', 04:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:37 INFO - 'MOZ_NO_REMOTE': '1', 04:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:37 INFO - 'NO_EM_RESTART': '1', 04:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:37 INFO - 'PWD': '/builds/slave/test', 04:16:37 INFO - 'SHELL': '/bin/bash', 04:16:37 INFO - 'SHLVL': '1', 04:16:37 INFO - 'TERM': 'linux', 04:16:37 INFO - 'TMOUT': '86400', 04:16:37 INFO - 'USER': 'cltbld', 04:16:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', 04:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:37 INFO - '_': '/tools/buildbot/bin/python'} 04:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:37 INFO - Downloading/unpacking jsonschema 04:16:37 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:37 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:37 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:37 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:37 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:37 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 jsonschema-2.5.1-py2.py3-none-any.whl 04:16:39 INFO - Downloading/unpacking functools32 (from jsonschema) 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 functools32-3.2.3-2.tar.gz 04:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:16:40 INFO - warning: no files found matching '*.txt' 04:16:40 INFO - no previously-included directories found matching 'build' 04:16:40 INFO - no previously-included directories found matching 'dist' 04:16:40 INFO - no previously-included directories found matching '.git*' 04:16:40 INFO - Installing collected packages: jsonschema, functools32 04:16:40 INFO - Running setup.py install for functools32 04:16:40 INFO - warning: no files found matching '*.txt' 04:16:40 INFO - no previously-included directories found matching 'build' 04:16:40 INFO - no previously-included directories found matching 'dist' 04:16:40 INFO - no previously-included directories found matching '.git*' 04:16:40 INFO - Successfully installed jsonschema functools32 04:16:40 INFO - Cleaning up... 04:16:40 INFO - Return code: 0 04:16:40 INFO - Installing flake8 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', '--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 0x7f02cb296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed100>, '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 0x22ee000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ee490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', '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', '--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:40 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: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': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', 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 - Downloading/unpacking flake8 04:16:40 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:40 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:40 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:40 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:40 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:40 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:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:16:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:16:42 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:42 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:42 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:42 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:42 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:42 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:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:16:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:16:42 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:42 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:42 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:42 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:42 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:42 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:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:16:42 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:42 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:42 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:42 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:42 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:42 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:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:16:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:16:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:16:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:16:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:16:42 INFO - no previously-included directories found matching 'docs/_build' 04:16:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:16:43 INFO - Running setup.py install for pep8 04:16:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:16:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:16:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:16:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:16:43 INFO - no previously-included directories found matching 'docs/_build' 04:16:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:16:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:16:43 INFO - Cleaning up... 04:16:43 INFO - Return code: 0 04:16:43 INFO - Running post-action listener: _resource_record_post_action 04:16:43 INFO - Running post-action listener: _start_resource_monitoring 04:16:43 INFO - Starting resource monitoring. 04:16:43 INFO - ##### 04:16:43 INFO - ##### Running install step. 04:16:43 INFO - ##### 04:16:43 INFO - Running pre-action listener: _resource_record_pre_action 04:16:43 INFO - Running main action method: install 04:16:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:43 INFO - Reading from file tmpfile_stdout 04:16:43 INFO - Detecting whether we're running mozinstall >=1.0... 04:16:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:16:43 INFO - Reading from file tmpfile_stdout 04:16:43 INFO - Output received: 04:16:43 INFO - Usage: mozinstall [options] installer 04:16:43 INFO - Options: 04:16:43 INFO - -h, --help show this help message and exit 04:16:43 INFO - -d DEST, --destination=DEST 04:16:43 INFO - Directory to install application into. [default: 04:16:43 INFO - "/builds/slave/test"] 04:16:43 INFO - --app=APP Application being installed. [default: firefox] 04:16:43 INFO - mkdir: /builds/slave/test/build/application 04:16:43 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:43 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:16:59 INFO - Reading from file tmpfile_stdout 04:16:59 INFO - Output received: 04:16:59 INFO - /builds/slave/test/build/application/firefox/firefox 04:16:59 INFO - Running post-action listener: _resource_record_post_action 04:16:59 INFO - ##### 04:16:59 INFO - ##### Running run-tests step. 04:16:59 INFO - ##### 04:16:59 INFO - Running pre-action listener: _resource_record_pre_action 04:16:59 INFO - Running main action method: run_tests 04:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:16:59 INFO - Python 2.7.3 04:16:59 INFO - Return code: 0 04:16:59 INFO - grabbing minidump binary from tooltool 04:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:59 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 0x22ed100>, '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 0x22ee000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ee490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:16:59 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:16:59 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:16:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:16:59 INFO - Return code: 0 04:16:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:16:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:16:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:16:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:16:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:17:00 INFO - Return code: 0 04:17:00 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', '--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-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:17:00 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 --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-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:17:00 INFO - Using env: {'DISPLAY': ':0', 04:17:00 INFO - 'HOME': '/home/cltbld', 04:17:00 INFO - 'LANG': 'en_US.UTF-8', 04:17:00 INFO - 'LANGUAGE': 'en_US:en', 04:17:00 INFO - 'LOGNAME': 'cltbld', 04:17:00 INFO - 'MAIL': '/var/mail/cltbld', 04:17:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:17:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:00 INFO - 'MOZ_NO_REMOTE': '1', 04:17:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:00 INFO - 'NO_EM_RESTART': '1', 04:17:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:00 INFO - 'PWD': '/builds/slave/test', 04:17:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:17:00 INFO - 'SHELL': '/bin/bash', 04:17:00 INFO - 'SHLVL': '1', 04:17:00 INFO - 'TERM': 'linux', 04:17:00 INFO - 'TMOUT': '86400', 04:17:00 INFO - 'USER': 'cltbld', 04:17:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432', 04:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:00 INFO - '_': '/tools/buildbot/bin/python'} 04:17:00 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', '--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-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:17:00 INFO - mozversion application_buildid: 20160301025941 04:17:00 INFO - mozversion application_changeset: 8ef94be995a453f5c464278c53478ba8c8554f81 04:17:00 INFO - mozversion application_display_name: Nightly 04:17:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:17:00 INFO - mozversion application_name: Firefox 04:17:00 INFO - mozversion application_remotingname: firefox 04:17:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:17:00 INFO - mozversion application_vendor: Mozilla 04:17:00 INFO - mozversion application_version: 47.0a1 04:17:00 INFO - mozversion platform_buildid: 20160301025941 04:17:00 INFO - mozversion platform_changeset: 8ef94be995a453f5c464278c53478ba8c8554f81 04:17:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:17:00 INFO - mozversion platform_version: 47.0a1 04:17:00 INFO - using testdate: 1456834620 04:17:00 INFO - actual date: 1456834620 04:17:00 INFO - starting webserver on 'localhost:56915' 04:17:00 INFO - SUITE-START | Running 2 tests 04:17:00 INFO - TEST-START | dromaeo_css 04:17:00 INFO - operating with platform_type : linux_ 04:17:00 INFO - Initialising browser for dromaeo_css test... 04:17:00 INFO - TEST-INFO | started process 24375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2GDJAu/profile http://localhost:56915/getInfo.html) 04:17:04 INFO - PROCESS | 24375 | __metrics Screen width/height:1600/1200 04:17:04 INFO - PROCESS | 24375 | colorDepth:24 04:17:04 INFO - PROCESS | 24375 | Browser inner width/height: 1024/697 04:17:04 INFO - PROCESS | 24375 | __metrics 04:17:05 INFO - PROCESS | 24375 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:17:05 INFO - PROCESS | 24375 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:17:05 INFO - PROCESS | 24375 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:17:05 INFO - PROCESS | 24375 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:17:05 INFO - PROCESS | 24375 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:17:05 INFO - PROCESS | 24375 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:17:05 INFO - PROCESS | 24375 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:17:05 INFO - PROCESS | 24375 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:17:06 INFO - TEST-INFO | 24375: exit 0 04:17:06 INFO - Browser initialized. 04:17:06 INFO - Running cycle 1/1 for dromaeo_css test... 04:17:06 INFO - TEST-INFO | started process 24472 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2GDJAu/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 | 24472 | RSS: Main: 153452544 04:17:18 INFO - PROCESS | 24472 | 04:18:09 INFO - PROCESS | 24472 | 1456834689625 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:20 INFO - PROCESS | 24472 | Cycle 1(1): loaded http://localhost:56915/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56915/tests/dromaeo/cssquery-ext.html) 04:20:21 INFO - PROCESS | 24472 | RSS: Main: 237113344 04:20:21 INFO - PROCESS | 24472 | 04:23:23 INFO - PROCESS | 24472 | Cycle 1(1): loaded http://localhost:56915/tests/dromaeo/cssquery-ext.html (next: http://localhost:56915/tests/dromaeo/cssquery-jquery.html) 04:23:24 INFO - PROCESS | 24472 | RSS: Main: 238313472 04:23:24 INFO - PROCESS | 24472 | 04:26:26 INFO - PROCESS | 24472 | Cycle 1(1): loaded http://localhost:56915/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56915/tests/dromaeo/cssquery-mootools.html) 04:26:26 INFO - PROCESS | 24472 | RSS: Main: 236396544 04:26:26 INFO - PROCESS | 24472 | 04:29:28 INFO - PROCESS | 24472 | Cycle 1(1): loaded http://localhost:56915/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56915/tests/dromaeo/cssquery-prototype.html) 04:29:29 INFO - PROCESS | 24472 | RSS: Main: 222212096 04:29:29 INFO - PROCESS | 24472 | 04:32:32 INFO - PROCESS | 24472 | Cycle 1(1): loaded http://localhost:56915/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56915/tests/dromaeo/cssquery-yui.html) 04:32:32 INFO - PROCESS | 24472 | RSS: Main: 197488640 04:32:32 INFO - PROCESS | 24472 | 04:35:35 INFO - PROCESS | 24472 | Cycle 1(1): loaded http://localhost:56915/tests/dromaeo/cssquery-yui.html (next: http://localhost:56915/tests/dromaeo/cssquery-dojo.html) 04:35:35 INFO - PROCESS | 24472 | RSS: Main: 266842112 04:35:35 INFO - PROCESS | 24472 | 04:35:35 INFO - PROCESS | 24472 | __start_tp_report 04:35:35 INFO - PROCESS | 24472 | _x_x_mozilla_page_load 04:35:35 INFO - PROCESS | 24472 | _x_x_mozilla_page_load_details 04:35:35 INFO - PROCESS | 24472 | |i|pagename|runs| 04:35:35 INFO - PROCESS | 24472 | |0;dojo.html;2588.585826267797;2662.188032650041;2681.503921774471;2686.90595829146;2707.4585082983394;4385.386045953569;4465.709728867621;4534.705244159131;4557.635389168862;4578.359029735835;4435.667324950634;4508.278675411935;4522.547745225484;4549.363089167519;4614.861554153373;4146.150039241963;4167.3332266837315;4169.270377683908;4187.602177793105;4289.849855255066;4256.659467242614;4266.082792199676;4295.484541854982;4322.308430651096;4369.847055353063;3990.0024993751417;4112.876613701594;4144.8134833932545;4190.47619047616;4192.392103145057;4130.463039804837;4150.979245103786;4157.147784704129;4193.035601811601;4201.663866890642;4010.598940105995;4134.545200027995;4137.172565486884;4150.91698166035;4177.895552611179;4372.584604462571;4419.756913369763;4460.219461594208;4466.263066594008;4492.595666390041;4713.104510143096;4729.075775398705;4730.124926888537;4732.266498692674;4770.952290477086;4660.277656963176;4751.14479393709;4807.326974223576;4811.350467686852;4831.130396528623;4550.408446901882;4551.45382554089;4572.199865023641;4588.01357708091;4596.4714057883775;4962.851114466572;4988.775505102279;4993.825216117491;4995.875103122451;5041.823536176216;4590.586847183769;4732.6687131900435;4784.40194975628;4804;4811.975940120347;4833.564979151894;4848.345473361122;4855.8057677693205;4888.486708895514;4895.241237608177;4811.109944660249;4813.205821039559;4815.807367705323;4819.638527110481;4860.343853579721;4639.118567472169;4775.689580177277;4800.399950006249;4812.687175333592;4826.541478559531;3742.8502859885843;3753.155540003477;3756.8309426075893;3780.1305699689224;3792.6965842732516;3379.831008449617;3389.864405423755;3404.965950340465;3406.8466918988706;3420.675035871588;4013.4983127109113;4097.221527909687;4187.20443115807;4189.979050104791;4208.558101399371;4834.854954351375;4835.879103022453;4838.03239352131;4864.80540778372;4879.487653796371;4193.098483825931;4202.663786897041;4205.894852628709;4224.725392849455;4244.787760611957;4190.580941905785;4264.530901600821;4312.741235525878;4328.242557552416;4351.825926962886;4585.174668559691;4588.767421841174;4604.907901841944;4627.236505976476;4635.374224479652;4808.182608956416;4808.879778005438;4812.807487700453;4818.084563932842;4861.295112208639;4539.114872599944;4592.954070459253;4638.652101092499;4708.623310135249;4721.102990431807;4787.257975013878;4794.880127996688;4803.519648035308;4804.543568361;4828.179209534317;4830.29960655696;4870.975645121894;4872.805087796449;4879.048585525788;4919.2129259318335;4566.406367172246;4599.356090147449;4648;4659.324397962344;4685.648576356855;4651.418572678415;4654.48800631937;4655.3249778782565;4665.136949664187;4706.505816889177;4469;4575.199340115533;4586.633069354377;4593.196190666687;4634.606058485067;4734.55021772931;4783.402074740658;4790.305405716082;4813.975930120327;4827.662063655511;4611.031683346535;4642.466116396523;4643.791029403753;4648.070385922897;4687.1328804171335 04:35:35 INFO - PROCESS | 24472 | |1;ext.html;478.6912441475251;492.6108374384237;495.0593871643876;504.07250658787825;518.5177784660266;24733.38166545837;33180.17049573762;33732.831335843344;33796.15509612255;33894.49158262628;37203.4419483708;37731;37780.43329350062;37793;37855.24289514208;6784.491163162783;7624.27569380908;7833.373330133576;9489.857652135224;9653.565589548487;9762.463064531448;9898.802023959517;9900.405975641448;9904.603815847357;9908.504574771268;9862.112409883144;9972.451515166664;9977.600895964153;9981.650642227523;9984.40093594383;9802.313838031341;9937.155341795957;9943;9944.900550994469;9945.850812237823;10005.149562287213;10156.085952264259;10176;10187.7453063674;10198.745031374201;36220.74799154108;36557.45163822518;36640.45039324412;36764.44853327202;36774;2911.737943585066;3058.8776448942017;3185.984070079658;3197.1847178969447;3294.7199488043543;28048.859755701294;28130.437391252264;28319.57520637192;28515.42969140626;28624.427511449656;2848.2167403963867;2906.6657334406605;2922.8830846766105;2930.868110935013;2953.1140657802575;213217;214308.92845535828;215833;215973;216097;37959.24081518354;53239.46760532423;53808.46191538034;53831.730841346325;53849.1922621161;36731.81634091812;36858.26283474315;36899.26201476009;36939.63060369415;36954.44568331477;10484.213683973732;11770.17608767378;11827;11958;11988.460519276654;9071.365004449624;9136.812214412217;9149.77125571866;9152.084791520794;9160;13011.739765204642;13024.934875325753;13034.615116891839;13392.799108013387;13442.193468391928;5437.401885792559;5526.696031718294;5557.194206839986;5604.8318550443555;5651.321841379061;872.445996792029;951.0740749981205;956.4404823178379;1013.2147585621055;1018.7045756730465;25364.873175634373;26050;26594.86702566475;26688.466230675276;26885.865570672413;954.8329042417688;989.3816364772017;1007.8941711120227;1026.2713473433796;1038.5118994072773;13611;13731.931340343235;13792.862071379157;13950.860491395159;14055.578332650037;253694;258806;259128;259144;259269;43583;45121.54878451173;45140.3228951566;45146.77426612846;45217.54782452199;1042.718466014187;1069.1072954083427;1069.5989004123453;1201.7296108375544;1213.1629175868622;19531.414057578295;27004.04656042348;27462.17613471599;27608.861955690092;27649.308767280174;43376.132477350904;43896;43914;43919.56080439282;43932.560674392844;237671;237887;239046;239774;240203;28675.56986645244;29427;29592.112236632936;29662;29685.85157074201;38185;38486.2302753949;39016.80491597524;39161.60838391694;39197.6080239194;32828.1792955178;32876.835615821765;33311.66688333086;33368.16579585433;33433.83283083666;33645.49531757075;33892;34040;34194.658053419145;34371.828140859136;33361.666383335854;33581;33889.66110338865;33927.32145357128;36017.63982360143;26204.344891377106;27635.447291053664;28699.713002869703;28705.28236794097;28947.85526072356;21691.566168676854;22028.422492220532;23724.28827135189;23728.169514066925;23886 04:35:35 INFO - PROCESS | 24472 | |2;jquery.html;332.63244115252644;341.1828670334549;341.48947323750997;342.1395191094397;346.06562281839024;13836.654083647902;14716.117032978029;15209.163496007715;15269.847301527008;15290.388384464608;13825.585232443018;14023.228722420288;14250.92874535626;14480.855191448083;14500.347484363203;5032.295478632995;5188.7146206958605;5191.480851914797;5199.168133098705;5203.765830537616;4829.613630909519;5015.473375295578;5055.46917573655;5122.206058060988;5133.358330208724;5004.924926126111;5029.245613158019;5030.647854650176;5032.194848824189;5059.139946209153;4995.250712393134;5019.949800502003;5021.372328458942;5029.094762942669;5099.23511473282;4873.31773551703;4951.777170027357;4982.17794063979;4983.92524112135;5008.649394542384;11349.262297950607;11551.768964620745;12538.561150359694;18581;18586.721199182022;1807.3403207829178;1836.2012524551862;1839.1723724323974;1894.1571000904603;1920.4814700031054;8376.790580235482;8587.270082043035;8801.735947921572;11743.236689615147;12295.262284262973;1683.4444633270991;1758.630687555615;1763.3387479695114;1763.7442570827159;1800.5768644368563;52089.21866172011;54482;54764;55493.9999999996;55501;9130.771730706785;9495.620175192915;9628.855567166498;9657;9728.416295022322;12068.758624827455;12075.698107547207;12136.817947730791;12164.209326393757;12178.695532611579;6434.7747828826705;6467.547271690936;6544.803655890331;6551.901721474182;6644.96677516619;5996.4603185713495;6058.757649694051;6139.539534534839;6147.01647736369;6242.469390101802;4142.378643203544;4215.093754842724;4252.128313695747;4312.956870431318;4316.6330861877095;1673.71546837038;1701.2769572931454;1709.666615010086;1723.6638855423073;1733.6446028564114;792.825578372757;847.4491580472619;876.7106854737921;886.4238245140581;921.1525396635112;14641.34113964874;14662.266886655838;15259.313330900137;15364.769528457082;15624.296906639001;848.2154007543121;854.692310768123;858.3219256787193;872.1017352127319;919.5172534419484;8609.354298427517;8683.522406267715;8690.913090869137;8726.345524085718;8907.955460222787;309185;353798;354856;355194;356009;59935.400645993854;61060;61672.38327616666;61939.380606193365;63768.68115659392;921.5069937583361;926.1664501948301;938.3009657804979;940.0505489455699;942.2038377570941;13504.797428038391;13561;13611.863881361456;13630.591082267549;13716.862831371958;29672;29830.55254171146;30535.08394748161;30717.23206919845;31686.049418517483;41252.793736031126;41430;41722.37416438695;41852.3722144162;42487.15025699531;6567.44176744982;6682.23154337238;6707.5304728668525;7034.120734908137;7038.542494737826;9642.951785241028;9925.404475731479;10288.537015834456;10489.79020419572;10678.946605266923;9223.21602663781;9408.670696525589;9411.10594493522;9443.480608566595;9758.658446954323;8331.416800823885;8920.286377089948;9015.14356136166;9139.862902056608;9318.254539636948;5288.762005709829;5806.419358064329;8863.335249856416;9596.328257021942;10308.793824123326;6929.411000064849;6988.390734426197;7088.929110709033;7150.463715221484;7189.5686258824635;7269.963650181715;9455.527223638654;9608.567614457226;9821.85267220978;9853.901460985298 04:35:35 INFO - PROCESS | 24472 | |3;mootools.html;1236.1408820869487;1354.5868510104417;1374.1342953939018;1488.7692407676814;1723.284836792731;5892.234009578754;6023.909641355383;6909.758158464455;7106.751263705772;7110.1112360954885;7107.538010029344;7119.074520312352;7167.426605871531;7177.784666460015;7200.711971521133;1493.60419488835;2023.6964455331745;2044.3458093410115;2079.875207487548;2082.979170208301;2000.1999200319842;2009.8090681385245;2010.497375656086;2011.1251605551631;2012.30575451469;2020.070767446976;2056.0233888902803;2057.372501387076;2057.825084867788;2061.9690704639443;2014.6575082235981;2019.4143698327468;2022.5853699991467;2024.9291274805385;2025.1696804310236;2054.0346037362415;2067.379786064175;2071.5753270579494;2072.9067191976396;2073.0463986566197;7262.818429539251;7327.413806895435;7339.486235963484;7340.632968351614;7346.926530734678;4124.154548317588;4211.978940105279;4222.408862759216;4224.366345048236;4225.492940847087;2586.44391455836;2639.722829102955;2691.3540750220004;2693.46130773846;2720.102366219163;790.7785819970418;800.8118092248317;815.9224873636995;851.8594431918788;852.071242345846;9648.855267170999;9792.314537982415;9895.851562226573;9911.454869982148;9916.702498925044;3767.7362584618813;3912.921741565153;3983.960160398417;3983.960160398417;3992.0818211811447;8588.699395521251;8613.353998450142;8640.179182977607;8660.26387757035;8665.826683466295;4328.567143285646;4338.154059958278;4367.62875155609;4377.737335759864;4389.188000219906;3087.243625311813;3647;3751.6811071059265;3761.586225515191;3767.811609419518;3301.3067255876535;3342.983285083559;3357.932841343208;3373.8144402058124;3381.9492707609406;1068.8610480637624;1077.0575746222055;1086.750047489082;1089.4389389464432;1105.171121658756;947.209080417845;1046.7749433871754;1171.3381939204323;1173.2608456672242;1179.4692388425242;6699.363560461748;6701.932980670131;6711.63086030273;6731.966340168267;6736;1080.3571874734678;1122.203235702644;1125.4468833010558;1127.7406196574834;1146.3236690352733;5315.069862773999;5347.679139251657;5398.541124004425;5404.3784964728775;5407.540359069444;8154.062282837431;8328.417010809306;8332.750017499484;8340.124286949784;8469.74590762278;8167.877481837777;8197.303229225463;8206.097329293772;8227.670893164206;8237.546934918637;6678.799636010927;6728.259891411941;6844.863102737917;6907.896381554281;6931.757388491278;6644.069830223869;6669.1330127083165;6712.160979877515;6713.395794378529;6746.190457145174;7328.890066648898;7443.218462061622;7482.625868706652;7596.8480630388185;7630.8855367170645;7513;7737;7751.883721744066;7753.4960227585025;7825.843483130192;5140.151874940593;5946.1972633693895;5983.581149319506;6294.6852657366035;6344.270408903035;6606.9008964866525;6644.335566443317;6684.131062961784;6697.564658297195;6711.731530738716;5992.161097446274;6108.51131909455;6145.262568491809;6157.599756015845;6275.246970363585;5923.614965027259;6008.519318454426;6076.635401875901;6103.786367477117;6161.44546990755;6409.391107844747;6480.7731729391135;6489.415952564292;6492.448141907802;6493.350664933469;5851.678157701367;5957.017092179742;5962;5962.940370596239;5987.550933680079;5972.313183983897;5976.760929562769;6014.699265036643;6015.608985416109;6026.246719160105 04:35:35 INFO - PROCESS | 24472 | |4;prototype.html;280.7108678061596;283.98722057507416;284.8411120671751;288.9956650650242;296.2445763303576;5337.546308563772;5354.544863686591;5354.946450535498;5360.437154098822;5364.758585863631;5129.717865517395;5284.339457567804;5291.708956007427;5295.0733621616255;5297.973510132453;3790.8862734117884;3851.017990412441;3858.59484754101;3994.920101597966;4031.5766844481345;3868.2263547290513;3901.122247494305;3933.193695292458;4061.208064427438;4071.9389209161886;4013.5384430790396;4017.7790221537803;4024.416459613354;4026.758394496325;4039.4546736190678;4004.7396919200305;4017.819198136091;4024.3561030235314;4027.335489644205;4028.1339512004765;3276.443004689185;3356.6475520070285;3424.503447000196;3429.331280400323;3436.8453419595926;5121.4110377306715;5124.4106927703415;5136.203888397305;5140.897182056376;5159.045576568347;4638.1883170445035;4645.837395691135;4648.837290694843;4649.209634362167;4652.232381657022;5599.776008959637;5611.579131565108;5612.831615051555;5613;5614.326280846284;3799.7530160539477;3801.885943421702;3802.2205447883116;3803.6766874815676;3806.9809650951843;5702.144678298247;5805.3323867755325;5882.705864706748;5890.410958904118;5890.528757699374;3856.633619806114;3873.32216862048;3887.6501114899793;3887.9805600971813;3894.4547763313158;3956.624120708528;3958.980205098956;3960.0693836948294;3960.683145348365;3962.890390690611;4596.632269418438;4601.562851529099;4606.078784243165;4614.123316569841;4621.09888571732;5634.492895639412;5636.549076073904;5638.590352411897;5640.520555752807;5643.435656434323;1365.7473367427058;1375.5804479633807;1375.848656647768;1376.0092733232057;1376.504458394977;894.3784070071368;902;927.3925578745932;940.5908429833045;944.7921457279388;4774.570288674036;4915.139850526144;4965.47862474435;4976.477469865685;5012.799488020439;5900.144479050599;5913.113033045078;5913.733881975321;5918.437748413894;5919.112133179971;5024.070546948826;5025.522575355335;5027.145385284511;5031.371078615173;5033.295338652591;3131.498960166408;3171.365726854592;3173.698498642625;3174.2857856981996;3175.3966746318124;5544.168374743821;5603.551715862721;5611.046122159243;5611.270534830527;5614.494695477427;5861.70691465425;6055.2430946131735;6057.757689692451;6065.4541091302;6078.787242446493;5586.636868603528;5606.467385598362;5606.55147588192;5611.607187496836;5615.466530679579;5884.9705751470965;5895.7052147393315;5896.351401345934;5897.5576831736935;5902.763889444546;5717.742701578522;5772.451617096369;5777.94222057774;5780.537556995514;5787.565932554991;5573.972130139324;5580.386157522588;5594.916076258941;5598.608097433141;5604.467575580314;3748;3858.6720128789366;3867.0332416895776;3879.224155169034;3903.6291552302487;5857;5869.4717475425705;5870.823875283749;5878.030125029322;5888.793892213752;5651.067573850269;5656.604037717485;5658.264425624642;5659.603827732019;5664.943350566442;5645.9153112702525;5645.971770141123;5665.065264231521;5673.801416950387;5676.886462270814;5559.694216817952;5565.30433695788;5565.860853478695;5570.910908409346;5571.470710282517;5460.15367618004;5716.828495145152;5801.680907550125;5807.825765226881;5809.157672137601;5538.91691624634;5580.748866300945;5581.972090139523;5582.385937546947;5586.636868603528 04:35:35 INFO - PROCESS | 24472 | |5;yui.html;615.8060211033521;655.5280198257253;706.5301574452989;727.4216997486998;733.3290039613754;10588.470576471183;10609.575616975331;10613.946930265347;10636.893631063696;10711.83932241016;11214.10287177026;11862.34757088362;12075.818862717066;12097.516099356037;12136.939315303433;606.3088079589272;748.7753673897836;762.7711686494057;775.4881778026504;780.5511830697343;771.3289438188756;777.7472321495509;780.2236774409471;780.7540624703229;782.1865260129458;818.7666515043214;821.3142026407927;821.363443331417;821.4496287487368;822.005373498068;630.265740412419;796.3271035974592;814.0394334685069;814.9225823546783;814.9388795840335;597.6175247841385;597.7579080472416;598.9341172471024;599.3107925885223;600.1957377114644;10838.512266948006;10871.891281087166;10899.073578745816;10991.175661825395;11007.449627518592;10576.471176441224;11028.172887033505;11216.719582010433;11319.434028298634;11408.71478213043;9175.541222938826;9326.393784403992;9385.10841470066;9482.762930926712;9550.95224523873;3206.422843888099;3215.8070515769127;3284.523744057098;3289.3256882339065;3317.4360358739073;39545.80227098875;39592.40611390831;39783.40324895129;39801.40297895534;39899.00252493682;8902.109789021175;9320.766980825534;9476.810463790824;9479.720446807316;9553.808923821623;16206.594835129215;16207.351705931631;16250.349986000663;16257.18714064292;16403.179841007903;6332.4934005279465;6366.649834259068;6420.486361091102;6492.253390860112;6592.76925307612;3612.151144481045;3631.4371272452813;3642.7996460194945;3684.373656478405;3701.574318953301;2489.962650560243;2539.7968162546954;2545.3382120648394;2545.923622291334;2557.0794513974956;427.9507856596469;475.5886158472896;485.9295402166666;492.37960170185823;494.88617617948074;455.5854172702891;517.3688100517363;563.937966823649;582.7115577789021;583.6498101139282;7727.961360193275;7893.802654933558;7967.362610991223;8002.500471319017;8047.155048719917;572.9627574207747;605.3613437823138;609.5093449772887;632.5572099530348;635.0976039499535;3300.455424854872;3428.63999280077;3611.9819400903352;3680.576733675608;3766.1902690921584;45313.773431132635;45793.31310030352;45956.08087838224;46219.53780462153;46336.7683161582;43374;43485.56514434879;43578;44227;44404;37175;39098.60901391006;39864;39878.80060599678;40004.59995400067;8119.79700507492;8147.714829980922;8200.138985406686;8289.917100829156;8321.625526851185;28748.281292967007;29614.259643509085;30334.241643959078;30576.694233057384;31320.21699457532;34549.481757774156;37886.242275154895;38440.6155938437;38537.80731096327;38703.03242418962;9100.99889012195;9176.95411522938;9196.58615362297;9199.724008279762;9218.769530761785;10320.174386049248;11012.17408694335;11166.274192177483;11222.438878055902;11230.494627741607;7781.455298129076;9906;10369.533370998473;10860.511276992713;10924.180686448708;9425.481598511873;9953.656256405582;10287.177025838064;10316.587336506456;10343.793124137324;9810.117089461983;9847.261455390731;10026.849597255901;10032.398056116657;10159.492025398553;8144.348452123934;8381.371397145116;8557.828843423222;8640.211824548116;8761.518116503654;8064;8127.390445716476;8251.793705157419;8411.873821892554;8423.157684231774 04:35:35 INFO - PROCESS | 24472 | __end_tp_report 04:35:35 INFO - PROCESS | 24472 | __start_cc_report 04:35:35 INFO - PROCESS | 24472 | _x_x_mozilla_cycle_collect,764 04:35:35 INFO - PROCESS | 24472 | __end_cc_report 04:35:35 INFO - PROCESS | 24472 | __startTimestamp1456835735550__endTimestamp 04:35:35 INFO - PROCESS | 24472 | 04:35:35 INFO - PROCESS | 24472 | ------- Summary: start ------- 04:35:35 INFO - PROCESS | 24472 | Number of tests: 6 04:35:35 INFO - PROCESS | 24472 | 04:35:35 INFO - PROCESS | 24472 | [#0] dojo.html Cycles:165 Average:4455.79 Median:4593.20 stddev:471.86 (10.3%) stddev-sans-first:450.00 04:35:35 INFO - PROCESS | 24472 | Values: 2588.6 2662.2 2681.5 2686.9 2707.5 4385.4 4465.7 4534.7 4557.6 4578.4 4435.7 4508.3 4522.5 4549.4 4614.9 4146.2 4167.3 4169.3 4187.6 4289.8 4256.7 4266.1 4295.5 4322.3 4369.8 3990.0 4112.9 4144.8 4190.5 4192.4 4130.5 4151.0 4157.1 4193.0 4201.7 4010.6 4134.5 4137.2 4150.9 4177.9 4372.6 4419.8 4460.2 4466.3 4492.6 4713.1 4729.1 4730.1 4732.3 4771.0 4660.3 4751.1 4807.3 4811.4 4831.1 4550.4 4551.5 4572.2 4588.0 4596.5 4962.9 4988.8 4993.8 4995.9 5041.8 4590.6 4732.7 4784.4 4804.0 4812.0 4833.6 4848.3 4855.8 4888.5 4895.2 4811.1 4813.2 4815.8 4819.6 4860.3 4639.1 4775.7 4800.4 4812.7 4826.5 3742.9 3753.2 3756.8 3780.1 3792.7 3379.8 3389.9 3405.0 3406.8 3420.7 4013.5 4097.2 4187.2 4190.0 4208.6 4834.9 4835.9 4838.0 4864.8 4879.5 4193.1 4202.7 4205.9 4224.7 4244.8 4190.6 4264.5 4312.7 4328.2 4351.8 4585.2 4588.8 4604.9 4627.2 4635.4 4808.2 4808.9 4812.8 4818.1 4861.3 4539.1 4593.0 4638.7 4708.6 4721.1 4787.3 4794.9 4803.5 4804.5 4828.2 4830.3 4871.0 4872.8 4879.0 4919.2 4566.4 4599.4 4648.0 4659.3 4685.6 4651.4 4654.5 4655.3 4665.1 4706.5 4469.0 4575.2 4586.6 4593.2 4634.6 4734.6 4783.4 4790.3 4814.0 4827.7 4611.0 4642.5 4643.8 4648.1 4687.1 04:35:35 INFO - PROCESS | 24472 | 04:35:35 INFO - PROCESS | 24472 | [#1] ext.html Cycles:180 Average:39067.06 Median:33364.92 stddev:61869.36 (185.4%) stddev-sans-first:61975.08 04:35:35 INFO - PROCESS | 24472 | Values: 478.7 492.6 495.1 504.1 518.5 24733.4 33180.2 33732.8 33796.2 33894.5 37203.4 37731.0 37780.4 37793.0 37855.2 6784.5 7624.3 7833.4 9489.9 9653.6 9762.5 9898.8 9900.4 9904.6 9908.5 9862.1 9972.5 9977.6 9981.7 9984.4 9802.3 9937.2 9943.0 9944.9 9945.9 10005.1 10156.1 10176.0 10187.7 10198.7 36220.7 36557.5 36640.5 36764.4 36774.0 2911.7 3058.9 3186.0 3197.2 3294.7 28048.9 28130.4 28319.6 28515.4 28624.4 2848.2 2906.7 2922.9 2930.9 2953.1 213217.0 214308.9 215833.0 215973.0 216097.0 37959.2 53239.5 53808.5 53831.7 53849.2 36731.8 36858.3 36899.3 36939.6 36954.4 10484.2 11770.2 11827.0 11958.0 11988.5 9071.4 9136.8 9149.8 9152.1 9160.0 13011.7 13024.9 13034.6 13392.8 13442.2 5437.4 5526.7 5557.2 5604.8 5651.3 872.4 951.1 956.4 1013.2 1018.7 25364.9 26050.0 26594.9 26688.5 26885.9 954.8 989.4 1007.9 1026.3 1038.5 13611.0 13731.9 13792.9 13950.9 14055.6 253694.0 258806.0 259128.0 259144.0 259269.0 43583.0 45121.5 45140.3 45146.8 45217.5 1042.7 1069.1 1069.6 1201.7 1213.2 19531.4 27004.0 27462.2 27608.9 27649.3 43376.1 43896.0 43914.0 43919.6 43932.6 237671.0 237887.0 239046.0 239774.0 240203.0 28675.6 29427.0 29592.1 29662.0 29685.9 38185.0 38486.2 39016.8 39161.6 39197.6 32828.2 32876.8 33311.7 33368.2 33433.8 33645.5 33892.0 34040.0 34194.7 34371.8 33361.7 33581.0 33889.7 33927.3 36017.6 26204.3 27635.4 28699.7 28705.3 28947.9 21691.6 22028.4 23724.3 23728.2 23886.0 04:35:35 INFO - PROCESS | 24472 | 04:35:35 INFO - PROCESS | 24472 | [#2] jquery.html Cycles:180 Average:21025.96 Median:5032.25 stddev:56846.00 (1129.6%) stddev-sans-first:56984.23 04:35:35 INFO - PROCESS | 24472 | Values: 332.6 341.2 341.5 342.1 346.1 13836.7 14716.1 15209.2 15269.8 15290.4 13825.6 14023.2 14250.9 14480.9 14500.3 5032.3 5188.7 5191.5 5199.2 5203.8 4829.6 5015.5 5055.5 5122.2 5133.4 5004.9 5029.2 5030.6 5032.2 5059.1 4995.3 5019.9 5021.4 5029.1 5099.2 4873.3 4951.8 4982.2 4983.9 5008.6 11349.3 11551.8 12538.6 18581.0 18586.7 1807.3 1836.2 1839.2 1894.2 1920.5 8376.8 8587.3 8801.7 11743.2 12295.3 1683.4 1758.6 1763.3 1763.7 1800.6 52089.2 54482.0 54764.0 55494.0 55501.0 9130.8 9495.6 9628.9 9657.0 9728.4 12068.8 12075.7 12136.8 12164.2 12178.7 6434.8 6467.5 6544.8 6551.9 6645.0 5996.5 6058.8 6139.5 6147.0 6242.5 4142.4 4215.1 4252.1 4313.0 4316.6 1673.7 1701.3 1709.7 1723.7 1733.6 792.8 847.4 876.7 886.4 921.2 14641.3 14662.3 15259.3 15364.8 15624.3 848.2 854.7 858.3 872.1 919.5 8609.4 8683.5 8690.9 8726.3 8908.0 309185.0 353798.0 354856.0 355194.0 356009.0 59935.4 61060.0 61672.4 61939.4 63768.7 921.5 926.2 938.3 940.1 942.2 13504.8 13561.0 13611.9 13630.6 13716.9 29672.0 29830.6 30535.1 30717.2 31686.0 41252.8 41430.0 41722.4 41852.4 42487.2 6567.4 6682.2 6707.5 7034.1 7038.5 9643.0 9925.4 10288.5 10489.8 10678.9 9223.2 9408.7 9411.1 9443.5 9758.7 8331.4 8920.3 9015.1 9139.9 9318.3 5288.8 5806.4 8863.3 9596.3 10308.8 6929.4 6988.4 7088.9 7150.5 7189.6 7270.0 9455.5 9608.6 9821.9 9853.9 04:35:35 INFO - PROCESS | 24472 | 04:35:35 INFO - PROCESS | 24472 | [#3] mootools.html Cycles:180 Average:4941.55 Median:5989.86 stddev:2570.96 (42.9%) stddev-sans-first:2563.08 04:35:35 INFO - PROCESS | 24472 | Values: 1236.1 1354.6 1374.1 1488.8 1723.3 5892.2 6023.9 6909.8 7106.8 7110.1 7107.5 7119.1 7167.4 7177.8 7200.7 1493.6 2023.7 2044.3 2079.9 2083.0 2000.2 2009.8 2010.5 2011.1 2012.3 2020.1 2056.0 2057.4 2057.8 2062.0 2014.7 2019.4 2022.6 2024.9 2025.2 2054.0 2067.4 2071.6 2072.9 2073.0 7262.8 7327.4 7339.5 7340.6 7346.9 4124.2 4212.0 4222.4 4224.4 4225.5 2586.4 2639.7 2691.4 2693.5 2720.1 790.8 800.8 815.9 851.9 852.1 9648.9 9792.3 9895.9 9911.5 9916.7 3767.7 3912.9 3984.0 3984.0 3992.1 8588.7 8613.4 8640.2 8660.3 8665.8 4328.6 4338.2 4367.6 4377.7 4389.2 3087.2 3647.0 3751.7 3761.6 3767.8 3301.3 3343.0 3357.9 3373.8 3381.9 1068.9 1077.1 1086.8 1089.4 1105.2 947.2 1046.8 1171.3 1173.3 1179.5 6699.4 6701.9 6711.6 6732.0 6736.0 1080.4 1122.2 1125.4 1127.7 1146.3 5315.1 5347.7 5398.5 5404.4 5407.5 8154.1 8328.4 8332.8 8340.1 8469.7 8167.9 8197.3 8206.1 8227.7 8237.5 6678.8 6728.3 6844.9 6907.9 6931.8 6644.1 6669.1 6712.2 6713.4 6746.2 7328.9 7443.2 7482.6 7596.8 7630.9 7513.0 7737.0 7751.9 7753.5 7825.8 5140.2 5946.2 5983.6 6294.7 6344.3 6606.9 6644.3 6684.1 6697.6 6711.7 5992.2 6108.5 6145.3 6157.6 6275.2 5923.6 6008.5 6076.6 6103.8 6161.4 6409.4 6480.8 6489.4 6492.4 6493.4 5851.7 5957.0 5962.0 5962.9 5987.6 5972.3 5976.8 6014.7 6015.6 6026.2 04:35:35 INFO - PROCESS | 24472 | 04:35:35 INFO - PROCESS | 24472 | [#4] prototype.html Cycles:180 Average:4639.85 Median:5346.05 stddev:1415.66 (26.5%) stddev-sans-first:1381.31 04:35:35 INFO - PROCESS | 24472 | Values: 280.7 284.0 284.8 289.0 296.2 5337.5 5354.5 5354.9 5360.4 5364.8 5129.7 5284.3 5291.7 5295.1 5298.0 3790.9 3851.0 3858.6 3994.9 4031.6 3868.2 3901.1 3933.2 4061.2 4071.9 4013.5 4017.8 4024.4 4026.8 4039.5 4004.7 4017.8 4024.4 4027.3 4028.1 3276.4 3356.6 3424.5 3429.3 3436.8 5121.4 5124.4 5136.2 5140.9 5159.0 4638.2 4645.8 4648.8 4649.2 4652.2 5599.8 5611.6 5612.8 5613.0 5614.3 3799.8 3801.9 3802.2 3803.7 3807.0 5702.1 5805.3 5882.7 5890.4 5890.5 3856.6 3873.3 3887.7 3888.0 3894.5 3956.6 3959.0 3960.1 3960.7 3962.9 4596.6 4601.6 4606.1 4614.1 4621.1 5634.5 5636.5 5638.6 5640.5 5643.4 1365.7 1375.6 1375.8 1376.0 1376.5 894.4 902.0 927.4 940.6 944.8 4774.6 4915.1 4965.5 4976.5 5012.8 5900.1 5913.1 5913.7 5918.4 5919.1 5024.1 5025.5 5027.1 5031.4 5033.3 3131.5 3171.4 3173.7 3174.3 3175.4 5544.2 5603.6 5611.0 5611.3 5614.5 5861.7 6055.2 6057.8 6065.5 6078.8 5586.6 5606.5 5606.6 5611.6 5615.5 5885.0 5895.7 5896.4 5897.6 5902.8 5717.7 5772.5 5777.9 5780.5 5787.6 5574.0 5580.4 5594.9 5598.6 5604.5 3748.0 3858.7 3867.0 3879.2 3903.6 5857.0 5869.5 5870.8 5878.0 5888.8 5651.1 5656.6 5658.3 5659.6 5664.9 5645.9 5646.0 5665.1 5673.8 5676.9 5559.7 5565.3 5565.9 5570.9 5571.5 5460.2 5716.8 5801.7 5807.8 5809.2 5538.9 5580.7 5582.0 5582.4 5586.6 04:35:35 INFO - PROCESS | 24472 | 04:35:35 INFO - PROCESS | 24472 | [#5] yui.html Cycles:180 Average:11791.46 Median:23406.18 stddev:13233.02 (56.5%) stddev-sans-first:13243.52 04:35:35 INFO - PROCESS | 24472 | Values: 615.8 655.5 706.5 727.4 733.3 10588.5 10609.6 10613.9 10636.9 10711.8 11214.1 11862.3 12075.8 12097.5 12136.9 606.3 748.8 762.8 775.5 780.6 771.3 777.7 780.2 780.8 782.2 818.8 821.3 821.4 821.4 822.0 630.3 796.3 814.0 814.9 814.9 597.6 597.8 598.9 599.3 600.2 10838.5 10871.9 10899.1 10991.2 11007.4 10576.5 11028.2 11216.7 11319.4 11408.7 9175.5 9326.4 9385.1 9482.8 9551.0 3206.4 3215.8 3284.5 3289.3 3317.4 39545.8 39592.4 39783.4 39801.4 39899.0 8902.1 9320.8 9476.8 9479.7 9553.8 16206.6 16207.4 16250.3 16257.2 16403.2 6332.5 6366.6 6420.5 6492.3 6592.8 3612.2 3631.4 3642.8 3684.4 3701.6 2490.0 2539.8 2545.3 2545.9 2557.1 428.0 475.6 485.9 492.4 494.9 455.6 517.4 563.9 582.7 583.6 7728.0 7893.8 7967.4 8002.5 8047.2 573.0 605.4 609.5 632.6 635.1 3300.5 3428.6 3612.0 3680.6 3766.2 45313.8 45793.3 45956.1 46219.5 46336.8 43374.0 43485.6 43578.0 44227.0 44404.0 37175.0 39098.6 39864.0 39878.8 40004.6 8119.8 8147.7 8200.1 8289.9 8321.6 28748.3 29614.3 30334.2 30576.7 31320.2 34549.5 37886.2 38440.6 38537.8 38703.0 9101.0 9177.0 9196.6 9199.7 9218.8 10320.2 11012.2 11166.3 11222.4 11230.5 7781.5 9906.0 10369.5 10860.5 10924.2 9425.5 9953.7 10287.2 10316.6 10343.8 9810.1 9847.3 10026.8 10032.4 10159.5 8144.3 8381.4 8557.8 8640.2 8761.5 8064.0 8127.4 8251.8 8411.9 8423.2 04:35:35 INFO - PROCESS | 24472 | -------- Summary: end -------- 04:35:35 INFO - PROCESS | 24472 | 04:35:35 INFO - PROCESS | 24472 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:35 INFO - PROCESS | 24472 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:35 INFO - PROCESS | 24472 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:35 INFO - PROCESS | 24472 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:35 INFO - PROCESS | 24472 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:36 INFO - TEST-INFO | 24472: exit 0 04:35:36 INFO - TEST-OK | dromaeo_css | took 1115580ms 04:35:36 INFO - TEST-START | kraken 04:35:36 INFO - operating with platform_type : linux_ 04:35:36 INFO - Initialising browser for kraken test... 04:35:36 INFO - TEST-INFO | started process 24656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxl22zB/profile http://localhost:56915/getInfo.html) 04:35:40 INFO - PROCESS | 24656 | __metrics Screen width/height:1600/1200 04:35:40 INFO - PROCESS | 24656 | colorDepth:24 04:35:40 INFO - PROCESS | 24656 | Browser inner width/height: 1024/697 04:35:40 INFO - PROCESS | 24656 | __metrics 04:35:40 INFO - PROCESS | 24656 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:35:40 INFO - PROCESS | 24656 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:40 INFO - PROCESS | 24656 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:40 INFO - PROCESS | 24656 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:40 INFO - PROCESS | 24656 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:40 INFO - PROCESS | 24656 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:40 INFO - PROCESS | 24656 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:40 INFO - PROCESS | 24656 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:35:41 INFO - TEST-INFO | 24656: exit 0 04:35:41 INFO - Browser initialized. 04:35:41 INFO - Running cycle 1/1 for kraken test... 04:35:41 INFO - TEST-INFO | started process 24739 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxl22zB/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 | 24739 | RSS: Main: 153624576 04:35:53 INFO - PROCESS | 24739 | 04:35:56 INFO - PROCESS | 24739 | Cycle 1(1): loaded http://localhost:56915/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56915/tests/kraken/driver.html?testName=audio-beat-detection) 04:35:57 INFO - PROCESS | 24739 | RSS: Main: 197259264 04:35:57 INFO - PROCESS | 24739 | 04:35:59 INFO - PROCESS | 24739 | Cycle 1(1): loaded http://localhost:56915/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56915/tests/kraken/driver.html?testName=audio-dft) 04:36:00 INFO - PROCESS | 24739 | RSS: Main: 185917440 04:36:00 INFO - PROCESS | 24739 | 04:36:03 INFO - PROCESS | 24739 | Cycle 1(1): loaded http://localhost:56915/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56915/tests/kraken/driver.html?testName=audio-fft) 04:36:04 INFO - PROCESS | 24739 | RSS: Main: 170250240 04:36:04 INFO - PROCESS | 24739 | 04:36:06 INFO - PROCESS | 24739 | Cycle 1(1): loaded http://localhost:56915/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56915/tests/kraken/driver.html?testName=audio-oscillator) 04:36:06 INFO - PROCESS | 24739 | RSS: Main: 174813184 04:36:06 INFO - PROCESS | 24739 | 04:36:08 INFO - PROCESS | 24739 | Cycle 1(1): loaded http://localhost:56915/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56915/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:36:09 INFO - PROCESS | 24739 | RSS: Main: 174333952 04:36:09 INFO - PROCESS | 24739 | 04:36:12 INFO - PROCESS | 24739 | Cycle 1(1): loaded http://localhost:56915/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56915/tests/kraken/driver.html?testName=imaging-darkroom) 04:36:13 INFO - PROCESS | 24739 | RSS: Main: 174448640 04:36:13 INFO - PROCESS | 24739 | 04:36:16 INFO - PROCESS | 24739 | Cycle 1(1): loaded http://localhost:56915/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56915/tests/kraken/driver.html?testName=imaging-desaturate) 04:36:17 INFO - PROCESS | 24739 | RSS: Main: 175919104 04:36:17 INFO - PROCESS | 24739 | 04:36:20 INFO - PROCESS | 24739 | Cycle 1(1): loaded http://localhost:56915/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56915/tests/kraken/driver.html?testName=json-parse-financial) 04:36:20 INFO - PROCESS | 24739 | RSS: Main: 175960064 04:36:20 INFO - PROCESS | 24739 | 04:36:22 INFO - PROCESS | 24739 | Cycle 1(1): loaded http://localhost:56915/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56915/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:36:22 INFO - PROCESS | 24739 | RSS: Main: 186830848 04:36:22 INFO - PROCESS | 24739 | 04:36:24 INFO - PROCESS | 24739 | Cycle 1(1): loaded http://localhost:56915/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56915/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:36:25 INFO - PROCESS | 24739 | RSS: Main: 183787520 04:36:25 INFO - PROCESS | 24739 | 04:36:27 INFO - PROCESS | 24739 | Cycle 1(1): loaded http://localhost:56915/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56915/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:36:28 INFO - PROCESS | 24739 | RSS: Main: 195084288 04:36:28 INFO - PROCESS | 24739 | 04:36:30 INFO - PROCESS | 24739 | Cycle 1(1): loaded http://localhost:56915/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56915/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:36:31 INFO - PROCESS | 24739 | RSS: Main: 198361088 04:36:31 INFO - PROCESS | 24739 | 04:36:33 INFO - PROCESS | 24739 | Cycle 1(1): loaded http://localhost:56915/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56915/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:36:34 INFO - PROCESS | 24739 | RSS: Main: 198791168 04:36:34 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | Cycle 1(1): loaded http://localhost:56915/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56915/tests/kraken/driver.html?testName=ai-astar) 04:36:36 INFO - PROCESS | 24739 | RSS: Main: 258326528 04:36:36 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | __start_tp_report 04:36:36 INFO - PROCESS | 24739 | _x_x_mozilla_page_load 04:36:36 INFO - PROCESS | 24739 | _x_x_mozilla_page_load_details 04:36:36 INFO - PROCESS | 24739 | |i|pagename|runs| 04:36:36 INFO - PROCESS | 24739 | |0;ai-astar;115;118;110;114;115;115;106;115;115;114 04:36:36 INFO - PROCESS | 24739 | |1;audio-beat-detection;159;134;154;181;134;158;154;135;170;134 04:36:36 INFO - PROCESS | 24739 | |2;audio-dft;165;163;164;162;163;163;165;165;164;163 04:36:36 INFO - PROCESS | 24739 | |3;audio-fft;74;74;97;95;75;74;74;114;106;75 04:36:36 INFO - PROCESS | 24739 | |4;audio-oscillator;98;98;146;103;98;97;134;98;98;146 04:36:36 INFO - PROCESS | 24739 | |5;imaging-gaussian-blur;119;114;115;114;115;114;115;115;115;115 04:36:36 INFO - PROCESS | 24739 | |6;imaging-darkroom;149;147;147;147;148;146;147;147;147;148 04:36:36 INFO - PROCESS | 24739 | |7;imaging-desaturate;96;95;97;96;96;96;96;96;96;95 04:36:36 INFO - PROCESS | 24739 | |8;json-parse-financial;68;68;68;68;67;68;68;75;65;66 04:36:36 INFO - PROCESS | 24739 | |9;json-stringify-tinderbox;72;73;72;72;73;76;72;71;72;72 04:36:36 INFO - PROCESS | 24739 | |10;stanford-crypto-aes;83;84;84;85;84;83;83;84;93;83 04:36:36 INFO - PROCESS | 24739 | |11;stanford-crypto-ccm;123;125;123;121;135;122;131;140;127;119 04:36:36 INFO - PROCESS | 24739 | |12;stanford-crypto-pbkdf2;152;140;153;149;152;142;159;151;140;149 04:36:36 INFO - PROCESS | 24739 | |13;stanford-crypto-sha256-iterative;70;69;69;69;72;73;70;70;70;71 04:36:36 INFO - PROCESS | 24739 | __end_tp_report 04:36:36 INFO - PROCESS | 24739 | __start_cc_report 04:36:36 INFO - PROCESS | 24739 | _x_x_mozilla_cycle_collect,1152 04:36:36 INFO - PROCESS | 24739 | __end_cc_report 04:36:36 INFO - PROCESS | 24739 | __startTimestamp1456835796634__endTimestamp 04:36:36 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | ------- Summary: start ------- 04:36:36 INFO - PROCESS | 24739 | Number of tests: 14 04:36:36 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | [#0] ai-astar Cycles:10 Average:113.70 Median:115.00 stddev:3.33 (2.9%) stddev-sans-first:3.50 04:36:36 INFO - PROCESS | 24739 | Values: 115.0 118.0 110.0 114.0 115.0 115.0 106.0 115.0 115.0 114.0 04:36:36 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:156.00 stddev:16.71 (10.7%) stddev-sans-first:17.49 04:36:36 INFO - PROCESS | 24739 | Values: 159.0 134.0 154.0 181.0 134.0 158.0 154.0 135.0 170.0 134.0 04:36:36 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:1.06 (0.6%) stddev-sans-first:1.01 04:36:36 INFO - PROCESS | 24739 | Values: 165.0 163.0 164.0 162.0 163.0 163.0 165.0 165.0 164.0 163.0 04:36:36 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | [#3] audio-fft Cycles:10 Average:85.80 Median:74.50 stddev:15.65 (21.0%) stddev-sans-first:16.00 04:36:36 INFO - PROCESS | 24739 | Values: 74.0 74.0 97.0 95.0 75.0 74.0 74.0 114.0 106.0 75.0 04:36:36 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:98.00 stddev:21.29 (21.7%) stddev-sans-first:22.01 04:36:36 INFO - PROCESS | 24739 | Values: 98.0 98.0 146.0 103.0 98.0 97.0 134.0 98.0 98.0 146.0 04:36:36 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.45 (1.3%) stddev-sans-first:0.50 04:36:36 INFO - PROCESS | 24739 | Values: 119.0 114.0 115.0 114.0 115.0 114.0 115.0 115.0 115.0 115.0 04:36:36 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.60 04:36:36 INFO - PROCESS | 24739 | Values: 149.0 147.0 147.0 147.0 148.0 146.0 147.0 147.0 147.0 148.0 04:36:36 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:36:36 INFO - PROCESS | 24739 | Values: 96.0 95.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 04:36:36 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | [#8] json-parse-financial Cycles:10 Average:68.10 Median:68.00 stddev:2.64 (3.9%) stddev-sans-first:2.80 04:36:36 INFO - PROCESS | 24739 | Values: 68.0 68.0 68.0 68.0 67.0 68.0 68.0 75.0 65.0 66.0 04:36:36 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:72.00 stddev:1.35 (1.9%) stddev-sans-first:1.42 04:36:36 INFO - PROCESS | 24739 | Values: 72.0 73.0 72.0 72.0 73.0 76.0 72.0 71.0 72.0 72.0 04:36:36 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:3.03 (3.6%) stddev-sans-first:3.15 04:36:36 INFO - PROCESS | 24739 | Values: 83.0 84.0 84.0 85.0 84.0 83.0 83.0 84.0 93.0 83.0 04:36:36 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:126.00 stddev:6.74 (5.3%) stddev-sans-first:7.02 04:36:36 INFO - PROCESS | 24739 | Values: 123.0 125.0 123.0 121.0 135.0 122.0 131.0 140.0 127.0 119.0 04:36:36 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:151.50 stddev:6.22 (4.1%) stddev-sans-first:6.48 04:36:36 INFO - PROCESS | 24739 | Values: 152.0 140.0 153.0 149.0 152.0 142.0 159.0 151.0 140.0 149.0 04:36:36 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:1.34 (1.9%) stddev-sans-first:1.41 04:36:36 INFO - PROCESS | 24739 | Values: 70.0 69.0 69.0 69.0 72.0 73.0 70.0 70.0 70.0 71.0 04:36:36 INFO - PROCESS | 24739 | -------- Summary: end -------- 04:36:36 INFO - PROCESS | 24739 | 04:36:36 INFO - PROCESS | 24739 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:36:36 INFO - PROCESS | 24739 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:36:36 INFO - PROCESS | 24739 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:36:36 INFO - PROCESS | 24739 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:36:36 INFO - PROCESS | 24739 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:36:36 INFO - PROCESS | 24739 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:36:36 INFO - PROCESS | 24739 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:36:37 INFO - TEST-INFO | 24739: exit 0 04:36:37 INFO - TEST-OK | kraken | took 61340ms 04:36:37 INFO - SUITE-END | took 1176s 04:36:37 INFO - Completed test suite (00:19:37) 04:36:37 INFO - Working with test: dromaeo_css 04:36:37 INFO - Generating results file: dromaeo_css 04:36:37 INFO - Working with test: kraken 04:36:37 INFO - Generating results file: kraken 04:36:37 INFO - javascript benchmark 04:36:37 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:36:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:36:37 INFO - process_Request line: dromaeo_css 6079.07 graph.html#tests=[[72,94,35]] 04:36:37 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:36:37 INFO - process_Request line: kraken 1555.20 graph.html#tests=[[232,94,35]] 04:36:37 INFO - RETURN: dromaeo_css: 6079.07 04:36:37 INFO - RETURN: kraken: 1555.20 04:36:37 INFO - javascript benchmark 04:36:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2588.585826267797, 2662.188032650041, 2681.503921774471, 2686.90595829146, 2707.4585082983394, 4385.386045953569, 4465.709728867621, 4534.705244159131, 4557.635389168862, 4578.359029735835, 4435.667324950634, 4508.278675411935, 4522.547745225484, 4549.363089167519, 4614.861554153373, 4146.150039241963, 4167.3332266837315, 4169.270377683908, 4187.602177793105, 4289.849855255066, 4256.659467242614, 4266.082792199676, 4295.484541854982, 4322.308430651096, 4369.847055353063, 3990.0024993751417, 4112.876613701594, 4144.8134833932545, 4190.47619047616, 4192.392103145057, 4130.463039804837, 4150.979245103786, 4157.147784704129, 4193.035601811601, 4201.663866890642, 4010.598940105995, 4134.545200027995, 4137.172565486884, 4150.91698166035, 4177.895552611179, 4372.584604462571, 4419.756913369763, 4460.219461594208, 4466.263066594008, 4492.595666390041, 4713.104510143096, 4729.075775398705, 4730.124926888537, 4732.266498692674, 4770.952290477086, 4660.277656963176, 4751.14479393709, 4807.326974223576, 4811.350467686852, 4831.130396528623, 4550.408446901882, 4551.45382554089, 4572.199865023641, 4588.01357708091, 4596.4714057883775, 4962.851114466572, 4988.775505102279, 4993.825216117491, 4995.875103122451, 5041.823536176216, 4590.586847183769, 4732.6687131900435, 4784.40194975628, 4804.0, 4811.975940120347, 4833.564979151894, 4848.345473361122, 4855.8057677693205, 4888.486708895514, 4895.241237608177, 4811.109944660249, 4813.205821039559, 4815.807367705323, 4819.638527110481, 4860.343853579721, 4639.118567472169, 4775.689580177277, 4800.399950006249, 4812.687175333592, 4826.541478559531, 3742.8502859885843, 3753.155540003477, 3756.8309426075893, 3780.1305699689224, 3792.6965842732516, 3379.831008449617, 3389.864405423755, 3404.965950340465, 3406.8466918988706, 3420.675035871588, 4013.4983127109113, 4097.221527909687, 4187.20443115807, 4189.979050104791, 4208.558101399371, 4834.854954351375, 4835.879103022453, 4838.03239352131, 4864.80540778372, 4879.487653796371, 4193.098483825931, 4202.663786897041, 4205.894852628709, 4224.725392849455, 4244.787760611957, 4190.580941905785, 4264.530901600821, 4312.741235525878, 4328.242557552416, 4351.825926962886, 4585.174668559691, 4588.767421841174, 4604.907901841944, 4627.236505976476, 4635.374224479652, 4808.182608956416, 4808.879778005438, 4812.807487700453, 4818.084563932842, 4861.295112208639, 4539.114872599944, 4592.954070459253, 4638.652101092499, 4708.623310135249, 4721.102990431807, 4787.257975013878, 4794.880127996688, 4803.519648035308, 4804.543568361, 4828.179209534317, 4830.29960655696, 4870.975645121894, 4872.805087796449, 4879.048585525788, 4919.2129259318335, 4566.406367172246, 4599.356090147449, 4648.0, 4659.324397962344, 4685.648576356855, 4651.418572678415, 4654.48800631937, 4655.3249778782565, 4665.136949664187, 4706.505816889177, 4469.0, 4575.199340115533, 4586.633069354377, 4593.196190666687, 4634.606058485067, 4734.55021772931, 4783.402074740658, 4790.305405716082, 4813.975930120327, 4827.662063655511, 4611.031683346535, 4642.466116396523, 4643.791029403753, 4648.070385922897, 4687.1328804171335], "unit": "score", "name": "dojo.html", "value": 4426.37522429929}, {"lowerIsBetter": false, "replicates": [478.6912441475251, 492.6108374384237, 495.0593871643876, 504.07250658787825, 518.5177784660266, 24733.38166545837, 33180.17049573762, 33732.831335843344, 33796.15509612255, 33894.49158262628, 37203.4419483708, 37731.0, 37780.43329350062, 37793.0, 37855.24289514208, 6784.491163162783, 7624.27569380908, 7833.373330133576, 9489.857652135224, 9653.565589548487, 9762.463064531448, 9898.802023959517, 9900.405975641448, 9904.603815847357, 9908.504574771268, 9862.112409883144, 9972.451515166664, 9977.600895964153, 9981.650642227523, 9984.40093594383, 9802.313838031341, 9937.155341795957, 9943.0, 9944.900550994469, 9945.850812237823, 10005.149562287213, 10156.085952264259, 10176.0, 10187.7453063674, 10198.745031374201, 36220.74799154108, 36557.45163822518, 36640.45039324412, 36764.44853327202, 36774.0, 2911.737943585066, 3058.8776448942017, 3185.984070079658, 3197.1847178969447, 3294.7199488043543, 28048.859755701294, 28130.437391252264, 28319.57520637192, 28515.42969140626, 28624.427511449656, 2848.2167403963867, 2906.6657334406605, 2922.8830846766105, 2930.868110935013, 2953.1140657802575, 213217.0, 214308.92845535828, 215833.0, 215973.0, 216097.0, 37959.24081518354, 53239.46760532423, 53808.46191538034, 53831.730841346325, 53849.1922621161, 36731.81634091812, 36858.26283474315, 36899.26201476009, 36939.63060369415, 36954.44568331477, 10484.213683973732, 11770.17608767378, 11827.0, 11958.0, 11988.460519276654, 9071.365004449624, 9136.812214412217, 9149.77125571866, 9152.084791520794, 9160.0, 13011.739765204642, 13024.934875325753, 13034.615116891839, 13392.799108013387, 13442.193468391928, 5437.401885792559, 5526.696031718294, 5557.194206839986, 5604.8318550443555, 5651.321841379061, 872.445996792029, 951.0740749981205, 956.4404823178379, 1013.2147585621055, 1018.7045756730465, 25364.873175634373, 26050.0, 26594.86702566475, 26688.466230675276, 26885.865570672413, 954.8329042417688, 989.3816364772017, 1007.8941711120227, 1026.2713473433796, 1038.5118994072773, 13611.0, 13731.931340343235, 13792.862071379157, 13950.860491395159, 14055.578332650037, 253694.0, 258806.0, 259128.0, 259144.0, 259269.0, 43583.0, 45121.54878451173, 45140.3228951566, 45146.77426612846, 45217.54782452199, 1042.718466014187, 1069.1072954083427, 1069.5989004123453, 1201.7296108375544, 1213.1629175868622, 19531.414057578295, 27004.04656042348, 27462.17613471599, 27608.861955690092, 27649.308767280174, 43376.132477350904, 43896.0, 43914.0, 43919.56080439282, 43932.560674392844, 237671.0, 237887.0, 239046.0, 239774.0, 240203.0, 28675.56986645244, 29427.0, 29592.112236632936, 29662.0, 29685.85157074201, 38185.0, 38486.2302753949, 39016.80491597524, 39161.60838391694, 39197.6080239194, 32828.1792955178, 32876.835615821765, 33311.66688333086, 33368.16579585433, 33433.83283083666, 33645.49531757075, 33892.0, 34040.0, 34194.658053419145, 34371.828140859136, 33361.666383335854, 33581.0, 33889.66110338865, 33927.32145357128, 36017.63982360143, 26204.344891377106, 27635.447291053664, 28699.713002869703, 28705.28236794097, 28947.85526072356, 21691.566168676854, 22028.422492220532, 23724.28827135189, 23728.169514066925, 23886.0], "unit": "score", "name": "ext.html", "value": 16367.462619461201}, {"lowerIsBetter": false, "replicates": [332.63244115252644, 341.1828670334549, 341.48947323750997, 342.1395191094397, 346.06562281839024, 13836.654083647902, 14716.117032978029, 15209.163496007715, 15269.847301527008, 15290.388384464608, 13825.585232443018, 14023.228722420288, 14250.92874535626, 14480.855191448083, 14500.347484363203, 5032.295478632995, 5188.7146206958605, 5191.480851914797, 5199.168133098705, 5203.765830537616, 4829.613630909519, 5015.473375295578, 5055.46917573655, 5122.206058060988, 5133.358330208724, 5004.924926126111, 5029.245613158019, 5030.647854650176, 5032.194848824189, 5059.139946209153, 4995.250712393134, 5019.949800502003, 5021.372328458942, 5029.094762942669, 5099.23511473282, 4873.31773551703, 4951.777170027357, 4982.17794063979, 4983.92524112135, 5008.649394542384, 11349.262297950607, 11551.768964620745, 12538.561150359694, 18581.0, 18586.721199182022, 1807.3403207829178, 1836.2012524551862, 1839.1723724323974, 1894.1571000904603, 1920.4814700031054, 8376.790580235482, 8587.270082043035, 8801.735947921572, 11743.236689615147, 12295.262284262973, 1683.4444633270991, 1758.630687555615, 1763.3387479695114, 1763.7442570827159, 1800.5768644368563, 52089.21866172011, 54482.0, 54764.0, 55493.9999999996, 55501.0, 9130.771730706785, 9495.620175192915, 9628.855567166498, 9657.0, 9728.416295022322, 12068.758624827455, 12075.698107547207, 12136.817947730791, 12164.209326393757, 12178.695532611579, 6434.7747828826705, 6467.547271690936, 6544.803655890331, 6551.901721474182, 6644.96677516619, 5996.4603185713495, 6058.757649694051, 6139.539534534839, 6147.01647736369, 6242.469390101802, 4142.378643203544, 4215.093754842724, 4252.128313695747, 4312.956870431318, 4316.6330861877095, 1673.71546837038, 1701.2769572931454, 1709.666615010086, 1723.6638855423073, 1733.6446028564114, 792.825578372757, 847.4491580472619, 876.7106854737921, 886.4238245140581, 921.1525396635112, 14641.34113964874, 14662.266886655838, 15259.313330900137, 15364.769528457082, 15624.296906639001, 848.2154007543121, 854.692310768123, 858.3219256787193, 872.1017352127319, 919.5172534419484, 8609.354298427517, 8683.522406267715, 8690.913090869137, 8726.345524085718, 8907.955460222787, 309185.0, 353798.0, 354856.0, 355194.0, 356009.0, 59935.400645993854, 61060.0, 61672.38327616666, 61939.380606193365, 63768.68115659392, 921.5069937583361, 926.1664501948301, 938.3009657804979, 940.0505489455699, 942.2038377570941, 13504.797428038391, 13561.0, 13611.863881361456, 13630.591082267549, 13716.862831371958, 29672.0, 29830.55254171146, 30535.08394748161, 30717.23206919845, 31686.049418517483, 41252.793736031126, 41430.0, 41722.37416438695, 41852.3722144162, 42487.15025699531, 6567.44176744982, 6682.23154337238, 6707.5304728668525, 7034.120734908137, 7038.542494737826, 9642.951785241028, 9925.404475731479, 10288.537015834456, 10489.79020419572, 10678.946605266923, 9223.21602663781, 9408.670696525589, 9411.10594493522, 9443.480608566595, 9758.658446954323, 8331.416800823885, 8920.286377089948, 9015.14356136166, 9139.862902056608, 9318.254539636948, 5288.762005709829, 5806.419358064329, 8863.335249856416, 9596.328257021942, 10308.793824123326, 6929.411000064849, 6988.390734426197, 7088.929110709033, 7150.463715221484, 7189.5686258824635, 7269.963650181715, 9455.527223638654, 9608.567614457226, 9821.85267220978, 9853.901460985298], "unit": "score", "name": "jquery.html", "value": 7416.02739133248}, {"lowerIsBetter": false, "replicates": [1236.1408820869487, 1354.5868510104417, 1374.1342953939018, 1488.7692407676814, 1723.284836792731, 5892.234009578754, 6023.909641355383, 6909.758158464455, 7106.751263705772, 7110.1112360954885, 7107.538010029344, 7119.074520312352, 7167.426605871531, 7177.784666460015, 7200.711971521133, 1493.60419488835, 2023.6964455331745, 2044.3458093410115, 2079.875207487548, 2082.979170208301, 2000.1999200319842, 2009.8090681385245, 2010.497375656086, 2011.1251605551631, 2012.30575451469, 2020.070767446976, 2056.0233888902803, 2057.372501387076, 2057.825084867788, 2061.9690704639443, 2014.6575082235981, 2019.4143698327468, 2022.5853699991467, 2024.9291274805385, 2025.1696804310236, 2054.0346037362415, 2067.379786064175, 2071.5753270579494, 2072.9067191976396, 2073.0463986566197, 7262.818429539251, 7327.413806895435, 7339.486235963484, 7340.632968351614, 7346.926530734678, 4124.154548317588, 4211.978940105279, 4222.408862759216, 4224.366345048236, 4225.492940847087, 2586.44391455836, 2639.722829102955, 2691.3540750220004, 2693.46130773846, 2720.102366219163, 790.7785819970418, 800.8118092248317, 815.9224873636995, 851.8594431918788, 852.071242345846, 9648.855267170999, 9792.314537982415, 9895.851562226573, 9911.454869982148, 9916.702498925044, 3767.7362584618813, 3912.921741565153, 3983.960160398417, 3983.960160398417, 3992.0818211811447, 8588.699395521251, 8613.353998450142, 8640.179182977607, 8660.26387757035, 8665.826683466295, 4328.567143285646, 4338.154059958278, 4367.62875155609, 4377.737335759864, 4389.188000219906, 3087.243625311813, 3647.0, 3751.6811071059265, 3761.586225515191, 3767.811609419518, 3301.3067255876535, 3342.983285083559, 3357.932841343208, 3373.8144402058124, 3381.9492707609406, 1068.8610480637624, 1077.0575746222055, 1086.750047489082, 1089.4389389464432, 1105.171121658756, 947.209080417845, 1046.7749433871754, 1171.3381939204323, 1173.2608456672242, 1179.4692388425242, 6699.363560461748, 6701.932980670131, 6711.63086030273, 6731.966340168267, 6736.0, 1080.3571874734678, 1122.203235702644, 1125.4468833010558, 1127.7406196574834, 1146.3236690352733, 5315.069862773999, 5347.679139251657, 5398.541124004425, 5404.3784964728775, 5407.540359069444, 8154.062282837431, 8328.417010809306, 8332.750017499484, 8340.124286949784, 8469.74590762278, 8167.877481837777, 8197.303229225463, 8206.097329293772, 8227.670893164206, 8237.546934918637, 6678.799636010927, 6728.259891411941, 6844.863102737917, 6907.896381554281, 6931.757388491278, 6644.069830223869, 6669.1330127083165, 6712.160979877515, 6713.395794378529, 6746.190457145174, 7328.890066648898, 7443.218462061622, 7482.625868706652, 7596.8480630388185, 7630.8855367170645, 7513.0, 7737.0, 7751.883721744066, 7753.4960227585025, 7825.843483130192, 5140.151874940593, 5946.1972633693895, 5983.581149319506, 6294.6852657366035, 6344.270408903035, 6606.9008964866525, 6644.335566443317, 6684.131062961784, 6697.564658297195, 6711.731530738716, 5992.161097446274, 6108.51131909455, 6145.262568491809, 6157.599756015845, 6275.246970363585, 5923.614965027259, 6008.519318454426, 6076.635401875901, 6103.786367477117, 6161.44546990755, 6409.391107844747, 6480.7731729391135, 6489.415952564292, 6492.448141907802, 6493.350664933469, 5851.678157701367, 5957.017092179742, 5962.0, 5962.940370596239, 5987.550933680079, 5972.313183983897, 5976.760929562769, 6014.699265036643, 6015.608985416109, 6026.246719160105], "unit": "score", "name": "mootools.html", "value": 4059.3366668480594}, {"lowerIsBetter": false, "replicates": [280.7108678061596, 283.98722057507416, 284.8411120671751, 288.9956650650242, 296.2445763303576, 5337.546308563772, 5354.544863686591, 5354.946450535498, 5360.437154098822, 5364.758585863631, 5129.717865517395, 5284.339457567804, 5291.708956007427, 5295.0733621616255, 5297.973510132453, 3790.8862734117884, 3851.017990412441, 3858.59484754101, 3994.920101597966, 4031.5766844481345, 3868.2263547290513, 3901.122247494305, 3933.193695292458, 4061.208064427438, 4071.9389209161886, 4013.5384430790396, 4017.7790221537803, 4024.416459613354, 4026.758394496325, 4039.4546736190678, 4004.7396919200305, 4017.819198136091, 4024.3561030235314, 4027.335489644205, 4028.1339512004765, 3276.443004689185, 3356.6475520070285, 3424.503447000196, 3429.331280400323, 3436.8453419595926, 5121.4110377306715, 5124.4106927703415, 5136.203888397305, 5140.897182056376, 5159.045576568347, 4638.1883170445035, 4645.837395691135, 4648.837290694843, 4649.209634362167, 4652.232381657022, 5599.776008959637, 5611.579131565108, 5612.831615051555, 5613.0, 5614.326280846284, 3799.7530160539477, 3801.885943421702, 3802.2205447883116, 3803.6766874815676, 3806.9809650951843, 5702.144678298247, 5805.3323867755325, 5882.705864706748, 5890.410958904118, 5890.528757699374, 3856.633619806114, 3873.32216862048, 3887.6501114899793, 3887.9805600971813, 3894.4547763313158, 3956.624120708528, 3958.980205098956, 3960.0693836948294, 3960.683145348365, 3962.890390690611, 4596.632269418438, 4601.562851529099, 4606.078784243165, 4614.123316569841, 4621.09888571732, 5634.492895639412, 5636.549076073904, 5638.590352411897, 5640.520555752807, 5643.435656434323, 1365.7473367427058, 1375.5804479633807, 1375.848656647768, 1376.0092733232057, 1376.504458394977, 894.3784070071368, 902.0, 927.3925578745932, 940.5908429833045, 944.7921457279388, 4774.570288674036, 4915.139850526144, 4965.47862474435, 4976.477469865685, 5012.799488020439, 5900.144479050599, 5913.113033045078, 5913.733881975321, 5918.437748413894, 5919.112133179971, 5024.070546948826, 5025.522575355335, 5027.145385284511, 5031.371078615173, 5033.295338652591, 3131.498960166408, 3171.365726854592, 3173.698498642625, 3174.2857856981996, 3175.3966746318124, 5544.168374743821, 5603.551715862721, 5611.046122159243, 5611.270534830527, 5614.494695477427, 5861.70691465425, 6055.2430946131735, 6057.757689692451, 6065.4541091302, 6078.787242446493, 5586.636868603528, 5606.467385598362, 5606.55147588192, 5611.607187496836, 5615.466530679579, 5884.9705751470965, 5895.7052147393315, 5896.351401345934, 5897.5576831736935, 5902.763889444546, 5717.742701578522, 5772.451617096369, 5777.94222057774, 5780.537556995514, 5787.565932554991, 5573.972130139324, 5580.386157522588, 5594.916076258941, 5598.608097433141, 5604.467575580314, 3748.0, 3858.6720128789366, 3867.0332416895776, 3879.224155169034, 3903.6291552302487, 5857.0, 5869.4717475425705, 5870.823875283749, 5878.030125029322, 5888.793892213752, 5651.067573850269, 5656.604037717485, 5658.264425624642, 5659.603827732019, 5664.943350566442, 5645.9153112702525, 5645.971770141123, 5665.065264231521, 5673.801416950387, 5676.886462270814, 5559.694216817952, 5565.30433695788, 5565.860853478695, 5570.910908409346, 5571.470710282517, 5460.15367618004, 5716.828495145152, 5801.680907550125, 5807.825765226881, 5809.157672137601, 5538.91691624634, 5580.748866300945, 5581.972090139523, 5582.385937546947, 5586.636868603528], "unit": "score", "name": "prototype.html", "value": 4175.440604867898}, {"lowerIsBetter": false, "replicates": [615.8060211033521, 655.5280198257253, 706.5301574452989, 727.4216997486998, 733.3290039613754, 10588.470576471183, 10609.575616975331, 10613.946930265347, 10636.893631063696, 10711.83932241016, 11214.10287177026, 11862.34757088362, 12075.818862717066, 12097.516099356037, 12136.939315303433, 606.3088079589272, 748.7753673897836, 762.7711686494057, 775.4881778026504, 780.5511830697343, 771.3289438188756, 777.7472321495509, 780.2236774409471, 780.7540624703229, 782.1865260129458, 818.7666515043214, 821.3142026407927, 821.363443331417, 821.4496287487368, 822.005373498068, 630.265740412419, 796.3271035974592, 814.0394334685069, 814.9225823546783, 814.9388795840335, 597.6175247841385, 597.7579080472416, 598.9341172471024, 599.3107925885223, 600.1957377114644, 10838.512266948006, 10871.891281087166, 10899.073578745816, 10991.175661825395, 11007.449627518592, 10576.471176441224, 11028.172887033505, 11216.719582010433, 11319.434028298634, 11408.71478213043, 9175.541222938826, 9326.393784403992, 9385.10841470066, 9482.762930926712, 9550.95224523873, 3206.422843888099, 3215.8070515769127, 3284.523744057098, 3289.3256882339065, 3317.4360358739073, 39545.80227098875, 39592.40611390831, 39783.40324895129, 39801.40297895534, 39899.00252493682, 8902.109789021175, 9320.766980825534, 9476.810463790824, 9479.720446807316, 9553.808923821623, 16206.594835129215, 16207.351705931631, 16250.349986000663, 16257.18714064292, 16403.179841007903, 6332.4934005279465, 6366.649834259068, 6420.486361091102, 6492.253390860112, 6592.76925307612, 3612.151144481045, 3631.4371272452813, 3642.7996460194945, 3684.373656478405, 3701.574318953301, 2489.962650560243, 2539.7968162546954, 2545.3382120648394, 2545.923622291334, 2557.0794513974956, 427.9507856596469, 475.5886158472896, 485.9295402166666, 492.37960170185823, 494.88617617948074, 455.5854172702891, 517.3688100517363, 563.937966823649, 582.7115577789021, 583.6498101139282, 7727.961360193275, 7893.802654933558, 7967.362610991223, 8002.500471319017, 8047.155048719917, 572.9627574207747, 605.3613437823138, 609.5093449772887, 632.5572099530348, 635.0976039499535, 3300.455424854872, 3428.63999280077, 3611.9819400903352, 3680.576733675608, 3766.1902690921584, 45313.773431132635, 45793.31310030352, 45956.08087838224, 46219.53780462153, 46336.7683161582, 43374.0, 43485.56514434879, 43578.0, 44227.0, 44404.0, 37175.0, 39098.60901391006, 39864.0, 39878.80060599678, 40004.59995400067, 8119.79700507492, 8147.714829980922, 8200.138985406686, 8289.917100829156, 8321.625526851185, 28748.281292967007, 29614.259643509085, 30334.241643959078, 30576.694233057384, 31320.21699457532, 34549.481757774156, 37886.242275154895, 38440.6155938437, 38537.80731096327, 38703.03242418962, 9100.99889012195, 9176.95411522938, 9196.58615362297, 9199.724008279762, 9218.769530761785, 10320.174386049248, 11012.17408694335, 11166.274192177483, 11222.438878055902, 11230.494627741607, 7781.455298129076, 9906.0, 10369.533370998473, 10860.511276992713, 10924.180686448708, 9425.481598511873, 9953.656256405582, 10287.177025838064, 10316.587336506456, 10343.793124137324, 9810.117089461983, 9847.261455390731, 10026.849597255901, 10032.398056116657, 10159.492025398553, 8144.348452123934, 8381.371397145116, 8557.828843423222, 8640.211824548116, 8761.518116503654, 8064.0, 8127.390445716476, 8251.793705157419, 8411.873821892554, 8423.157684231774], "unit": "score", "name": "yui.html", "value": 5541.416255379592}], "name": "dromaeo_css", "value": 6079.070285645026}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 118.0, 110.0, 114.0, 115.0, 115.0, 106.0, 115.0, 115.0, 114.0], "unit": "score", "name": "ai-astar", "value": 113.7}, {"lowerIsBetter": true, "replicates": [159.0, 134.0, 154.0, 181.0, 134.0, 158.0, 154.0, 135.0, 170.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 151.3}, {"lowerIsBetter": true, "replicates": [165.0, 163.0, 164.0, 162.0, 163.0, 163.0, 165.0, 165.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 97.0, 95.0, 75.0, 74.0, 74.0, 114.0, 106.0, 75.0], "unit": "score", "name": "audio-fft", "value": 85.8}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 146.0, 103.0, 98.0, 97.0, 134.0, 98.0, 98.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 111.6}, {"lowerIsBetter": true, "replicates": [119.0, 114.0, 115.0, 114.0, 115.0, 114.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.1}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 147.0, 147.0, 148.0, 146.0, 147.0, 147.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 75.0, 65.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 68.1}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 72.0, 73.0, 76.0, 72.0, 71.0, 72.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.5}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 85.0, 84.0, 83.0, 83.0, 84.0, 93.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [123.0, 125.0, 123.0, 121.0, 135.0, 122.0, 131.0, 140.0, 127.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.6}, {"lowerIsBetter": true, "replicates": [152.0, 140.0, 153.0, 149.0, 152.0, 142.0, 159.0, 151.0, 140.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.7}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 69.0, 72.0, 73.0, 70.0, 70.0, 70.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.3}], "name": "kraken", "value": 1555.1999999999998}]} 04:36:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1555.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6079.07"}}} 04:36:37 INFO - Return code: 0 04:36:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:36:38 INFO - # TBPL SUCCESS # 04:36:38 INFO - Running post-action listener: _resource_record_post_action 04:36:38 INFO - Running post-run listener: _resource_record_post_run 04:36:39 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 527343616; Read time: 0; Write time: 366344 04:36:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 233582592; Read time: 0; Write time: 208380 04:36:39 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 293761024; Read time: 0; Write time: 157964 04:36:39 INFO - Running post-run listener: _upload_blobber_files 04:36:39 INFO - Blob upload gear active. 04:36:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:36:39 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:39 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:39 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:39 INFO - (blobuploader) - INFO - Open directory for files ... 04:36:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:36:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:36:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:36:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:36:40 INFO - (blobuploader) - INFO - Done attempting. 04:36:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:36:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:36:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:36:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:36:41 INFO - (blobuploader) - INFO - Done attempting. 04:36:41 INFO - (blobuploader) - INFO - Iteration through files over. 04:36:41 INFO - Return code: 0 04:36:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:36:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:36:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ea1c3d8782387eda185e89038b39b0be80cbf39fab6a4fad455efe988fa3e8d7d72f88bf41e6d99df8e7680357d66319c1b126a04b139e9b6a6eb37b6446bb5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2eff33efb9ddddfcffe5364e8bfa5a63e7ca7c222e67cc78d5241fc15d441cb187fc166ab29a84ca9852ef1946fd9b4d3010081d45610e5820911365073aa391"} 04:36:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:36:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:36:41 INFO - Contents: 04:36:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ea1c3d8782387eda185e89038b39b0be80cbf39fab6a4fad455efe988fa3e8d7d72f88bf41e6d99df8e7680357d66319c1b126a04b139e9b6a6eb37b6446bb5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2eff33efb9ddddfcffe5364e8bfa5a63e7ca7c222e67cc78d5241fc15d441cb187fc166ab29a84ca9852ef1946fd9b4d3010081d45610e5820911365073aa391"} 04:36:41 INFO - Running post-run listener: copy_logs_to_upload_dir 04:36:41 INFO - Copying logs to upload dir... 04:36:41 INFO - mkdir: /builds/slave/test/build/upload/logs 04:36:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.574248 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-01 04:36:40.509653) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 04:36:40.513675) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ea1c3d8782387eda185e89038b39b0be80cbf39fab6a4fad455efe988fa3e8d7d72f88bf41e6d99df8e7680357d66319c1b126a04b139e9b6a6eb37b6446bb5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2eff33efb9ddddfcffe5364e8bfa5a63e7ca7c222e67cc78d5241fc15d441cb187fc166ab29a84ca9852ef1946fd9b4d3010081d45610e5820911365073aa391"} 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.011322 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ea1c3d8782387eda185e89038b39b0be80cbf39fab6a4fad455efe988fa3e8d7d72f88bf41e6d99df8e7680357d66319c1b126a04b139e9b6a6eb37b6446bb5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2eff33efb9ddddfcffe5364e8bfa5a63e7ca7c222e67cc78d5241fc15d441cb187fc166ab29a84ca9852ef1946fd9b4d3010081d45610e5820911365073aa391"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 04:36:40.543267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:36:40.543947) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456834304.680273-1654793432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:36:40.628756) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 04:36:40.629130) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 04:36:40.629484) ========= ========= Total master_lag: 0.50 =========