builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-067 starttime: 1455597206.11 results: success (0) buildid: 20160215195750 builduid: 82eda6d8b1dc4cb0bd12653bc61631d3 revision: fb7ceaf4b009243423cdaf1077adbb6c609b22e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:26.114081) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:26.114477) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:26.114792) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006445 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:26.155828) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:26.156127) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:26.223629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:26.223943) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004657 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:26.285749) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:26.286214) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:26.286599) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:26.287104) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-15 20:33:26-- 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% 217M=0s 2016-02-15 20:33:26 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162819 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:26.482452) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:26.482916) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013922 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:26.537611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-15 20:33:26.537914) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fb7ceaf4b009243423cdaf1077adbb6c609b22e5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fb7ceaf4b009243423cdaf1077adbb6c609b22e5 --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=e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-15 20:33:26,776 truncating revision to first 12 chars 2016-02-15 20:33:26,776 Setting DEBUG logging. 2016-02-15 20:33:26,776 attempt 1/10 2016-02-15 20:33:26,776 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fb7ceaf4b009?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-15 20:33:27,609 unpacking tar archive at: fx-team-fb7ceaf4b009/testing/mozharness/ program finished with exit code 0 elapsedTime=1.127615 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-15 20:33:27.679282) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:27.679626) ========= echo fb7ceaf4b009243423cdaf1077adbb6c609b22e5 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'fb7ceaf4b009243423cdaf1077adbb6c609b22e5'] 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=e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False fb7ceaf4b009243423cdaf1077adbb6c609b22e5 program finished with exit code 0 elapsedTime=0.004600 script_repo_revision: 'fb7ceaf4b009243423cdaf1077adbb6c609b22e5' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:27.729042) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:27.729406) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 20:33:27.738968) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-02-15 20:33:27.739246) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:33:28 INFO - MultiFileLogger online at 20160215 20:33:28 in /builds/slave/test 20:33:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 20:33:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:33:28 INFO - {'append_to_log': False, 20:33:28 INFO - 'base_work_dir': '/builds/slave/test', 20:33:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:33:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:33:28 INFO - 'branch': 'Fx-Team-Non-PGO', 20:33:28 INFO - 'buildbot_json_path': 'buildprops.json', 20:33:28 INFO - 'config_files': ('talos/linux_config.py',), 20:33:28 INFO - 'default_actions': ('clobber', 20:33:28 INFO - 'read-buildbot-config', 20:33:28 INFO - 'download-and-extract', 20:33:28 INFO - 'populate-webroot', 20:33:28 INFO - 'create-virtualenv', 20:33:28 INFO - 'install', 20:33:28 INFO - 'run-tests'), 20:33:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:33:28 INFO - 'download_minidump_stackwalk': True, 20:33:28 INFO - 'download_symbols': 'ondemand', 20:33:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:33:28 INFO - 'tooltool.py': '/tools/tooltool.py', 20:33:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:33:28 INFO - '/tools/misc-python/virtualenv.py')}, 20:33:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:33:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:33:28 INFO - 'installer_path': 'installer.exe', 20:33:28 INFO - 'log_level': 'info', 20:33:28 INFO - 'log_name': 'talos', 20:33:28 INFO - 'log_to_console': True, 20:33:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:33:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:33:28 INFO - 'opt_config_files': (), 20:33:28 INFO - 'pip_index': False, 20:33:28 INFO - 'sps_profile': False, 20:33:28 INFO - 'sps_profile_interval': 0, 20:33:28 INFO - 'suite': 'dromaeojs', 20:33:28 INFO - 'system_bits': '32', 20:33:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:33:28 INFO - 'title': 'talos-linux64-ix-067', 20:33:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:33:28 INFO - 'use_talos_json': True, 20:33:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:33:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:33:28 INFO - 'work_dir': 'build'} 20:33:28 INFO - ##### 20:33:28 INFO - ##### Running clobber step. 20:33:28 INFO - ##### 20:33:28 INFO - Running pre-action listener: _resource_record_pre_action 20:33:28 INFO - Running main action method: clobber 20:33:28 INFO - rmtree: /builds/slave/test/build 20:33:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:33:28 INFO - Running post-action listener: _resource_record_post_action 20:33:28 INFO - ##### 20:33:28 INFO - ##### Running read-buildbot-config step. 20:33:28 INFO - ##### 20:33:28 INFO - Running pre-action listener: _resource_record_pre_action 20:33:28 INFO - Running main action method: read_buildbot_config 20:33:28 INFO - Using buildbot properties: 20:33:28 INFO - { 20:33:28 INFO - "project": "", 20:33:28 INFO - "product": "firefox", 20:33:28 INFO - "script_repo_revision": "production", 20:33:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:33:28 INFO - "repository": "", 20:33:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 20:33:28 INFO - "buildid": "20160215195750", 20:33:28 INFO - "pgo_build": "False", 20:33:28 INFO - "basedir": "/builds/slave/test", 20:33:28 INFO - "buildnumber": 2486, 20:33:28 INFO - "slavename": "talos-linux64-ix-067", 20:33:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:33:28 INFO - "platform": "ubuntu64_hw", 20:33:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:33:28 INFO - "branch": "fx-team", 20:33:28 INFO - "repo_path": "integration/fx-team", 20:33:28 INFO - "revision": "fb7ceaf4b009243423cdaf1077adbb6c609b22e5", 20:33:28 INFO - "stage_platform": "linux64", 20:33:28 INFO - "builduid": "82eda6d8b1dc4cb0bd12653bc61631d3", 20:33:28 INFO - "slavebuilddir": "test" 20:33:28 INFO - } 20:33:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 20:33:28 INFO - Running post-action listener: _resource_record_post_action 20:33:28 INFO - ##### 20:33:28 INFO - ##### Running download-and-extract step. 20:33:28 INFO - ##### 20:33:28 INFO - Running pre-action listener: _resource_record_pre_action 20:33:28 INFO - Running main action method: download_and_extract 20:33:28 INFO - mkdir: /builds/slave/test/build/tests 20:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:33:28 INFO - https://queue.taskcluster.net/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:33:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/test_packages.json 20:33:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/test_packages.json 20:33:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:33:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:33:32 INFO - Downloaded 1448 bytes. 20:33:32 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:33:32 INFO - Using the following test package requirements: 20:33:32 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 20:33:32 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:32 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:33:32 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:32 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:33:32 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:32 INFO - u'jsshell-linux-x86_64.zip'], 20:33:32 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:32 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:33:32 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 20:33:32 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:32 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:33:32 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:32 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:33:32 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:32 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:33:32 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 20:33:32 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:32 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:33:32 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:33:32 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')]} 20:33:32 INFO - https://queue.taskcluster.net/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:33:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:33:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:33:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/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 20:33:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/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 20:33:33 INFO - Downloaded 22027537 bytes. 20:33:33 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'] 20:33:33 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 20:33:34 INFO - Return code: 0 20:33:34 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 20:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:33:34 INFO - https://queue.taskcluster.net/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:33:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:33:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:33:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/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 20:33:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/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 20:33:35 INFO - Downloaded 22027537 bytes. 20:33:35 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'] 20:33:35 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 20:33:37 INFO - Return code: 0 20:33: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')]} 20:33:37 INFO - https://queue.taskcluster.net/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:33:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 20:33:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 20:33:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/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 20:33:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/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 20:33:38 INFO - Downloaded 10707070 bytes. 20:33:38 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'] 20:33:38 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 20:33:38 INFO - Return code: 0 20:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:33:38 INFO - https://queue.taskcluster.net/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:33:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:33:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:33:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/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 20:33:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/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 20:34:10 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2: The read operation timed out 20:34:10 INFO - retry: attempt #1 caught exception: The read operation timed out 20:34:10 INFO - retry: Failed, sleeping 30 seconds before retrying 20:34:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfgprqkfRfe845VEbd9slQ/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 #2 20:34:42 INFO - Downloaded 54721849 bytes. 20:34:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:34:42 INFO - mkdir: /builds/slave/test/properties 20:34:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:34:42 INFO - Writing to file /builds/slave/test/properties/build_url 20:34:42 INFO - Contents: 20:34:42 INFO - build_url:https://queue.taskcluster.net/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:34:42 INFO - Running post-action listener: _resource_record_post_action 20:34:42 INFO - Running post-action listener: set_extra_try_arguments 20:34:42 INFO - ##### 20:34:42 INFO - ##### Running populate-webroot step. 20:34:42 INFO - ##### 20:34:42 INFO - Running pre-action listener: _resource_record_pre_action 20:34:42 INFO - Running main action method: populate_webroot 20:34:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:34:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:34:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:34:42 INFO - '--tppagecycles', 20:34:42 INFO - '7'], 20:34:42 INFO - 'tests': ['tsvgm']}}, 20:34:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:34:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:34:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:34:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 20:34:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:34:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:34:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:34:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:42 INFO - 'talos_options': ['--e10s'], 20:34:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:34:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:42 INFO - 'tests': ['damp', 'tps']}, 20:34:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:42 INFO - 'talos_options': ['--e10s'], 20:34:42 INFO - 'tests': ['damp', 'tps']}, 20:34:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:34:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:34:42 INFO - 'other': {'tests': ['a11yr', 20:34:42 INFO - 'ts_paint', 20:34:42 INFO - 'tpaint', 20:34:42 INFO - 'sessionrestore', 20:34:42 INFO - 'sessionrestore_no_auto_restore']}, 20:34:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:34:42 INFO - 'tests': ['a11yr', 20:34:42 INFO - 'ts_paint', 20:34:42 INFO - 'tpaint', 20:34:42 INFO - 'sessionrestore', 20:34:42 INFO - 'sessionrestore_no_auto_restore']}, 20:34:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:34:42 INFO - 'tests': ['a11yr', 20:34:42 INFO - 'ts_paint', 20:34:42 INFO - 'tpaint', 20:34:42 INFO - 'sessionrestore', 20:34:42 INFO - 'sessionrestore_no_auto_restore']}, 20:34:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:34:42 INFO - 'tests': ['a11yr', 20:34:42 INFO - 'ts_paint', 20:34:42 INFO - 'tpaint', 20:34:42 INFO - 'sessionrestore', 20:34:42 INFO - 'sessionrestore_no_auto_restore']}, 20:34:42 INFO - 'other_l64': {'tests': ['a11yr', 20:34:42 INFO - 'ts_paint', 20:34:42 INFO - 'tpaint', 20:34:42 INFO - 'sessionrestore', 20:34:42 INFO - 'sessionrestore_no_auto_restore']}, 20:34:42 INFO - 'other_nol64': {'tests': ['a11yr', 20:34:42 INFO - 'ts_paint', 20:34:42 INFO - 'tpaint', 20:34:42 INFO - 'sessionrestore', 20:34:42 INFO - 'sessionrestore_no_auto_restore']}, 20:34:42 INFO - 'svgr': {'tests': ['tsvgx', 20:34:42 INFO - 'tsvgr_opacity', 20:34:42 INFO - 'tart', 20:34:42 INFO - 'tscrollx', 20:34:42 INFO - 'cart']}, 20:34:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:34:42 INFO - 'tests': ['tsvgx', 20:34:42 INFO - 'tsvgr_opacity', 20:34:42 INFO - 'tart', 20:34:42 INFO - 'tscrollx', 20:34:42 INFO - 'cart']}, 20:34:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:42 INFO - 'tests': ['tp5o']}, 20:34:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:42 INFO - 'talos_options': ['--e10s'], 20:34:42 INFO - 'tests': ['tp5o']}, 20:34:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:42 INFO - 'talos_options': ['--xperf_path', 20:34:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:34:42 INFO - 'tests': ['tp5n']}, 20:34:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:42 INFO - 'talos_options': ['--e10s', 20:34:42 INFO - '--xperf_path', 20:34:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:34:42 INFO - 'tests': ['tp5n']}}, 20:34:42 INFO - 'talos.zip': {'path': '', 20:34:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:34:42 INFO - Running post-action listener: _resource_record_post_action 20:34:42 INFO - ##### 20:34:42 INFO - ##### Running create-virtualenv step. 20:34:42 INFO - ##### 20:34:42 INFO - Running pre-action listener: _resource_record_pre_action 20:34:42 INFO - Running main action method: create_virtualenv 20:34:42 INFO - Creating virtualenv /builds/slave/test/build/venv 20:34:42 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 20:34:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:34:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:34:42 INFO - Using real prefix '/usr' 20:34:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:34:43 INFO - Installing distribute.............................................................................................................................................................................................done. 20:34:45 INFO - Installing pip.................done. 20:34:45 INFO - Return code: 0 20:34:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:45 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 0x7fbeb09d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca100>, '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 0xdcb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', '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 20:34:45 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 20:34:45 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 20:34:45 INFO - Using env: {'DISPLAY': ':0', 20:34:45 INFO - 'HOME': '/home/cltbld', 20:34:45 INFO - 'LANG': 'en_US.UTF-8', 20:34:45 INFO - 'LANGUAGE': 'en_US:en', 20:34:45 INFO - 'LOGNAME': 'cltbld', 20:34:45 INFO - 'MAIL': '/var/mail/cltbld', 20:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:45 INFO - 'MOZ_NO_REMOTE': '1', 20:34:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:45 INFO - 'NO_EM_RESTART': '1', 20:34:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:45 INFO - 'PWD': '/builds/slave/test', 20:34:45 INFO - 'SHELL': '/bin/bash', 20:34:45 INFO - 'SHLVL': '1', 20:34:45 INFO - 'TERM': 'linux', 20:34:45 INFO - 'TMOUT': '86400', 20:34:45 INFO - 'USER': 'cltbld', 20:34:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', 20:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:45 INFO - '_': '/tools/buildbot/bin/python'} 20:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:45 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 20:34:45 INFO - Cleaning up... 20:34:45 INFO - Return code: 0 20:34:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:45 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 0x7fbeb09d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca100>, '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 0xdcb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', '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 20:34:45 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 20:34:45 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 20:34:45 INFO - Using env: {'DISPLAY': ':0', 20:34:45 INFO - 'HOME': '/home/cltbld', 20:34:45 INFO - 'LANG': 'en_US.UTF-8', 20:34:45 INFO - 'LANGUAGE': 'en_US:en', 20:34:45 INFO - 'LOGNAME': 'cltbld', 20:34:45 INFO - 'MAIL': '/var/mail/cltbld', 20:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:45 INFO - 'MOZ_NO_REMOTE': '1', 20:34:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:45 INFO - 'NO_EM_RESTART': '1', 20:34:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:45 INFO - 'PWD': '/builds/slave/test', 20:34:45 INFO - 'SHELL': '/bin/bash', 20:34:45 INFO - 'SHLVL': '1', 20:34:45 INFO - 'TERM': 'linux', 20:34:45 INFO - 'TMOUT': '86400', 20:34:45 INFO - 'USER': 'cltbld', 20:34:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', 20:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:45 INFO - '_': '/tools/buildbot/bin/python'} 20:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:45 INFO - Downloading/unpacking psutil>=0.7.1 20:34:45 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 20:34:45 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 20:34:45 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 20:34:45 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 20:34:45 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 20:34:45 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 20:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:34:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:34:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:34:47 INFO - Installing collected packages: psutil 20:34:47 INFO - Running setup.py install for psutil 20:34:47 INFO - building 'psutil._psutil_linux' extension 20:34:47 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 20:34:47 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 20:34:47 INFO - building 'psutil._psutil_posix' extension 20:34:47 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 20:34:48 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 20:34:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:34:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:34:48 INFO - Successfully installed psutil 20:34:48 INFO - Cleaning up... 20:34:48 INFO - Return code: 0 20:34:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbeb09d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca100>, '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 0xdcb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', '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 20:34:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:34:48 INFO - Using env: {'DISPLAY': ':0', 20:34:48 INFO - 'HOME': '/home/cltbld', 20:34:48 INFO - 'LANG': 'en_US.UTF-8', 20:34:48 INFO - 'LANGUAGE': 'en_US:en', 20:34:48 INFO - 'LOGNAME': 'cltbld', 20:34:48 INFO - 'MAIL': '/var/mail/cltbld', 20:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:48 INFO - 'MOZ_NO_REMOTE': '1', 20:34:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:48 INFO - 'NO_EM_RESTART': '1', 20:34:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:48 INFO - 'PWD': '/builds/slave/test', 20:34:48 INFO - 'SHELL': '/bin/bash', 20:34:48 INFO - 'SHLVL': '1', 20:34:48 INFO - 'TERM': 'linux', 20:34:48 INFO - 'TMOUT': '86400', 20:34:48 INFO - 'USER': 'cltbld', 20:34:48 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', 20:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:48 INFO - '_': '/tools/buildbot/bin/python'} 20:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:34:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:34:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:34:50 INFO - Installing collected packages: mozsystemmonitor 20:34:50 INFO - Running setup.py install for mozsystemmonitor 20:34:50 INFO - Successfully installed mozsystemmonitor 20:34:50 INFO - Cleaning up... 20:34:50 INFO - Return code: 0 20:34:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbeb09d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca100>, '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 0xdcb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', '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 20:34:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:34:50 INFO - Using env: {'DISPLAY': ':0', 20:34:50 INFO - 'HOME': '/home/cltbld', 20:34:50 INFO - 'LANG': 'en_US.UTF-8', 20:34:50 INFO - 'LANGUAGE': 'en_US:en', 20:34:50 INFO - 'LOGNAME': 'cltbld', 20:34:50 INFO - 'MAIL': '/var/mail/cltbld', 20:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:50 INFO - 'MOZ_NO_REMOTE': '1', 20:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:50 INFO - 'NO_EM_RESTART': '1', 20:34:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:50 INFO - 'PWD': '/builds/slave/test', 20:34:50 INFO - 'SHELL': '/bin/bash', 20:34:50 INFO - 'SHLVL': '1', 20:34:50 INFO - 'TERM': 'linux', 20:34:50 INFO - 'TMOUT': '86400', 20:34:50 INFO - 'USER': 'cltbld', 20:34:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', 20:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:50 INFO - '_': '/tools/buildbot/bin/python'} 20:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:50 INFO - Downloading/unpacking blobuploader==1.2.4 20:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:52 INFO - Downloading blobuploader-1.2.4.tar.gz 20:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:34:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:34:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:53 INFO - Downloading docopt-0.6.1.tar.gz 20:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:34:53 INFO - Installing collected packages: blobuploader, requests, docopt 20:34:53 INFO - Running setup.py install for blobuploader 20:34:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:34:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:34:53 INFO - Running setup.py install for requests 20:34:53 INFO - Running setup.py install for docopt 20:34:53 INFO - Successfully installed blobuploader requests docopt 20:34:53 INFO - Cleaning up... 20:34:53 INFO - Return code: 0 20:34:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:53 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 0x7fbeb09d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca100>, '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 0xdcb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', '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 20:34:53 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 20:34:53 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 20:34:53 INFO - Using env: {'DISPLAY': ':0', 20:34:53 INFO - 'HOME': '/home/cltbld', 20:34:53 INFO - 'LANG': 'en_US.UTF-8', 20:34:53 INFO - 'LANGUAGE': 'en_US:en', 20:34:53 INFO - 'LOGNAME': 'cltbld', 20:34:53 INFO - 'MAIL': '/var/mail/cltbld', 20:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:53 INFO - 'MOZ_NO_REMOTE': '1', 20:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:53 INFO - 'NO_EM_RESTART': '1', 20:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:53 INFO - 'PWD': '/builds/slave/test', 20:34:53 INFO - 'SHELL': '/bin/bash', 20:34:53 INFO - 'SHLVL': '1', 20:34:53 INFO - 'TERM': 'linux', 20:34:53 INFO - 'TMOUT': '86400', 20:34:53 INFO - 'USER': 'cltbld', 20:34:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', 20:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:53 INFO - '_': '/tools/buildbot/bin/python'} 20:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:34:53 INFO - Running setup.py (path:/tmp/pip-PLyZs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:34:54 INFO - Running setup.py (path:/tmp/pip-TFn9jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:34:54 INFO - Running setup.py (path:/tmp/pip-CH2X0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:34:54 INFO - Running setup.py (path:/tmp/pip-bf6x31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:34:54 INFO - Running setup.py (path:/tmp/pip-MB8y4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:34:54 INFO - Running setup.py (path:/tmp/pip-76jUii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:34:54 INFO - Running setup.py (path:/tmp/pip-RZgAdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:34:54 INFO - Running setup.py (path:/tmp/pip-CPNs7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:34:54 INFO - Running setup.py (path:/tmp/pip-ZLuyPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:34:54 INFO - Running setup.py (path:/tmp/pip-KGtErI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:34:54 INFO - Running setup.py (path:/tmp/pip-1u2V9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:34:54 INFO - Running setup.py (path:/tmp/pip-t_QQNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:34:54 INFO - Running setup.py (path:/tmp/pip-uCjTR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:34:54 INFO - Running setup.py (path:/tmp/pip-9a2G7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:54 INFO - Running setup.py (path:/tmp/pip-MBBnBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:34:55 INFO - Running setup.py (path:/tmp/pip-3oe9_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:34:55 INFO - Running setup.py (path:/tmp/pip-IHKVoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:34:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:34:55 INFO - Running setup.py install for manifestparser 20:34:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:34:55 INFO - Running setup.py install for mozcrash 20:34:55 INFO - Running setup.py install for mozdebug 20:34:55 INFO - Running setup.py install for mozdevice 20:34:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:34:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:34:55 INFO - Running setup.py install for mozfile 20:34:55 INFO - Running setup.py install for mozhttpd 20:34:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:34:55 INFO - Running setup.py install for mozinfo 20:34:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:34:55 INFO - Running setup.py install for mozInstall 20:34:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:34:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:34:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:34:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:34:55 INFO - Running setup.py install for mozleak 20:34:56 INFO - Running setup.py install for mozlog 20:34:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:34:56 INFO - Running setup.py install for moznetwork 20:34:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:34:56 INFO - Running setup.py install for mozprocess 20:34:56 INFO - Running setup.py install for mozprofile 20:34:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:34:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:34:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:34:56 INFO - Running setup.py install for mozrunner 20:34:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:34:56 INFO - Running setup.py install for mozscreenshot 20:34:56 INFO - Running setup.py install for moztest 20:34:56 INFO - Running setup.py install for mozversion 20:34:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:34:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:34:56 INFO - Cleaning up... 20:34:56 INFO - Return code: 0 20:34:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:56 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 0x7fbeb09d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca100>, '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 0xdcb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', '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 20:34:56 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 20:34:56 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 20:34:56 INFO - Using env: {'DISPLAY': ':0', 20:34:56 INFO - 'HOME': '/home/cltbld', 20:34:56 INFO - 'LANG': 'en_US.UTF-8', 20:34:56 INFO - 'LANGUAGE': 'en_US:en', 20:34:56 INFO - 'LOGNAME': 'cltbld', 20:34:56 INFO - 'MAIL': '/var/mail/cltbld', 20:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:56 INFO - 'MOZ_NO_REMOTE': '1', 20:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:56 INFO - 'NO_EM_RESTART': '1', 20:34:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:56 INFO - 'PWD': '/builds/slave/test', 20:34:56 INFO - 'SHELL': '/bin/bash', 20:34:56 INFO - 'SHLVL': '1', 20:34:56 INFO - 'TERM': 'linux', 20:34:56 INFO - 'TMOUT': '86400', 20:34:56 INFO - 'USER': 'cltbld', 20:34:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', 20:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:56 INFO - '_': '/tools/buildbot/bin/python'} 20:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:34:57 INFO - Running setup.py (path:/tmp/pip-gaH6HL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:34:57 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)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:34:57 INFO - Running setup.py (path:/tmp/pip-9LgN9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:34:57 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)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:34:57 INFO - Running setup.py (path:/tmp/pip-P9TvxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:34:57 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)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:34:57 INFO - Running setup.py (path:/tmp/pip-ikj0zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:34:57 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)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:34:57 INFO - Running setup.py (path:/tmp/pip-Pyb4b0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:34:57 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)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:34:57 INFO - Running setup.py (path:/tmp/pip-zOYsUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:34:57 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)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:34:57 INFO - Running setup.py (path:/tmp/pip-BeB91k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:34:57 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)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:34:57 INFO - Running setup.py (path:/tmp/pip-pPHTYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:34:57 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)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:34:57 INFO - Running setup.py (path:/tmp/pip-O_RZDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:34:57 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)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:34:57 INFO - Running setup.py (path:/tmp/pip-BeFjbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:34:57 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)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:34:57 INFO - Running setup.py (path:/tmp/pip-vas4Dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:34:57 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)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:34:57 INFO - Running setup.py (path:/tmp/pip-caW9gI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:34:58 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)) 20:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:34:58 INFO - Running setup.py (path:/tmp/pip-3REKcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:34:58 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)) 20:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:34:58 INFO - Running setup.py (path:/tmp/pip-aaOHcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:34:58 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)) 20:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:58 INFO - Running setup.py (path:/tmp/pip-BhEoWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:58 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)) 20:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:34:58 INFO - Running setup.py (path:/tmp/pip-ICTzu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:34:58 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)) 20:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:34:58 INFO - Running setup.py (path:/tmp/pip-zaIM9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:34:58 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)) 20:34:58 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)) 20:34:58 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)) 20:34:58 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)) 20:34:58 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)) 20:34:58 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)) 20:34:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:00 INFO - Downloading blessings-1.6.tar.gz 20:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:35:00 INFO - Installing collected packages: blessings 20:35:00 INFO - Running setup.py install for blessings 20:35:00 INFO - Successfully installed blessings 20:35:00 INFO - Cleaning up... 20:35:00 INFO - Return code: 0 20:35:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:35:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:35:00 INFO - Reading from file tmpfile_stdout 20:35:00 INFO - Current package versions: 20:35:00 INFO - argparse == 1.2.1 20:35:00 INFO - blessings == 1.6 20:35:00 INFO - blobuploader == 1.2.4 20:35:00 INFO - docopt == 0.6.1 20:35:00 INFO - manifestparser == 1.1 20:35:00 INFO - mozInstall == 1.12 20:35:00 INFO - mozcrash == 0.16 20:35:00 INFO - mozdebug == 0.1 20:35:00 INFO - mozdevice == 0.48 20:35:00 INFO - mozfile == 1.2 20:35:00 INFO - mozhttpd == 0.7 20:35:00 INFO - mozinfo == 0.9 20:35:00 INFO - mozleak == 0.1 20:35:00 INFO - mozlog == 3.1 20:35:00 INFO - moznetwork == 0.27 20:35:00 INFO - mozprocess == 0.22 20:35:00 INFO - mozprofile == 0.28 20:35:00 INFO - mozrunner == 6.11 20:35:00 INFO - mozscreenshot == 0.1 20:35:00 INFO - mozsystemmonitor == 0.0 20:35:00 INFO - moztest == 0.7 20:35:00 INFO - mozversion == 1.4 20:35:00 INFO - psutil == 3.1.1 20:35:00 INFO - requests == 1.2.3 20:35:00 INFO - wsgiref == 0.1.2 20:35:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:35:00 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')]} 20:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:00 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')]} 20:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:00 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 0x7fbeb09d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca100>, '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 0xdcb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', '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 20:35:00 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 20:35:00 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 20:35:00 INFO - Using env: {'DISPLAY': ':0', 20:35:00 INFO - 'HOME': '/home/cltbld', 20:35:00 INFO - 'LANG': 'en_US.UTF-8', 20:35:00 INFO - 'LANGUAGE': 'en_US:en', 20:35:00 INFO - 'LOGNAME': 'cltbld', 20:35:00 INFO - 'MAIL': '/var/mail/cltbld', 20:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:00 INFO - 'MOZ_NO_REMOTE': '1', 20:35:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:00 INFO - 'NO_EM_RESTART': '1', 20:35:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:00 INFO - 'PWD': '/builds/slave/test', 20:35:00 INFO - 'SHELL': '/bin/bash', 20:35:00 INFO - 'SHLVL': '1', 20:35:00 INFO - 'TERM': 'linux', 20:35:00 INFO - 'TMOUT': '86400', 20:35:00 INFO - 'USER': 'cltbld', 20:35:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', 20:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:00 INFO - '_': '/tools/buildbot/bin/python'} 20:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:00 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)) 20:35:00 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)) 20:35:00 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)) 20:35:00 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)) 20:35:00 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)) 20:35:00 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)) 20:35:00 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)) 20:35:00 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)) 20:35:00 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)) 20:35:00 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)) 20:35:00 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)) 20:35:00 INFO - Cleaning up... 20:35:00 INFO - Return code: 0 20:35:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:35:00 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')]} 20:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:00 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')]} 20:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:00 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 0x7fbeb09d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca100>, '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 0xdcb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', '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 20:35:00 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 20:35:00 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 20:35:00 INFO - Using env: {'DISPLAY': ':0', 20:35:00 INFO - 'HOME': '/home/cltbld', 20:35:00 INFO - 'LANG': 'en_US.UTF-8', 20:35:00 INFO - 'LANGUAGE': 'en_US:en', 20:35:00 INFO - 'LOGNAME': 'cltbld', 20:35:00 INFO - 'MAIL': '/var/mail/cltbld', 20:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:00 INFO - 'MOZ_NO_REMOTE': '1', 20:35:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:00 INFO - 'NO_EM_RESTART': '1', 20:35:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:00 INFO - 'PWD': '/builds/slave/test', 20:35:00 INFO - 'SHELL': '/bin/bash', 20:35:00 INFO - 'SHLVL': '1', 20:35:00 INFO - 'TERM': 'linux', 20:35:00 INFO - 'TMOUT': '86400', 20:35:00 INFO - 'USER': 'cltbld', 20:35:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', 20:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:00 INFO - '_': '/tools/buildbot/bin/python'} 20:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:01 INFO - Downloading/unpacking jsonschema 20:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:35:02 INFO - Downloading/unpacking functools32 (from jsonschema) 20:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:03 INFO - Downloading functools32-3.2.3-2.tar.gz 20:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:35:03 INFO - warning: no files found matching '*.txt' 20:35:03 INFO - no previously-included directories found matching 'build' 20:35:03 INFO - no previously-included directories found matching 'dist' 20:35:03 INFO - no previously-included directories found matching '.git*' 20:35:03 INFO - Installing collected packages: jsonschema, functools32 20:35:03 INFO - Running setup.py install for functools32 20:35:03 INFO - warning: no files found matching '*.txt' 20:35:03 INFO - no previously-included directories found matching 'build' 20:35:03 INFO - no previously-included directories found matching 'dist' 20:35:03 INFO - no previously-included directories found matching '.git*' 20:35:03 INFO - Successfully installed jsonschema functools32 20:35:03 INFO - Cleaning up... 20:35:03 INFO - Return code: 0 20:35:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:35: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')]} 20:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35: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')]} 20:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:03 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 0x7fbeb09d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca100>, '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 0xdcb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', '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 20:35:03 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 20:35:03 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 20:35:03 INFO - Using env: {'DISPLAY': ':0', 20:35:03 INFO - 'HOME': '/home/cltbld', 20:35:03 INFO - 'LANG': 'en_US.UTF-8', 20:35:03 INFO - 'LANGUAGE': 'en_US:en', 20:35:03 INFO - 'LOGNAME': 'cltbld', 20:35:03 INFO - 'MAIL': '/var/mail/cltbld', 20:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:03 INFO - 'MOZ_NO_REMOTE': '1', 20:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:03 INFO - 'NO_EM_RESTART': '1', 20:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:03 INFO - 'PWD': '/builds/slave/test', 20:35:03 INFO - 'SHELL': '/bin/bash', 20:35:03 INFO - 'SHLVL': '1', 20:35:03 INFO - 'TERM': 'linux', 20:35:03 INFO - 'TMOUT': '86400', 20:35:03 INFO - 'USER': 'cltbld', 20:35:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', 20:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:03 INFO - '_': '/tools/buildbot/bin/python'} 20:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:03 INFO - Downloading/unpacking flake8 20:35:03 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 20:35:03 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 20:35:03 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 20:35:03 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 20:35:03 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 20:35:03 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 20:35:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:35:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:35:05 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 20:35:05 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 20:35:05 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 20:35:05 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 20:35:05 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 20:35:05 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 20:35:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:35:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:35:05 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 20:35:05 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 20:35:05 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 20:35:05 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 20:35:05 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 20:35:05 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 20:35:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:35:05 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 20:35:05 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 20:35:05 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 20:35:05 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 20:35:05 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 20:35:05 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 20:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:35:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:35:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:35:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:35:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:35:06 INFO - no previously-included directories found matching 'docs/_build' 20:35:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:35:06 INFO - Running setup.py install for pep8 20:35:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:35:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:35:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:35:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:35:06 INFO - no previously-included directories found matching 'docs/_build' 20:35:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:35:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:35:06 INFO - Cleaning up... 20:35:06 INFO - Return code: 0 20:35:06 INFO - Running post-action listener: _resource_record_post_action 20:35:06 INFO - Running post-action listener: _start_resource_monitoring 20:35:06 INFO - Starting resource monitoring. 20:35:06 INFO - ##### 20:35:06 INFO - ##### Running install step. 20:35:06 INFO - ##### 20:35:06 INFO - Running pre-action listener: _resource_record_pre_action 20:35:06 INFO - Running main action method: install 20:35:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:35:06 INFO - Reading from file tmpfile_stdout 20:35:06 INFO - Detecting whether we're running mozinstall >=1.0... 20:35:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:35:06 INFO - Reading from file tmpfile_stdout 20:35:06 INFO - Output received: 20:35:06 INFO - Usage: mozinstall [options] installer 20:35:06 INFO - Options: 20:35:06 INFO - -h, --help show this help message and exit 20:35:06 INFO - -d DEST, --destination=DEST 20:35:06 INFO - Directory to install application into. [default: 20:35:06 INFO - "/builds/slave/test"] 20:35:06 INFO - --app=APP Application being installed. [default: firefox] 20:35:06 INFO - mkdir: /builds/slave/test/build/application 20:35:06 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'] 20:35:06 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 20:35:22 INFO - Reading from file tmpfile_stdout 20:35:22 INFO - Output received: 20:35:22 INFO - /builds/slave/test/build/application/firefox/firefox 20:35:22 INFO - Running post-action listener: _resource_record_post_action 20:35:22 INFO - ##### 20:35:22 INFO - ##### Running run-tests step. 20:35:22 INFO - ##### 20:35:22 INFO - Running pre-action listener: _resource_record_pre_action 20:35:22 INFO - Running main action method: run_tests 20:35:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:35:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:35:22 INFO - Python 2.7.3 20:35:22 INFO - Return code: 0 20:35:22 INFO - grabbing minidump binary from tooltool 20:35: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')]} 20:35:22 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 0xdca100>, '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 0xdcb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:35:22 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 20:35:22 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 20:35:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:35:22 INFO - Return code: 0 20:35:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:35:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:35:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:35:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:35:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:35:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:35:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:35:23 INFO - Return code: 0 20:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 20:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 20:35:23 INFO - Using env: {'DISPLAY': ':0', 20:35:23 INFO - 'HOME': '/home/cltbld', 20:35:23 INFO - 'LANG': 'en_US.UTF-8', 20:35:23 INFO - 'LANGUAGE': 'en_US:en', 20:35:23 INFO - 'LOGNAME': 'cltbld', 20:35:23 INFO - 'MAIL': '/var/mail/cltbld', 20:35:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:35:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:23 INFO - 'MOZ_NO_REMOTE': '1', 20:35:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:23 INFO - 'NO_EM_RESTART': '1', 20:35:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:23 INFO - 'PWD': '/builds/slave/test', 20:35:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:35:23 INFO - 'SHELL': '/bin/bash', 20:35:23 INFO - 'SHLVL': '1', 20:35:23 INFO - 'TERM': 'linux', 20:35:23 INFO - 'TMOUT': '86400', 20:35:23 INFO - 'USER': 'cltbld', 20:35:23 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608', 20:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:23 INFO - '_': '/tools/buildbot/bin/python'} 20:35:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 20:35:23 INFO - mozversion application_buildid: 20160215195750 20:35:23 INFO - mozversion application_changeset: fb7ceaf4b009243423cdaf1077adbb6c609b22e5 20:35:23 INFO - mozversion application_display_name: Nightly 20:35:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:35:23 INFO - mozversion application_name: Firefox 20:35:23 INFO - mozversion application_remotingname: firefox 20:35:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:35:23 INFO - mozversion application_vendor: Mozilla 20:35:23 INFO - mozversion application_version: 47.0a1 20:35:23 INFO - mozversion platform_buildid: 20160215195750 20:35:23 INFO - mozversion platform_changeset: fb7ceaf4b009243423cdaf1077adbb6c609b22e5 20:35:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:35:23 INFO - mozversion platform_version: 47.0a1 20:35:23 INFO - using testdate: 1455597323 20:35:23 INFO - actual date: 1455597323 20:35:23 INFO - starting webserver on 'localhost:55680' 20:35:23 INFO - SUITE-START | Running 2 tests 20:35:23 INFO - TEST-START | dromaeo_css 20:35:23 INFO - operating with platform_type : linux_ 20:35:23 INFO - Initialising browser for dromaeo_css test... 20:35:23 INFO - TEST-INFO | started process 11800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnKCzhV/profile http://localhost:55680/getInfo.html) 20:35:27 INFO - PROCESS | 11800 | __metrics Screen width/height:1600/1200 20:35:27 INFO - PROCESS | 11800 | colorDepth:24 20:35:27 INFO - PROCESS | 11800 | Browser inner width/height: 1024/697 20:35:27 INFO - PROCESS | 11800 | __metrics 20:35:28 INFO - PROCESS | 11800 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:35:28 INFO - PROCESS | 11800 | 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. 20:35:29 INFO - TEST-INFO | 11800: exit 0 20:35:29 INFO - Browser initialized. 20:35:29 INFO - Running cycle 1/1 for dromaeo_css test... 20:35:29 INFO - TEST-INFO | started process 11894 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnKCzhV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:35:41 INFO - PROCESS | 11894 | RSS: Main: 150401024 20:35:41 INFO - PROCESS | 11894 | 20:36:32 INFO - PROCESS | 11894 | 1455597392460 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] 20:38:43 INFO - PROCESS | 11894 | Cycle 1(1): loaded http://localhost:55680/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55680/tests/dromaeo/cssquery-ext.html) 20:38:44 INFO - PROCESS | 11894 | RSS: Main: 230064128 20:38:44 INFO - PROCESS | 11894 | 20:41:46 INFO - PROCESS | 11894 | Cycle 1(1): loaded http://localhost:55680/tests/dromaeo/cssquery-ext.html (next: http://localhost:55680/tests/dromaeo/cssquery-jquery.html) 20:41:47 INFO - PROCESS | 11894 | RSS: Main: 233824256 20:41:47 INFO - PROCESS | 11894 | 20:44:49 INFO - PROCESS | 11894 | Cycle 1(1): loaded http://localhost:55680/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55680/tests/dromaeo/cssquery-mootools.html) 20:44:50 INFO - PROCESS | 11894 | RSS: Main: 227045376 20:44:50 INFO - PROCESS | 11894 | 20:47:52 INFO - PROCESS | 11894 | Cycle 1(1): loaded http://localhost:55680/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55680/tests/dromaeo/cssquery-prototype.html) 20:47:52 INFO - PROCESS | 11894 | RSS: Main: 217022464 20:47:52 INFO - PROCESS | 11894 | 20:50:55 INFO - PROCESS | 11894 | Cycle 1(1): loaded http://localhost:55680/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55680/tests/dromaeo/cssquery-yui.html) 20:50:56 INFO - PROCESS | 11894 | RSS: Main: 218693632 20:50:56 INFO - PROCESS | 11894 | 20:53:58 INFO - PROCESS | 11894 | Cycle 1(1): loaded http://localhost:55680/tests/dromaeo/cssquery-yui.html (next: http://localhost:55680/tests/dromaeo/cssquery-dojo.html) 20:53:59 INFO - PROCESS | 11894 | RSS: Main: 262217728 20:53:59 INFO - PROCESS | 11894 | 20:53:59 INFO - PROCESS | 11894 | __start_tp_report 20:53:59 INFO - PROCESS | 11894 | _x_x_mozilla_page_load 20:53:59 INFO - PROCESS | 11894 | _x_x_mozilla_page_load_details 20:53:59 INFO - PROCESS | 11894 | |i|pagename|runs| 20:53:59 INFO - PROCESS | 11894 | |0;dojo.html;2591.1190195333584;2661.0686259809067;2662.573988161892;2666.4800363929044;2697.231289082611;4276.807543660535;4383.846565370212;4467.374567560544;4493;4516.480604730453;4420.823167073321;4466.82132714691;4467.620252278561;4569.246074397721;4600.470945841221;4037.9394309085387;4055.290324193269;4056.8985775355704;4084.9387259191135;4248.787560621957;4164.396162556428;4223.070924396628;4232.174725928445;4238.618524332809;4267.573242675723;4054.898627534306;4067.67458603314;4085.9591404085877;4125.834966601333;4175.185838761443;4132.152908653718;4132.380142978577;4143.233501802176;4146.37804329353;4171.374293855915;4121.835126594932;4128.3601041838565;4142.689298302609;4169.999200191932;4179.059711564873;4318.719283246579;4343.239933011742;4400.537943515948;4445.51099379068;4464.151811155903;4788.114198873185;4797.280407938802;4811.326414302001;4825.276208568707;4865.756712164413;4829.396325459317;4838.0082083172865;4844;4845.83039593616;4883.267509873512;4373.978130109329;4455.75493347869;4502.617277531381;4532.342810292555;4578.336141259565;4896.436909755353;4905.190643543847;4914.852554423373;4917.508249175054;4961.925571116436;4599.793009314589;4730.455997560256;4731.881702957454;4735.928961065587;4747.335373047776;4677.906441871143;4721.315409265706;4724.929126063112;4732.574068333866;4779.378680771547;4696.7651617419;4730.881727956828;4730.976345118322;4741.43102827656;4785.952140478551;4607.792649330788;4715.646326525524;4716.575508204278;4721.315409265637;4758.976205119022;4077.368007958771;4097.221527909747;4102.220578090153;4120.526139493996;4138.089620283533;3543.6633519815578;3545.556805399325;3554.9466757998653;3581.7492775505984;3583.5341405617105;4053.1285773558825;4110.876673699734;4151.232022075926;4165.354370072643;4201.096764195712;4724.362211101526;4767.570918617341;4774.116788394089;4777.4983626718695;4816.494268101869;4165.66674666026;4183.435236243129;4193.622573968358;4209.095044565433;4230.196262710076;4197.811098500575;4268.231718290675;4299;4338.240807858612;4384.254676704968;4629.814807407801;4633.443986721615;4642.3036544517245;4652.1626107300335;4664.137134630104;4859.3682821233015;4868.488808675038;4872.561469467623;4877.292792545132;4923.729194894315;4483.080968401535;4536.523665015258;4575.130725162208;4617.191991401559;4621.445426548836;4742.170120229015;4768.237082066853;4772.093302272557;4773.474917758975;4801.087793319258;4824.155772739827;4826;4853.611711063177;4853.632489295694;4896.681715688469;4544.068465964403;4629.86110416688;4665.32352808834;4709.222978208557;4758.643101767312;4686.648501362343;4708;4722.055588882306;4724.834630787906;4761.857144285677;4475.70907890986;4641.3502109703995;4645.767711614473;4661.184292748823;4707.458642256184;4619.630429565559;4696.718196908197;4736.952630473651;4745.83389581363;4790.353302304145;4550.635949124128;4574.1309151262485;4577.702449340783;4583.518730533246;4617.976910115428 20:53:59 INFO - PROCESS | 11894 | |1;ext.html;455.062571103527;485.204265005391;489.74288498538266;498.0884980485711;519.2315373247594;24797.38006549837;25231.243062708127;25263;33020.834895825545;33213.66786332136;36352.818235908846;36827.447588286195;36871.4469282961;36904;36913.26173476529;7542.057242844645;7722.922770772305;7729.227077292254;7730.806729831771;7737.961310193441;7715.614219289041;7839.490433121858;7844.9215507844765;7847.764567062969;7851.136374998746;7807.882881756778;7896.486728362666;7900.881486777703;8101.230383113595;8116.837663246732;7956.2441568050945;8042.597870106471;8044.115147333789;8052.879206811903;8055.879161812548;7874.72438464651;8004.479708818966;8011.599420029033;8016.959915200445;8019.839603207904;36064.819675901716;36165;36613.450798238046;36671.266574668625;36686.449703254475;3071.692830716933;3222.5649537312397;3289.654586268431;3410.84651190697;3472.9131771705656;27607.447851043067;27675.308117297027;27752.861235693894;28479.857600711865;28673.85663071692;3149.4645910195322;3160.5101209312593;3202.6224948469107;3232.3212125453683;3258.771885967983;163656.18062916264;164722;164844;164921;165000;46178.76910615426;47094.76452617715;54715.72642136764;55007.44992550103;56068.43931560714;55122.72438637781;55241.44758552443;55453;55507.72246138824;55550;13861.930690346686;13880.028398012042;13901.513447029305;13923.651908702364;13990.370433330525;9072.54637268134;10717.89282107169;11156;11175.050120739828;11177.552897884156;18087.909560452114;18187.81812181861;18315.542111447056;18330.541736456427;18334.358297459792;7070.8939365909555;7196.460265480006;7314.561126332437;7318.231585683533;7396.408287337;857.4683696108452;893.6246776353947;969.5055521683992;972.5186032913753;984.8621193032981;25996.090136845498;26015.869920650275;26256.60615090775;26282.211533654023;26305.473890522084;950.5864948747317;975.4342481360794;982.1259079419323;1045.4720366215013;1066.3122286125406;13371.866281337258;13677.31613419325;13754.862451375559;13925.651858703613;13933.58199254024;360303;365535;367249;369539;371003;42989.35515967263;43040.56959430428;43068;43090.78454607707;43356.349654755206;1198.2930071258;1227.0858210633135;1241.2242348532168;1242.105683907585;1243.173289762298;26276.211713647856;27204;27286.03620483824;27828.582571261853;27893.72106278911;38952.41571376375;39647.60352396439;39659;39785.403218951156;39841.20317593574;249019;250961;251415;251445;252029;23792.40518987039;28256.15231543057;28911.566326504697;28961.710382896745;29491.262718432212;32912.835435822664;32980.50529242111;33452.832735836164;33760.831195843864;33844.323113538085;28043.579346309412;28309.716902830707;28432.57351139776;28534.857325713238;29356.853215733783;24050.39874003164;30387.848060759556;31832.52251216187;34912.47631285482;35467.82266088653;31370.686293136776;31428.37143257168;31589.36821263608;31687.52468712925;31702;26725.732742672324;28264.682064555644;28349.291267718472;28586;28761.280967975967;22420;22721.659175112716;24446;25740.356491087874;26888 20:53:59 INFO - PROCESS | 11894 | |2;jquery.html;337.5611704783781;338.47198370541946;341.53210102160045;341.9846106925188;344.82586293921565;12035;12418.565350212744;14585.854141458596;14893.925530372346;15848.445304414348;14369.640758981031;14865.777013344808;14926.701465970675;15555.144467054308;15641.139737314443;4660.743659098748;4787.54518320759;4892.119418504668;5029.446760856303;5041.470645582216;4928.97535512322;5016.3227964224725;5017.874553136165;5021.472745361739;5023.171176755849;4705.388299521058;4890.193118135503;4893.14369985253;4895.657303988723;4900.828471003516;4920.926186107211;4920.950790492103;4927.285543596195;4929.433115191745;4974.42794078682;4983.152864013126;4986.925196122061;4987.077390682735;4988.127077761414;5000.274960130797;11179.217454778169;11204.943975280072;11704.297742135499;11717.648470545897;11726.179167458282;1785.3037315446986;1819.3450357871156;1842.8986405747812;1906.9904650476797;2052.363767232148;8556.272716819078;8568.828623427496;8636.697715579925;8823.77940551485;8837.867431988525;1738.4610770661136;1744.7121224997861;1764.0297836190173;1775.8845675031082;1782.5632719983557;48238.961661820606;53919.730401348526;53983;54285.1857222142;54414.727926360116;9561.378510396802;9610.855837162448;9689.41863488179;9705.175060119827;9771.12059914611;11045.447727613588;11188.104951603853;11445.88554114465;12414.62756117318;12433.813492797615;5518.2826232590305;5640.210370548127;6097.542684298695;6969.6515174241085;7016.964915175391;6541.771038013741;6550.410463058348;6718.764843230561;6765.864682706417;6842.726290948306;4009.498812648419;4054.1486287879284;4055.391691246278;4057.472528571267;4090.652294554996;1639.6556723088047;1646.876484263661;1704.2671651190108;1717.4504158669106;1732.7141021731525;826.9793255168669;855.8844555984987;881.5107615273585;965.7743137919243;977.4868194198103;14426.711465770626;14795.852041479448;15102.169380684169;15195.143624509414;15212.771808422882;831.6964308027648;848.8259906719107;885.5483703311357;906.7053207707521;933.071593764209;8608.311335093178;8737.650493980296;8777.517236551923;8801.25189358899;8872.24585910205;363804;397995;445825;450424;452188;58703.70648146732;59563.702181488814;60489;62239;62706.372936270054;1023.918086553074;1026.5124066068558;1027.2963020331097;1042.2027149230844;1043.598214687351;10668.293073108265;12504.374781261082;13237.27195004284;13677.931610341884;13979.231142286864;28981.85509072441;29640.851795740884;29729.405411892072;29996;30594;40606;40769.1846163081;40857.79571102125;40955.795221023705;41354.172916542106;6446.580972236789;6720.563163394364;6725.764598239038;6730.226024007106;6780.355866192704;7966.322862556747;8680.609372578376;8697.826043479221;9964.302498825302;10368.844467333147;8679.826403472021;9001.954990225007;9205.539723013957;9434.245260379015;9465.810683786149;8435.283000944988;8696.956515217384;9077.727668169966;9121.589528471102;9451.480168590793;4852.611791056636;5644.407337229696;7616.743237365773;8488.490690558587;8946.776330591787;6293.811185664437;6413.775517856852;6472.385123413268;6554.737810487527;6808.319168083152;7041.366277035091;8214.876776848232;8299.419040667095;8300.70947516834;8312.293455056146 20:53:59 INFO - PROCESS | 11894 | |3;mootools.html;1208.3173007250907;1354.966125846854;1378.4486205517794;1476.5127507922386;1693.4580934101093;6227.377262273771;7118.8932166017485;7285.235050319707;7294.562326260428;7308.890366644498;7012.474064445161;7165;7177.389921856636;7177.8564428711525;7182;1777.3068503283664;1796.8113348098457;1797.2002458905793;2079.802418770218;2112.13402504973;1817.7091665333548;1823.4256209294097;2118.0151229678195;2150.354893531942;2152.666336717811;2012.8792272463627;2019.0308651847122;2020.1212472574477;2020.979790202094;2046.4167712202025;2108.862923909941;2116.365090472852;2117.100232401239;2118.3750793515874;2118.8622739521884;2044.5297581556176;2074.7199128117813;2089.226986015169;2089.780573039824;2092.5814837032503;7227.988081668571;7307.4884758066955;7313.744018959311;7336.046313979148;7390.7413240536325;4362.781860906942;4447.177272204653;4453.955460445386;4480.036792089716;4487;2800.789940754431;2803.831770093801;2806.9157925262275;2853.0157095802124;2864.914052578426;911.2116922218034;921.4793641592479;933.7665583604099;942.4392486470539;957.8898426680951;9976.301658883882;9979.75050623733;9989.999999999927;10000.199984001263;10012;3968.226195891831;4046.473958385391;4046.838126474967;4083.4487344208746;4152.335626299778;8676.045634980148;8688.78278043054;8693.174148455886;8705.173008564176;8715.52064636451;4476.932846007313;4484.484284307281;4485.46174459067;4486.753228572395;4490.393796837385;4033.749537643281;4054.5337286211875;4055.7566546007333;4057.857974970862;4064.04494943688;3073.6926307369085;3523.5419395478425;3569.5716514017963;3604.9279014419567;3613.747037707335;1005.0753306957616;1006.3257617396362;1010.3533738407425;1124.3928278729559;1169.6374124021581;1173.8180582009802;1180.8051671474282;1185.1170877696172;1199.7000749812546;1200.4897918384827;6806.081179040865;6848.280930502325;6852;6852.45180385568;6855.108835851407;1014.2241185493103;1025.1644909398817;1027.3168343051937;1046.4401545173296;1048.3290693955873;5316.680999140064;5406.486383793534;5406.675599463966;5408.4050754416985;5413.810516631899;8638.13618638131;8866.689665861664;9069.682561110329;9091.590878410487;9214.44713317203;8931.642734290555;8973.461592304482;9065.048169942193;9074.274058075338;9085.273178145733;6939.861202775916;7073.257307982691;7111.466640002124;7133.464990125657;7151.606661633556;6723.899141512783;6746;6763.154605674291;6793.320667933167;6794.66026698673;7804.2585954334245;7927.881081783663;7943.721969731032;8080.111187769223;8105.594720263845;8140.226678465537;8245.464044837066;8254.587270636564;8337.249647531751;8411.032731235742;6427.807165785034;6442.710078046405;6455.515836312202;6486.708098135689;6525.119108920235;7013.649317534205;7067.434605231672;7078.1506219254015;7080.610566418896;7084.114485689289;5562.2212890196215;6019.668918209541;6316.62100273985;6431.710573024132;6462.612243265419;6339.397757213057;6377.202849643794;6451.1290975717675;6517.902231466626;6558.967205163944;6398.168238129014;6407.615543067431;6469.320721324193;6485.805425837232;6486.189226346707;5900.173975643499;5947.672877991579;5953.077273022688;5957.16599676037;5958.612690175125;5900;6085.66528840918;6123.234595675541;6165.383461653978;6181.721822518088 20:53:59 INFO - PROCESS | 11894 | |4;prototype.html;300.24638158222865;300.74436728780535;302.19314430470644;305.5813535456425;306.0985398002881;5034.295198672189;5124.820631277906;5167.5607573356265;5190.961807638478;5191.1953647184655;4979.8008079676765;5072.2391641253835;5103.311053007852;5104.515071068243;5162.045021670993;4034.334334834749;4037.555868854424;4041.6564592009568;4043.1913617276514;4044.1102957349335;3808.7714737115725;3941.2314598653275;4013.7591744495426;4018.959810401888;4048.251073551388;3994.4407782910416;4010.5588385277597;4019.718619696622;4024.6377825995655;4031.1333063391367;4019.216252830699;4023.7988100595;4024.3963405489117;4029.979850100731;4030.536488303824;3547.733919955988;3549.8402571884326;3551.5915669698056;3551.5915669698056;3559.75081744278;4862.975685121552;5028.245763135523;5038.571721403685;5039.143345631215;5049;4616.8153273869;4623.352730617717;4627.629789616823;4634.39752832133;4660.790264438075;5490.121580547133;5493.752781124859;5497.202905578669;5498.725063746837;5501.312335958005;3679.208970071421;3784.2242340320167;3860.903477413059;3867.6076612419506;3869.6323849234277;5649.683629711799;5730.169125476824;5731;5737.08206686928;5759.798407055733;3992.061865461614;4005.8783540608674;4006.6794656427414;4007.6793856491413;4008.7594744315434;4069.959300406958;4076.1236334188293;4078.6737061035046;4079.4288799568085;4079.5920407958965;4508.909821803545;4605.263157894721;4609.746463944448;4612.0545288215835;4619.676622636383;5452.672839629635;5453.345598528202;5459.945400546023;5460.563154947595;5465.9726701367035;1411.3084588551535;1431.8138641976684;1433.806436131109;1434.1108512722178;1434.3688776938113;972.7519482532051;981.2297346582898;985.8225519406576;999.6900960702205;1005.1506477027046;4798.5441383068555;4804.759762011886;4812.085703716282;4813.831515896997;4823.300621409876;5659.971700141556;5660.235868157828;5669.971650141723;5671.489565939003;5677.744501497443;4803.159447096814;4804.783784729696;4807.6394270429855;4810.6632535722165;4812.965212479334;2950.2771820903586;3014.291641464254;3037.4228896509594;3038;3043.0566524377073;5339.3058902342445;5343.599230057761;5347.839564813062;5405.837824865261;5412.134058550613;5791.131330300404;5794.391588883106;5795.9420405796245;5800;5802.129680547867;5330.227117068003;5330.653507521999;5345.091334473149;5346.465353464622;5349.4650534946195;5527.143292789624;5584.0507113789945;5670.291213598301;5674.205611214351;5674.886502270014;5322.840314790563;5459.808906688247;5461.098918678374;5559.193916881949;5574.414686457863;5180.533751962191;5274.077036518517;5281.973590132178;5321.201819726917;5334.866628334323;3824.5601755797325;3833.1758671885677;3836.9616303836606;3837.827297771551;3857.807109644563;5660.066089095253;5661.433856614306;5662.848117715242;5664.405237450009;5664.461876121762;5328.547073498796;5416.7020813855615;5453.727313634382;5456.072467680583;5460.290162278879;5463.754131064191;5470.9179362308805;5471.863203419787;5473.452654734495;5476.479734425223;5372.409035006068;5377.085895397713;5384.380796208487;5386.569074474111;5386.919196212139;5304.283921670525;5489.39616642177;5506.5870059744875;5514.751836167302;5515.393306736176;5406.459354064562;5410.918836217381;5416.593755468277;5416.593755468277;5416.8104116355735 20:53:59 INFO - PROCESS | 11894 | |5;yui.html;666.8166254280076;669.7086767256243;692.3111504053464;723.2767232767233;746.0934964018716;12154;12183.57357492488;12410.069244806653;12423.440945157467;12427.06796990226;12261.693457663541;12275.63173104806;12294.754104917896;12314.199577027486;12326.137170398075;606.0636316890393;613.1324176290543;758.8140905478166;761.3566536276837;772.9729459468906;786.0174781523096;786.3551887452292;790.5138339920936;790.7034861926777;791.1218547412368;825.7192554531458;827.2720006394395;827.5448503323179;827.7433995461396;828.5774255129897;630.9116723658691;792.5601291283364;814.9348052155814;816.0207750699185;816.9714060007931;597.3071237364636;600.2017316968465;602.5149754447712;603.1224568253181;603.1796756411277;12278.938605307005;12741;12744.235345879277;12744.490220391266;12748.426320815586;12020.879791202151;12313.07651926109;12439.502419903192;12588.811167832398;12720.87279127206;9693.176080033205;9783.0706082922;9815.067568580973;9904.108630223314;10094.646687365981;3295.505674148873;3309.6855798699085;3325.617553981299;3411.0278570607506;3418.2479854431986;41865.79067104676;41915.580844191776;41923.37114943278;42072.36891446631;42728;9482.19401350893;9763.072508111718;9768.90231097694;9787.90212097884;9829;17325.306987720604;17360.39238626642;17369.7394539082;17375;17376.304947801946;6583.670816459158;6594.802155935329;6666.133402657721;6685.364890335411;6811;3708.4066549351974;3784.0918179636687;3790.7156963227867;3800.771953682788;3801.657850793442;2720.143154906198;2722.7005029446746;2730.7678847298203;2731.385438276372;2742.3966727319957;458.35829838226084;471.94100737407825;476.7640018191018;479.72895314147394;481.0715319433457;529.6689569019363;564.6781334639217;567.5261156933924;600.2257088356059;625.5839866488825;7860.952201076552;8141.51150930946;8165.510069395856;8239.288924398259;8370.958145209357;526.1502673182782;526.6234642230824;528.735632183908;544.4990608639981;623.6632218601995;3631.8002509862213;3661.1945372018113;4192.727472714264;4250.341197114452;4265.2525152401;45437.318440223426;46094.76952615283;46190.76904615456;46421;46446.5355346449;41587.7920610395;41920.37119443211;42050.78974605107;43021.784891075346;43054;38112.618873811465;38249.808750956065;38629.42055869164;38809.417858732144;39052.41421378682;7724.7682569523;7844.725434609762;7916.208379162268;8109.1485394035135;8141.14517975604;28589.856405743536;28644;28798.856005719837;29070.56394154047;29426.411471770873;36541.81729091337;36913.261734764616;37246.696365627075;37302.626973731;37833.81083094677;10336.638217662347;10595.09941654968;10600.734981625521;10677.466126693478;10714;11477.540898363972;11736.354500502553;11822.290662560274;11835.491618589936;11853.466594003117;10942.069924056545;11070.114390848874;11147.55409783632;11186.776264474827;11563;10848.67453976382;11027;11158.497867595815;11236.606718764804;11722.58970936013;10956.890431095588;11185.440727963407;11273.661790146309;11274.267172634081;11408.94295528517;7345.522541034816;7508.8498230034;7594.392448603988;7794.103678077094;7981.496219657687;8823.250023748053;9109.817803644022;9160.679376222068;9296.302777291596;9432.245420366491 20:53:59 INFO - PROCESS | 11894 | __end_tp_report 20:53:59 INFO - PROCESS | 11894 | __start_cc_report 20:53:59 INFO - PROCESS | 11894 | _x_x_mozilla_cycle_collect,743 20:53:59 INFO - PROCESS | 11894 | __end_cc_report 20:53:59 INFO - PROCESS | 11894 | __startTimestamp1455598439165__endTimestamp 20:53:59 INFO - PROCESS | 11894 | 20:53:59 INFO - PROCESS | 11894 | ------- Summary: start ------- 20:53:59 INFO - PROCESS | 11894 | Number of tests: 6 20:53:59 INFO - PROCESS | 11894 | 20:53:59 INFO - PROCESS | 11894 | [#0] dojo.html Cycles:165 Average:4446.75 Median:4583.52 stddev:445.72 (9.7%) stddev-sans-first:422.65 20:53:59 INFO - PROCESS | 11894 | Values: 2591.1 2661.1 2662.6 2666.5 2697.2 4276.8 4383.8 4467.4 4493.0 4516.5 4420.8 4466.8 4467.6 4569.2 4600.5 4037.9 4055.3 4056.9 4084.9 4248.8 4164.4 4223.1 4232.2 4238.6 4267.6 4054.9 4067.7 4086.0 4125.8 4175.2 4132.2 4132.4 4143.2 4146.4 4171.4 4121.8 4128.4 4142.7 4170.0 4179.1 4318.7 4343.2 4400.5 4445.5 4464.2 4788.1 4797.3 4811.3 4825.3 4865.8 4829.4 4838.0 4844.0 4845.8 4883.3 4374.0 4455.8 4502.6 4532.3 4578.3 4896.4 4905.2 4914.9 4917.5 4961.9 4599.8 4730.5 4731.9 4735.9 4747.3 4677.9 4721.3 4724.9 4732.6 4779.4 4696.8 4730.9 4731.0 4741.4 4786.0 4607.8 4715.6 4716.6 4721.3 4759.0 4077.4 4097.2 4102.2 4120.5 4138.1 3543.7 3545.6 3554.9 3581.7 3583.5 4053.1 4110.9 4151.2 4165.4 4201.1 4724.4 4767.6 4774.1 4777.5 4816.5 4165.7 4183.4 4193.6 4209.1 4230.2 4197.8 4268.2 4299.0 4338.2 4384.3 4629.8 4633.4 4642.3 4652.2 4664.1 4859.4 4868.5 4872.6 4877.3 4923.7 4483.1 4536.5 4575.1 4617.2 4621.4 4742.2 4768.2 4772.1 4773.5 4801.1 4824.2 4826.0 4853.6 4853.6 4896.7 4544.1 4629.9 4665.3 4709.2 4758.6 4686.6 4708.0 4722.1 4724.8 4761.9 4475.7 4641.4 4645.8 4661.2 4707.5 4619.6 4696.7 4737.0 4745.8 4790.4 4550.6 4574.1 4577.7 4583.5 4618.0 20:53:59 INFO - PROCESS | 11894 | 20:53:59 INFO - PROCESS | 11894 | [#1] ext.html Cycles:180 Average:40943.45 Median:32946.67 stddev:72170.88 (219.1%) stddev-sans-first:72309.32 20:53:59 INFO - PROCESS | 11894 | Values: 455.1 485.2 489.7 498.1 519.2 24797.4 25231.2 25263.0 33020.8 33213.7 36352.8 36827.4 36871.4 36904.0 36913.3 7542.1 7722.9 7729.2 7730.8 7738.0 7715.6 7839.5 7844.9 7847.8 7851.1 7807.9 7896.5 7900.9 8101.2 8116.8 7956.2 8042.6 8044.1 8052.9 8055.9 7874.7 8004.5 8011.6 8017.0 8019.8 36064.8 36165.0 36613.5 36671.3 36686.4 3071.7 3222.6 3289.7 3410.8 3472.9 27607.4 27675.3 27752.9 28479.9 28673.9 3149.5 3160.5 3202.6 3232.3 3258.8 163656.2 164722.0 164844.0 164921.0 165000.0 46178.8 47094.8 54715.7 55007.4 56068.4 55122.7 55241.4 55453.0 55507.7 55550.0 13861.9 13880.0 13901.5 13923.7 13990.4 9072.5 10717.9 11156.0 11175.1 11177.6 18087.9 18187.8 18315.5 18330.5 18334.4 7070.9 7196.5 7314.6 7318.2 7396.4 857.5 893.6 969.5 972.5 984.9 25996.1 26015.9 26256.6 26282.2 26305.5 950.6 975.4 982.1 1045.5 1066.3 13371.9 13677.3 13754.9 13925.7 13933.6 360303.0 365535.0 367249.0 369539.0 371003.0 42989.4 43040.6 43068.0 43090.8 43356.3 1198.3 1227.1 1241.2 1242.1 1243.2 26276.2 27204.0 27286.0 27828.6 27893.7 38952.4 39647.6 39659.0 39785.4 39841.2 249019.0 250961.0 251415.0 251445.0 252029.0 23792.4 28256.2 28911.6 28961.7 29491.3 32912.8 32980.5 33452.8 33760.8 33844.3 28043.6 28309.7 28432.6 28534.9 29356.9 24050.4 30387.8 31832.5 34912.5 35467.8 31370.7 31428.4 31589.4 31687.5 31702.0 26725.7 28264.7 28349.3 28586.0 28761.3 22420.0 22721.7 24446.0 25740.4 26888.0 20:53:59 INFO - PROCESS | 11894 | 20:53:59 INFO - PROCESS | 11894 | [#2] jquery.html Cycles:180 Average:22757.90 Median:4951.93 stddev:69275.93 (1399.0%) stddev-sans-first:69449.81 20:53:59 INFO - PROCESS | 11894 | Values: 337.6 338.5 341.5 342.0 344.8 12035.0 12418.6 14585.9 14893.9 15848.4 14369.6 14865.8 14926.7 15555.1 15641.1 4660.7 4787.5 4892.1 5029.4 5041.5 4929.0 5016.3 5017.9 5021.5 5023.2 4705.4 4890.2 4893.1 4895.7 4900.8 4920.9 4921.0 4927.3 4929.4 4974.4 4983.2 4986.9 4987.1 4988.1 5000.3 11179.2 11204.9 11704.3 11717.6 11726.2 1785.3 1819.3 1842.9 1907.0 2052.4 8556.3 8568.8 8636.7 8823.8 8837.9 1738.5 1744.7 1764.0 1775.9 1782.6 48239.0 53919.7 53983.0 54285.2 54414.7 9561.4 9610.9 9689.4 9705.2 9771.1 11045.4 11188.1 11445.9 12414.6 12433.8 5518.3 5640.2 6097.5 6969.7 7017.0 6541.8 6550.4 6718.8 6765.9 6842.7 4009.5 4054.1 4055.4 4057.5 4090.7 1639.7 1646.9 1704.3 1717.5 1732.7 827.0 855.9 881.5 965.8 977.5 14426.7 14795.9 15102.2 15195.1 15212.8 831.7 848.8 885.5 906.7 933.1 8608.3 8737.7 8777.5 8801.3 8872.2 363804.0 397995.0 445825.0 450424.0 452188.0 58703.7 59563.7 60489.0 62239.0 62706.4 1023.9 1026.5 1027.3 1042.2 1043.6 10668.3 12504.4 13237.3 13677.9 13979.2 28981.9 29640.9 29729.4 29996.0 30594.0 40606.0 40769.2 40857.8 40955.8 41354.2 6446.6 6720.6 6725.8 6730.2 6780.4 7966.3 8680.6 8697.8 9964.3 10368.8 8679.8 9002.0 9205.5 9434.2 9465.8 8435.3 8697.0 9077.7 9121.6 9451.5 4852.6 5644.4 7616.7 8488.5 8946.8 6293.8 6413.8 6472.4 6554.7 6808.3 7041.4 8214.9 8299.4 8300.7 8312.3 20:53:59 INFO - PROCESS | 11894 | 20:53:59 INFO - PROCESS | 11894 | [#3] mootools.html Cycles:180 Average:5118.79 Median:6104.45 stddev:2684.71 (44.0%) stddev-sans-first:2676.15 20:53:59 INFO - PROCESS | 11894 | Values: 1208.3 1355.0 1378.4 1476.5 1693.5 6227.4 7118.9 7285.2 7294.6 7308.9 7012.5 7165.0 7177.4 7177.9 7182.0 1777.3 1796.8 1797.2 2079.8 2112.1 1817.7 1823.4 2118.0 2150.4 2152.7 2012.9 2019.0 2020.1 2021.0 2046.4 2108.9 2116.4 2117.1 2118.4 2118.9 2044.5 2074.7 2089.2 2089.8 2092.6 7228.0 7307.5 7313.7 7336.0 7390.7 4362.8 4447.2 4454.0 4480.0 4487.0 2800.8 2803.8 2806.9 2853.0 2864.9 911.2 921.5 933.8 942.4 957.9 9976.3 9979.8 9990.0 10000.2 10012.0 3968.2 4046.5 4046.8 4083.4 4152.3 8676.0 8688.8 8693.2 8705.2 8715.5 4476.9 4484.5 4485.5 4486.8 4490.4 4033.7 4054.5 4055.8 4057.9 4064.0 3073.7 3523.5 3569.6 3604.9 3613.7 1005.1 1006.3 1010.4 1124.4 1169.6 1173.8 1180.8 1185.1 1199.7 1200.5 6806.1 6848.3 6852.0 6852.5 6855.1 1014.2 1025.2 1027.3 1046.4 1048.3 5316.7 5406.5 5406.7 5408.4 5413.8 8638.1 8866.7 9069.7 9091.6 9214.4 8931.6 8973.5 9065.0 9074.3 9085.3 6939.9 7073.3 7111.5 7133.5 7151.6 6723.9 6746.0 6763.2 6793.3 6794.7 7804.3 7927.9 7943.7 8080.1 8105.6 8140.2 8245.5 8254.6 8337.2 8411.0 6427.8 6442.7 6455.5 6486.7 6525.1 7013.6 7067.4 7078.2 7080.6 7084.1 5562.2 6019.7 6316.6 6431.7 6462.6 6339.4 6377.2 6451.1 6517.9 6559.0 6398.2 6407.6 6469.3 6485.8 6486.2 5900.2 5947.7 5953.1 5957.2 5958.6 5900.0 6085.7 6123.2 6165.4 6181.7 20:53:59 INFO - PROCESS | 11894 | 20:53:59 INFO - PROCESS | 11894 | [#4] prototype.html Cycles:180 Average:4533.06 Median:5114.67 stddev:1320.58 (25.8%) stddev-sans-first:1285.50 20:53:59 INFO - PROCESS | 11894 | Values: 300.2 300.7 302.2 305.6 306.1 5034.3 5124.8 5167.6 5191.0 5191.2 4979.8 5072.2 5103.3 5104.5 5162.0 4034.3 4037.6 4041.7 4043.2 4044.1 3808.8 3941.2 4013.8 4019.0 4048.3 3994.4 4010.6 4019.7 4024.6 4031.1 4019.2 4023.8 4024.4 4030.0 4030.5 3547.7 3549.8 3551.6 3551.6 3559.8 4863.0 5028.2 5038.6 5039.1 5049.0 4616.8 4623.4 4627.6 4634.4 4660.8 5490.1 5493.8 5497.2 5498.7 5501.3 3679.2 3784.2 3860.9 3867.6 3869.6 5649.7 5730.2 5731.0 5737.1 5759.8 3992.1 4005.9 4006.7 4007.7 4008.8 4070.0 4076.1 4078.7 4079.4 4079.6 4508.9 4605.3 4609.7 4612.1 4619.7 5452.7 5453.3 5459.9 5460.6 5466.0 1411.3 1431.8 1433.8 1434.1 1434.4 972.8 981.2 985.8 999.7 1005.2 4798.5 4804.8 4812.1 4813.8 4823.3 5660.0 5660.2 5670.0 5671.5 5677.7 4803.2 4804.8 4807.6 4810.7 4813.0 2950.3 3014.3 3037.4 3038.0 3043.1 5339.3 5343.6 5347.8 5405.8 5412.1 5791.1 5794.4 5795.9 5800.0 5802.1 5330.2 5330.7 5345.1 5346.5 5349.5 5527.1 5584.1 5670.3 5674.2 5674.9 5322.8 5459.8 5461.1 5559.2 5574.4 5180.5 5274.1 5282.0 5321.2 5334.9 3824.6 3833.2 3837.0 3837.8 3857.8 5660.1 5661.4 5662.8 5664.4 5664.5 5328.5 5416.7 5453.7 5456.1 5460.3 5463.8 5470.9 5471.9 5473.5 5476.5 5372.4 5377.1 5384.4 5386.6 5386.9 5304.3 5489.4 5506.6 5514.8 5515.4 5406.5 5410.9 5416.6 5416.6 5416.8 20:53:59 INFO - PROCESS | 11894 | 20:53:59 INFO - PROCESS | 11894 | [#5] yui.html Cycles:180 Average:12143.96 Median:23161.36 stddev:13154.00 (56.8%) stddev-sans-first:13162.66 20:53:59 INFO - PROCESS | 11894 | Values: 666.8 669.7 692.3 723.3 746.1 12154.0 12183.6 12410.1 12423.4 12427.1 12261.7 12275.6 12294.8 12314.2 12326.1 606.1 613.1 758.8 761.4 773.0 786.0 786.4 790.5 790.7 791.1 825.7 827.3 827.5 827.7 828.6 630.9 792.6 814.9 816.0 817.0 597.3 600.2 602.5 603.1 603.2 12278.9 12741.0 12744.2 12744.5 12748.4 12020.9 12313.1 12439.5 12588.8 12720.9 9693.2 9783.1 9815.1 9904.1 10094.6 3295.5 3309.7 3325.6 3411.0 3418.2 41865.8 41915.6 41923.4 42072.4 42728.0 9482.2 9763.1 9768.9 9787.9 9829.0 17325.3 17360.4 17369.7 17375.0 17376.3 6583.7 6594.8 6666.1 6685.4 6811.0 3708.4 3784.1 3790.7 3800.8 3801.7 2720.1 2722.7 2730.8 2731.4 2742.4 458.4 471.9 476.8 479.7 481.1 529.7 564.7 567.5 600.2 625.6 7861.0 8141.5 8165.5 8239.3 8371.0 526.2 526.6 528.7 544.5 623.7 3631.8 3661.2 4192.7 4250.3 4265.3 45437.3 46094.8 46190.8 46421.0 46446.5 41587.8 41920.4 42050.8 43021.8 43054.0 38112.6 38249.8 38629.4 38809.4 39052.4 7724.8 7844.7 7916.2 8109.1 8141.1 28589.9 28644.0 28798.9 29070.6 29426.4 36541.8 36913.3 37246.7 37302.6 37833.8 10336.6 10595.1 10600.7 10677.5 10714.0 11477.5 11736.4 11822.3 11835.5 11853.5 10942.1 11070.1 11147.6 11186.8 11563.0 10848.7 11027.0 11158.5 11236.6 11722.6 10956.9 11185.4 11273.7 11274.3 11408.9 7345.5 7508.8 7594.4 7794.1 7981.5 8823.3 9109.8 9160.7 9296.3 9432.2 20:53:59 INFO - PROCESS | 11894 | -------- Summary: end -------- 20:53:59 INFO - PROCESS | 11894 | 20:53:59 INFO - TEST-INFO | 11894: exit 0 20:53:59 INFO - TEST-OK | dromaeo_css | took 1116079ms 20:53:59 INFO - TEST-START | kraken 20:53:59 INFO - operating with platform_type : linux_ 20:53:59 INFO - Initialising browser for kraken test... 20:53:59 INFO - TEST-INFO | started process 12070 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN7pnaG/profile http://localhost:55680/getInfo.html) 20:54:03 INFO - PROCESS | 12070 | __metrics Screen width/height:1600/1200 20:54:03 INFO - PROCESS | 12070 | colorDepth:24 20:54:03 INFO - PROCESS | 12070 | Browser inner width/height: 1024/697 20:54:03 INFO - PROCESS | 12070 | __metrics 20:54:04 INFO - PROCESS | 12070 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:54:04 INFO - PROCESS | 12070 | 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. 20:54:05 INFO - TEST-INFO | 12070: exit 0 20:54:05 INFO - Browser initialized. 20:54:05 INFO - Running cycle 1/1 for kraken test... 20:54:05 INFO - TEST-INFO | started process 12152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN7pnaG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:54:17 INFO - PROCESS | 12152 | RSS: Main: 148422656 20:54:17 INFO - PROCESS | 12152 | 20:54:19 INFO - PROCESS | 12152 | Cycle 1(1): loaded http://localhost:55680/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55680/tests/kraken/driver.html?testName=audio-beat-detection) 20:54:20 INFO - PROCESS | 12152 | RSS: Main: 192372736 20:54:20 INFO - PROCESS | 12152 | 20:54:23 INFO - PROCESS | 12152 | Cycle 1(1): loaded http://localhost:55680/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55680/tests/kraken/driver.html?testName=audio-dft) 20:54:23 INFO - PROCESS | 12152 | RSS: Main: 181661696 20:54:23 INFO - PROCESS | 12152 | 20:54:26 INFO - PROCESS | 12152 | Cycle 1(1): loaded http://localhost:55680/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55680/tests/kraken/driver.html?testName=audio-fft) 20:54:27 INFO - PROCESS | 12152 | RSS: Main: 168464384 20:54:27 INFO - PROCESS | 12152 | 20:54:29 INFO - PROCESS | 12152 | Cycle 1(1): loaded http://localhost:55680/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55680/tests/kraken/driver.html?testName=audio-oscillator) 20:54:30 INFO - PROCESS | 12152 | RSS: Main: 167776256 20:54:30 INFO - PROCESS | 12152 | 20:54:32 INFO - PROCESS | 12152 | Cycle 1(1): loaded http://localhost:55680/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55680/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:54:33 INFO - PROCESS | 12152 | RSS: Main: 169889792 20:54:33 INFO - PROCESS | 12152 | 20:54:36 INFO - PROCESS | 12152 | Cycle 1(1): loaded http://localhost:55680/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55680/tests/kraken/driver.html?testName=imaging-darkroom) 20:54:36 INFO - PROCESS | 12152 | RSS: Main: 169803776 20:54:36 INFO - PROCESS | 12152 | 20:54:40 INFO - PROCESS | 12152 | Cycle 1(1): loaded http://localhost:55680/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55680/tests/kraken/driver.html?testName=imaging-desaturate) 20:54:40 INFO - PROCESS | 12152 | RSS: Main: 167546880 20:54:40 INFO - PROCESS | 12152 | 20:54:43 INFO - PROCESS | 12152 | Cycle 1(1): loaded http://localhost:55680/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55680/tests/kraken/driver.html?testName=json-parse-financial) 20:54:44 INFO - PROCESS | 12152 | RSS: Main: 168005632 20:54:44 INFO - PROCESS | 12152 | 20:54:46 INFO - PROCESS | 12152 | Cycle 1(1): loaded http://localhost:55680/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55680/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:54:46 INFO - PROCESS | 12152 | RSS: Main: 179494912 20:54:46 INFO - PROCESS | 12152 | 20:54:48 INFO - PROCESS | 12152 | Cycle 1(1): loaded http://localhost:55680/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55680/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:54:49 INFO - PROCESS | 12152 | RSS: Main: 176570368 20:54:49 INFO - PROCESS | 12152 | 20:54:51 INFO - PROCESS | 12152 | Cycle 1(1): loaded http://localhost:55680/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55680/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:54:51 INFO - PROCESS | 12152 | RSS: Main: 191733760 20:54:51 INFO - PROCESS | 12152 | 20:54:54 INFO - PROCESS | 12152 | Cycle 1(1): loaded http://localhost:55680/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55680/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:54:55 INFO - PROCESS | 12152 | RSS: Main: 195559424 20:54:55 INFO - PROCESS | 12152 | 20:54:57 INFO - PROCESS | 12152 | Cycle 1(1): loaded http://localhost:55680/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55680/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:54:58 INFO - PROCESS | 12152 | RSS: Main: 193835008 20:54:58 INFO - PROCESS | 12152 | 20:55:00 INFO - PROCESS | 12152 | Cycle 1(1): loaded http://localhost:55680/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55680/tests/kraken/driver.html?testName=ai-astar) 20:55:00 INFO - PROCESS | 12152 | RSS: Main: 255324160 20:55:00 INFO - PROCESS | 12152 | 20:55:00 INFO - PROCESS | 12152 | __start_tp_report 20:55:00 INFO - PROCESS | 12152 | _x_x_mozilla_page_load 20:55:00 INFO - PROCESS | 12152 | _x_x_mozilla_page_load_details 20:55:00 INFO - PROCESS | 12152 | |i|pagename|runs| 20:55:00 INFO - PROCESS | 12152 | |0;ai-astar;113;115;108;114;115;115;105;116;115;115 20:55:00 INFO - PROCESS | 12152 | |1;audio-beat-detection;152;130;159;172;132;166;152;146;173;132 20:55:00 INFO - PROCESS | 12152 | |2;audio-dft;165;161;162;161;163;164;162;162;162;163 20:55:00 INFO - PROCESS | 12152 | |3;audio-fft;74;77;103;100;74;73;74;111;92;75 20:55:00 INFO - PROCESS | 12152 | |4;audio-oscillator;98;98;132;95;97;97;143;98;97;132 20:55:00 INFO - PROCESS | 12152 | |5;imaging-gaussian-blur;120;117;114;115;115;115;115;114;114;114 20:55:00 INFO - PROCESS | 12152 | |6;imaging-darkroom;147;146;147;147;147;147;147;146;147;147 20:55:00 INFO - PROCESS | 12152 | |7;imaging-desaturate;98;97;98;97;96;95;95;96;96;95 20:55:00 INFO - PROCESS | 12152 | |8;json-parse-financial;68;69;68;68;68;68;67;78;66;65 20:55:00 INFO - PROCESS | 12152 | |9;json-stringify-tinderbox;71;71;70;71;71;71;71;71;70;71 20:55:00 INFO - PROCESS | 12152 | |10;stanford-crypto-aes;85;85;86;85;85;85;87;85;84;87 20:55:00 INFO - PROCESS | 12152 | |11;stanford-crypto-ccm;129;126;141;123;131;139;124;130;122;121 20:55:00 INFO - PROCESS | 12152 | |12;stanford-crypto-pbkdf2;155;136;152;149;153;138;150;140;155;151 20:55:00 INFO - PROCESS | 12152 | |13;stanford-crypto-sha256-iterative;72;72;71;71;72;71;71;71;75;70 20:55:00 INFO - PROCESS | 12152 | __end_tp_report 20:55:00 INFO - PROCESS | 12152 | __start_cc_report 20:55:00 INFO - PROCESS | 12152 | _x_x_mozilla_cycle_collect,1017 20:55:00 INFO - PROCESS | 12152 | __end_cc_report 20:55:00 INFO - PROCESS | 12152 | __startTimestamp1455598500348__endTimestamp 20:55:00 INFO - PROCESS | 12152 | 20:55:00 INFO - PROCESS | 12152 | ------- Summary: start ------- 20:55:00 INFO - PROCESS | 12152 | Number of tests: 14 20:55:00 INFO - PROCESS | 12152 | 20:55:00 INFO - PROCESS | 12152 | [#0] ai-astar Cycles:10 Average:113.10 Median:115.00 stddev:3.63 (3.2%) stddev-sans-first:3.86 20:55:00 INFO - PROCESS | 12152 | Values: 113.0 115.0 108.0 114.0 115.0 115.0 105.0 116.0 115.0 115.0 20:55:00 INFO - PROCESS | 12152 | 20:55:00 INFO - PROCESS | 12152 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:155.50 stddev:16.34 (10.5%) stddev-sans-first:17.33 20:55:00 INFO - PROCESS | 12152 | Values: 152.0 130.0 159.0 172.0 132.0 166.0 152.0 146.0 173.0 132.0 20:55:00 INFO - PROCESS | 12152 | 20:55:00 INFO - PROCESS | 12152 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.27 (0.8%) stddev-sans-first:0.97 20:55:00 INFO - PROCESS | 12152 | Values: 165.0 161.0 162.0 161.0 163.0 164.0 162.0 162.0 162.0 163.0 20:55:00 INFO - PROCESS | 12152 | 20:55:00 INFO - PROCESS | 12152 | [#3] audio-fft Cycles:10 Average:85.30 Median:74.00 stddev:14.70 (19.9%) stddev-sans-first:15.01 20:55:00 INFO - PROCESS | 12152 | Values: 74.0 77.0 103.0 100.0 74.0 73.0 74.0 111.0 92.0 75.0 20:55:00 INFO - PROCESS | 12152 | 20:55:00 INFO - PROCESS | 12152 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:97.00 stddev:18.87 (19.5%) stddev-sans-first:19.61 20:55:00 INFO - PROCESS | 12152 | Values: 98.0 98.0 132.0 95.0 97.0 97.0 143.0 98.0 97.0 132.0 20:55:00 INFO - PROCESS | 12152 | 20:55:00 INFO - PROCESS | 12152 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.89 (1.6%) stddev-sans-first:0.97 20:55:00 INFO - PROCESS | 12152 | Values: 120.0 117.0 114.0 115.0 115.0 115.0 115.0 114.0 114.0 114.0 20:55:00 INFO - PROCESS | 12152 | 20:55:00 INFO - PROCESS | 12152 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 20:55:00 INFO - PROCESS | 12152 | Values: 147.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 20:55:00 INFO - PROCESS | 12152 | 20:55:00 INFO - PROCESS | 12152 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:1.16 (1.2%) stddev-sans-first:1.05 20:55:00 INFO - PROCESS | 12152 | Values: 98.0 97.0 98.0 97.0 96.0 95.0 95.0 96.0 96.0 95.0 20:55:00 INFO - PROCESS | 12152 | 20:55:00 INFO - PROCESS | 12152 | [#8] json-parse-financial Cycles:10 Average:68.50 Median:68.00 stddev:3.54 (5.2%) stddev-sans-first:3.75 20:55:00 INFO - PROCESS | 12152 | Values: 68.0 69.0 68.0 68.0 68.0 68.0 67.0 78.0 66.0 65.0 20:55:00 INFO - PROCESS | 12152 | 20:55:00 INFO - PROCESS | 12152 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 20:55:00 INFO - PROCESS | 12152 | Values: 71.0 71.0 70.0 71.0 71.0 71.0 71.0 71.0 70.0 71.0 20:55:00 INFO - PROCESS | 12152 | 20:55:00 INFO - PROCESS | 12152 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:0.97 (1.1%) stddev-sans-first:1.01 20:55:00 INFO - PROCESS | 12152 | Values: 85.0 85.0 86.0 85.0 85.0 85.0 87.0 85.0 84.0 87.0 20:55:00 INFO - PROCESS | 12152 | 20:55:00 INFO - PROCESS | 12152 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:129.50 stddev:6.92 (5.3%) stddev-sans-first:7.33 20:55:00 INFO - PROCESS | 12152 | Values: 129.0 126.0 141.0 123.0 131.0 139.0 124.0 130.0 122.0 121.0 20:55:00 INFO - PROCESS | 12152 | 20:55:00 INFO - PROCESS | 12152 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:151.50 stddev:7.16 (4.7%) stddev-sans-first:7.11 20:55:00 INFO - PROCESS | 12152 | Values: 155.0 136.0 152.0 149.0 153.0 138.0 150.0 140.0 155.0 151.0 20:55:00 INFO - PROCESS | 12152 | 20:55:00 INFO - PROCESS | 12152 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:71.50 stddev:1.35 (1.9%) stddev-sans-first:1.42 20:55:00 INFO - PROCESS | 12152 | Values: 72.0 72.0 71.0 71.0 72.0 71.0 71.0 71.0 75.0 70.0 20:55:00 INFO - PROCESS | 12152 | -------- Summary: end -------- 20:55:00 INFO - PROCESS | 12152 | 20:55:01 INFO - TEST-INFO | 12152: exit 0 20:55:01 INFO - TEST-OK | kraken | took 61407ms 20:55:01 INFO - SUITE-END | took 1177s 20:55:01 INFO - Completed test suite (00:19:37) 20:55:01 INFO - Working with test: dromaeo_css 20:55:01 INFO - Generating results file: dromaeo_css 20:55:01 INFO - Working with test: kraken 20:55:01 INFO - Generating results file: kraken 20:55:01 INFO - javascript benchmark 20:55:01 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:55:01 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 20:55:01 INFO - process_Request line: dromaeo_css 6109.22 graph.html#tests=[[72,132,35]] 20:55:01 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:55:01 INFO - process_Request line: kraken 1552.20 graph.html#tests=[[232,132,35]] 20:55:01 INFO - RETURN: dromaeo_css: 6109.22 20:55:01 INFO - RETURN: kraken: 1552.20 20:55:01 INFO - javascript benchmark 20:55:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2591.1190195333584, 2661.0686259809067, 2662.573988161892, 2666.4800363929044, 2697.231289082611, 4276.807543660535, 4383.846565370212, 4467.374567560544, 4493.0, 4516.480604730453, 4420.823167073321, 4466.82132714691, 4467.620252278561, 4569.246074397721, 4600.470945841221, 4037.9394309085387, 4055.290324193269, 4056.8985775355704, 4084.9387259191135, 4248.787560621957, 4164.396162556428, 4223.070924396628, 4232.174725928445, 4238.618524332809, 4267.573242675723, 4054.898627534306, 4067.67458603314, 4085.9591404085877, 4125.834966601333, 4175.185838761443, 4132.152908653718, 4132.380142978577, 4143.233501802176, 4146.37804329353, 4171.374293855915, 4121.835126594932, 4128.3601041838565, 4142.689298302609, 4169.999200191932, 4179.059711564873, 4318.719283246579, 4343.239933011742, 4400.537943515948, 4445.51099379068, 4464.151811155903, 4788.114198873185, 4797.280407938802, 4811.326414302001, 4825.276208568707, 4865.756712164413, 4829.396325459317, 4838.0082083172865, 4844.0, 4845.83039593616, 4883.267509873512, 4373.978130109329, 4455.75493347869, 4502.617277531381, 4532.342810292555, 4578.336141259565, 4896.436909755353, 4905.190643543847, 4914.852554423373, 4917.508249175054, 4961.925571116436, 4599.793009314589, 4730.455997560256, 4731.881702957454, 4735.928961065587, 4747.335373047776, 4677.906441871143, 4721.315409265706, 4724.929126063112, 4732.574068333866, 4779.378680771547, 4696.7651617419, 4730.881727956828, 4730.976345118322, 4741.43102827656, 4785.952140478551, 4607.792649330788, 4715.646326525524, 4716.575508204278, 4721.315409265637, 4758.976205119022, 4077.368007958771, 4097.221527909747, 4102.220578090153, 4120.526139493996, 4138.089620283533, 3543.6633519815578, 3545.556805399325, 3554.9466757998653, 3581.7492775505984, 3583.5341405617105, 4053.1285773558825, 4110.876673699734, 4151.232022075926, 4165.354370072643, 4201.096764195712, 4724.362211101526, 4767.570918617341, 4774.116788394089, 4777.4983626718695, 4816.494268101869, 4165.66674666026, 4183.435236243129, 4193.622573968358, 4209.095044565433, 4230.196262710076, 4197.811098500575, 4268.231718290675, 4299.0, 4338.240807858612, 4384.254676704968, 4629.814807407801, 4633.443986721615, 4642.3036544517245, 4652.1626107300335, 4664.137134630104, 4859.3682821233015, 4868.488808675038, 4872.561469467623, 4877.292792545132, 4923.729194894315, 4483.080968401535, 4536.523665015258, 4575.130725162208, 4617.191991401559, 4621.445426548836, 4742.170120229015, 4768.237082066853, 4772.093302272557, 4773.474917758975, 4801.087793319258, 4824.155772739827, 4826.0, 4853.611711063177, 4853.632489295694, 4896.681715688469, 4544.068465964403, 4629.86110416688, 4665.32352808834, 4709.222978208557, 4758.643101767312, 4686.648501362343, 4708.0, 4722.055588882306, 4724.834630787906, 4761.857144285677, 4475.70907890986, 4641.3502109703995, 4645.767711614473, 4661.184292748823, 4707.458642256184, 4619.630429565559, 4696.718196908197, 4736.952630473651, 4745.83389581363, 4790.353302304145, 4550.635949124128, 4574.1309151262485, 4577.702449340783, 4583.518730533246, 4617.976910115428], "unit": "score", "name": "dojo.html", "value": 4420.3558612702245}, {"lowerIsBetter": false, "replicates": [455.062571103527, 485.204265005391, 489.74288498538266, 498.0884980485711, 519.2315373247594, 24797.38006549837, 25231.243062708127, 25263.0, 33020.834895825545, 33213.66786332136, 36352.818235908846, 36827.447588286195, 36871.4469282961, 36904.0, 36913.26173476529, 7542.057242844645, 7722.922770772305, 7729.227077292254, 7730.806729831771, 7737.961310193441, 7715.614219289041, 7839.490433121858, 7844.9215507844765, 7847.764567062969, 7851.136374998746, 7807.882881756778, 7896.486728362666, 7900.881486777703, 8101.230383113595, 8116.837663246732, 7956.2441568050945, 8042.597870106471, 8044.115147333789, 8052.879206811903, 8055.879161812548, 7874.72438464651, 8004.479708818966, 8011.599420029033, 8016.959915200445, 8019.839603207904, 36064.819675901716, 36165.0, 36613.450798238046, 36671.266574668625, 36686.449703254475, 3071.692830716933, 3222.5649537312397, 3289.654586268431, 3410.84651190697, 3472.9131771705656, 27607.447851043067, 27675.308117297027, 27752.861235693894, 28479.857600711865, 28673.85663071692, 3149.4645910195322, 3160.5101209312593, 3202.6224948469107, 3232.3212125453683, 3258.771885967983, 163656.18062916264, 164722.0, 164844.0, 164921.0, 165000.0, 46178.76910615426, 47094.76452617715, 54715.72642136764, 55007.44992550103, 56068.43931560714, 55122.72438637781, 55241.44758552443, 55453.0, 55507.72246138824, 55550.0, 13861.930690346686, 13880.028398012042, 13901.513447029305, 13923.651908702364, 13990.370433330525, 9072.54637268134, 10717.89282107169, 11156.0, 11175.050120739828, 11177.552897884156, 18087.909560452114, 18187.81812181861, 18315.542111447056, 18330.541736456427, 18334.358297459792, 7070.8939365909555, 7196.460265480006, 7314.561126332437, 7318.231585683533, 7396.408287337, 857.4683696108452, 893.6246776353947, 969.5055521683992, 972.5186032913753, 984.8621193032981, 25996.090136845498, 26015.869920650275, 26256.60615090775, 26282.211533654023, 26305.473890522084, 950.5864948747317, 975.4342481360794, 982.1259079419323, 1045.4720366215013, 1066.3122286125406, 13371.866281337258, 13677.31613419325, 13754.862451375559, 13925.651858703613, 13933.58199254024, 360303.0, 365535.0, 367249.0, 369539.0, 371003.0, 42989.35515967263, 43040.56959430428, 43068.0, 43090.78454607707, 43356.349654755206, 1198.2930071258, 1227.0858210633135, 1241.2242348532168, 1242.105683907585, 1243.173289762298, 26276.211713647856, 27204.0, 27286.03620483824, 27828.582571261853, 27893.72106278911, 38952.41571376375, 39647.60352396439, 39659.0, 39785.403218951156, 39841.20317593574, 249019.0, 250961.0, 251415.0, 251445.0, 252029.0, 23792.40518987039, 28256.15231543057, 28911.566326504697, 28961.710382896745, 29491.262718432212, 32912.835435822664, 32980.50529242111, 33452.832735836164, 33760.831195843864, 33844.323113538085, 28043.579346309412, 28309.716902830707, 28432.57351139776, 28534.857325713238, 29356.853215733783, 24050.39874003164, 30387.848060759556, 31832.52251216187, 34912.47631285482, 35467.82266088653, 31370.686293136776, 31428.37143257168, 31589.36821263608, 31687.52468712925, 31702.0, 26725.732742672324, 28264.682064555644, 28349.291267718472, 28586.0, 28761.280967975967, 22420.0, 22721.659175112716, 24446.0, 25740.356491087874, 26888.0], "unit": "score", "name": "ext.html", "value": 16368.074971676746}, {"lowerIsBetter": false, "replicates": [337.5611704783781, 338.47198370541946, 341.53210102160045, 341.9846106925188, 344.82586293921565, 12035.0, 12418.565350212744, 14585.854141458596, 14893.925530372346, 15848.445304414348, 14369.640758981031, 14865.777013344808, 14926.701465970675, 15555.144467054308, 15641.139737314443, 4660.743659098748, 4787.54518320759, 4892.119418504668, 5029.446760856303, 5041.470645582216, 4928.97535512322, 5016.3227964224725, 5017.874553136165, 5021.472745361739, 5023.171176755849, 4705.388299521058, 4890.193118135503, 4893.14369985253, 4895.657303988723, 4900.828471003516, 4920.926186107211, 4920.950790492103, 4927.285543596195, 4929.433115191745, 4974.42794078682, 4983.152864013126, 4986.925196122061, 4987.077390682735, 4988.127077761414, 5000.274960130797, 11179.217454778169, 11204.943975280072, 11704.297742135499, 11717.648470545897, 11726.179167458282, 1785.3037315446986, 1819.3450357871156, 1842.8986405747812, 1906.9904650476797, 2052.363767232148, 8556.272716819078, 8568.828623427496, 8636.697715579925, 8823.77940551485, 8837.867431988525, 1738.4610770661136, 1744.7121224997861, 1764.0297836190173, 1775.8845675031082, 1782.5632719983557, 48238.961661820606, 53919.730401348526, 53983.0, 54285.1857222142, 54414.727926360116, 9561.378510396802, 9610.855837162448, 9689.41863488179, 9705.175060119827, 9771.12059914611, 11045.447727613588, 11188.104951603853, 11445.88554114465, 12414.62756117318, 12433.813492797615, 5518.2826232590305, 5640.210370548127, 6097.542684298695, 6969.6515174241085, 7016.964915175391, 6541.771038013741, 6550.410463058348, 6718.764843230561, 6765.864682706417, 6842.726290948306, 4009.498812648419, 4054.1486287879284, 4055.391691246278, 4057.472528571267, 4090.652294554996, 1639.6556723088047, 1646.876484263661, 1704.2671651190108, 1717.4504158669106, 1732.7141021731525, 826.9793255168669, 855.8844555984987, 881.5107615273585, 965.7743137919243, 977.4868194198103, 14426.711465770626, 14795.852041479448, 15102.169380684169, 15195.143624509414, 15212.771808422882, 831.6964308027648, 848.8259906719107, 885.5483703311357, 906.7053207707521, 933.071593764209, 8608.311335093178, 8737.650493980296, 8777.517236551923, 8801.25189358899, 8872.24585910205, 363804.0, 397995.0, 445825.0, 450424.0, 452188.0, 58703.70648146732, 59563.702181488814, 60489.0, 62239.0, 62706.372936270054, 1023.918086553074, 1026.5124066068558, 1027.2963020331097, 1042.2027149230844, 1043.598214687351, 10668.293073108265, 12504.374781261082, 13237.27195004284, 13677.931610341884, 13979.231142286864, 28981.85509072441, 29640.851795740884, 29729.405411892072, 29996.0, 30594.0, 40606.0, 40769.1846163081, 40857.79571102125, 40955.795221023705, 41354.172916542106, 6446.580972236789, 6720.563163394364, 6725.764598239038, 6730.226024007106, 6780.355866192704, 7966.322862556747, 8680.609372578376, 8697.826043479221, 9964.302498825302, 10368.844467333147, 8679.826403472021, 9001.954990225007, 9205.539723013957, 9434.245260379015, 9465.810683786149, 8435.283000944988, 8696.956515217384, 9077.727668169966, 9121.589528471102, 9451.480168590793, 4852.611791056636, 5644.407337229696, 7616.743237365773, 8488.490690558587, 8946.776330591787, 6293.811185664437, 6413.775517856852, 6472.385123413268, 6554.737810487527, 6808.319168083152, 7041.366277035091, 8214.876776848232, 8299.419040667095, 8300.70947516834, 8312.293455056146], "unit": "score", "name": "jquery.html", "value": 7253.857700398335}, {"lowerIsBetter": false, "replicates": [1208.3173007250907, 1354.966125846854, 1378.4486205517794, 1476.5127507922386, 1693.4580934101093, 6227.377262273771, 7118.8932166017485, 7285.235050319707, 7294.562326260428, 7308.890366644498, 7012.474064445161, 7165.0, 7177.389921856636, 7177.8564428711525, 7182.0, 1777.3068503283664, 1796.8113348098457, 1797.2002458905793, 2079.802418770218, 2112.13402504973, 1817.7091665333548, 1823.4256209294097, 2118.0151229678195, 2150.354893531942, 2152.666336717811, 2012.8792272463627, 2019.0308651847122, 2020.1212472574477, 2020.979790202094, 2046.4167712202025, 2108.862923909941, 2116.365090472852, 2117.100232401239, 2118.3750793515874, 2118.8622739521884, 2044.5297581556176, 2074.7199128117813, 2089.226986015169, 2089.780573039824, 2092.5814837032503, 7227.988081668571, 7307.4884758066955, 7313.744018959311, 7336.046313979148, 7390.7413240536325, 4362.781860906942, 4447.177272204653, 4453.955460445386, 4480.036792089716, 4487.0, 2800.789940754431, 2803.831770093801, 2806.9157925262275, 2853.0157095802124, 2864.914052578426, 911.2116922218034, 921.4793641592479, 933.7665583604099, 942.4392486470539, 957.8898426680951, 9976.301658883882, 9979.75050623733, 9989.999999999927, 10000.199984001263, 10012.0, 3968.226195891831, 4046.473958385391, 4046.838126474967, 4083.4487344208746, 4152.335626299778, 8676.045634980148, 8688.78278043054, 8693.174148455886, 8705.173008564176, 8715.52064636451, 4476.932846007313, 4484.484284307281, 4485.46174459067, 4486.753228572395, 4490.393796837385, 4033.749537643281, 4054.5337286211875, 4055.7566546007333, 4057.857974970862, 4064.04494943688, 3073.6926307369085, 3523.5419395478425, 3569.5716514017963, 3604.9279014419567, 3613.747037707335, 1005.0753306957616, 1006.3257617396362, 1010.3533738407425, 1124.3928278729559, 1169.6374124021581, 1173.8180582009802, 1180.8051671474282, 1185.1170877696172, 1199.7000749812546, 1200.4897918384827, 6806.081179040865, 6848.280930502325, 6852.0, 6852.45180385568, 6855.108835851407, 1014.2241185493103, 1025.1644909398817, 1027.3168343051937, 1046.4401545173296, 1048.3290693955873, 5316.680999140064, 5406.486383793534, 5406.675599463966, 5408.4050754416985, 5413.810516631899, 8638.13618638131, 8866.689665861664, 9069.682561110329, 9091.590878410487, 9214.44713317203, 8931.642734290555, 8973.461592304482, 9065.048169942193, 9074.274058075338, 9085.273178145733, 6939.861202775916, 7073.257307982691, 7111.466640002124, 7133.464990125657, 7151.606661633556, 6723.899141512783, 6746.0, 6763.154605674291, 6793.320667933167, 6794.66026698673, 7804.2585954334245, 7927.881081783663, 7943.721969731032, 8080.111187769223, 8105.594720263845, 8140.226678465537, 8245.464044837066, 8254.587270636564, 8337.249647531751, 8411.032731235742, 6427.807165785034, 6442.710078046405, 6455.515836312202, 6486.708098135689, 6525.119108920235, 7013.649317534205, 7067.434605231672, 7078.1506219254015, 7080.610566418896, 7084.114485689289, 5562.2212890196215, 6019.668918209541, 6316.62100273985, 6431.710573024132, 6462.612243265419, 6339.397757213057, 6377.202849643794, 6451.1290975717675, 6517.902231466626, 6558.967205163944, 6398.168238129014, 6407.615543067431, 6469.320721324193, 6485.805425837232, 6486.189226346707, 5900.173975643499, 5947.672877991579, 5953.077273022688, 5957.16599676037, 5958.612690175125, 5900.0, 6085.66528840918, 6123.234595675541, 6165.383461653978, 6181.721822518088], "unit": "score", "name": "mootools.html", "value": 4187.395363878555}, {"lowerIsBetter": false, "replicates": [300.24638158222865, 300.74436728780535, 302.19314430470644, 305.5813535456425, 306.0985398002881, 5034.295198672189, 5124.820631277906, 5167.5607573356265, 5190.961807638478, 5191.1953647184655, 4979.8008079676765, 5072.2391641253835, 5103.311053007852, 5104.515071068243, 5162.045021670993, 4034.334334834749, 4037.555868854424, 4041.6564592009568, 4043.1913617276514, 4044.1102957349335, 3808.7714737115725, 3941.2314598653275, 4013.7591744495426, 4018.959810401888, 4048.251073551388, 3994.4407782910416, 4010.5588385277597, 4019.718619696622, 4024.6377825995655, 4031.1333063391367, 4019.216252830699, 4023.7988100595, 4024.3963405489117, 4029.979850100731, 4030.536488303824, 3547.733919955988, 3549.8402571884326, 3551.5915669698056, 3551.5915669698056, 3559.75081744278, 4862.975685121552, 5028.245763135523, 5038.571721403685, 5039.143345631215, 5049.0, 4616.8153273869, 4623.352730617717, 4627.629789616823, 4634.39752832133, 4660.790264438075, 5490.121580547133, 5493.752781124859, 5497.202905578669, 5498.725063746837, 5501.312335958005, 3679.208970071421, 3784.2242340320167, 3860.903477413059, 3867.6076612419506, 3869.6323849234277, 5649.683629711799, 5730.169125476824, 5731.0, 5737.08206686928, 5759.798407055733, 3992.061865461614, 4005.8783540608674, 4006.6794656427414, 4007.6793856491413, 4008.7594744315434, 4069.959300406958, 4076.1236334188293, 4078.6737061035046, 4079.4288799568085, 4079.5920407958965, 4508.909821803545, 4605.263157894721, 4609.746463944448, 4612.0545288215835, 4619.676622636383, 5452.672839629635, 5453.345598528202, 5459.945400546023, 5460.563154947595, 5465.9726701367035, 1411.3084588551535, 1431.8138641976684, 1433.806436131109, 1434.1108512722178, 1434.3688776938113, 972.7519482532051, 981.2297346582898, 985.8225519406576, 999.6900960702205, 1005.1506477027046, 4798.5441383068555, 4804.759762011886, 4812.085703716282, 4813.831515896997, 4823.300621409876, 5659.971700141556, 5660.235868157828, 5669.971650141723, 5671.489565939003, 5677.744501497443, 4803.159447096814, 4804.783784729696, 4807.6394270429855, 4810.6632535722165, 4812.965212479334, 2950.2771820903586, 3014.291641464254, 3037.4228896509594, 3038.0, 3043.0566524377073, 5339.3058902342445, 5343.599230057761, 5347.839564813062, 5405.837824865261, 5412.134058550613, 5791.131330300404, 5794.391588883106, 5795.9420405796245, 5800.0, 5802.129680547867, 5330.227117068003, 5330.653507521999, 5345.091334473149, 5346.465353464622, 5349.4650534946195, 5527.143292789624, 5584.0507113789945, 5670.291213598301, 5674.205611214351, 5674.886502270014, 5322.840314790563, 5459.808906688247, 5461.098918678374, 5559.193916881949, 5574.414686457863, 5180.533751962191, 5274.077036518517, 5281.973590132178, 5321.201819726917, 5334.866628334323, 3824.5601755797325, 3833.1758671885677, 3836.9616303836606, 3837.827297771551, 3857.807109644563, 5660.066089095253, 5661.433856614306, 5662.848117715242, 5664.405237450009, 5664.461876121762, 5328.547073498796, 5416.7020813855615, 5453.727313634382, 5456.072467680583, 5460.290162278879, 5463.754131064191, 5470.9179362308805, 5471.863203419787, 5473.452654734495, 5476.479734425223, 5372.409035006068, 5377.085895397713, 5384.380796208487, 5386.569074474111, 5386.919196212139, 5304.283921670525, 5489.39616642177, 5506.5870059744875, 5514.751836167302, 5515.393306736176, 5406.459354064562, 5410.918836217381, 5416.593755468277, 5416.593755468277, 5416.8104116355735], "unit": "score", "name": "prototype.html", "value": 4113.186214106413}, {"lowerIsBetter": false, "replicates": [666.8166254280076, 669.7086767256243, 692.3111504053464, 723.2767232767233, 746.0934964018716, 12154.0, 12183.57357492488, 12410.069244806653, 12423.440945157467, 12427.06796990226, 12261.693457663541, 12275.63173104806, 12294.754104917896, 12314.199577027486, 12326.137170398075, 606.0636316890393, 613.1324176290543, 758.8140905478166, 761.3566536276837, 772.9729459468906, 786.0174781523096, 786.3551887452292, 790.5138339920936, 790.7034861926777, 791.1218547412368, 825.7192554531458, 827.2720006394395, 827.5448503323179, 827.7433995461396, 828.5774255129897, 630.9116723658691, 792.5601291283364, 814.9348052155814, 816.0207750699185, 816.9714060007931, 597.3071237364636, 600.2017316968465, 602.5149754447712, 603.1224568253181, 603.1796756411277, 12278.938605307005, 12741.0, 12744.235345879277, 12744.490220391266, 12748.426320815586, 12020.879791202151, 12313.07651926109, 12439.502419903192, 12588.811167832398, 12720.87279127206, 9693.176080033205, 9783.0706082922, 9815.067568580973, 9904.108630223314, 10094.646687365981, 3295.505674148873, 3309.6855798699085, 3325.617553981299, 3411.0278570607506, 3418.2479854431986, 41865.79067104676, 41915.580844191776, 41923.37114943278, 42072.36891446631, 42728.0, 9482.19401350893, 9763.072508111718, 9768.90231097694, 9787.90212097884, 9829.0, 17325.306987720604, 17360.39238626642, 17369.7394539082, 17375.0, 17376.304947801946, 6583.670816459158, 6594.802155935329, 6666.133402657721, 6685.364890335411, 6811.0, 3708.4066549351974, 3784.0918179636687, 3790.7156963227867, 3800.771953682788, 3801.657850793442, 2720.143154906198, 2722.7005029446746, 2730.7678847298203, 2731.385438276372, 2742.3966727319957, 458.35829838226084, 471.94100737407825, 476.7640018191018, 479.72895314147394, 481.0715319433457, 529.6689569019363, 564.6781334639217, 567.5261156933924, 600.2257088356059, 625.5839866488825, 7860.952201076552, 8141.51150930946, 8165.510069395856, 8239.288924398259, 8370.958145209357, 526.1502673182782, 526.6234642230824, 528.735632183908, 544.4990608639981, 623.6632218601995, 3631.8002509862213, 3661.1945372018113, 4192.727472714264, 4250.341197114452, 4265.2525152401, 45437.318440223426, 46094.76952615283, 46190.76904615456, 46421.0, 46446.5355346449, 41587.7920610395, 41920.37119443211, 42050.78974605107, 43021.784891075346, 43054.0, 38112.618873811465, 38249.808750956065, 38629.42055869164, 38809.417858732144, 39052.41421378682, 7724.7682569523, 7844.725434609762, 7916.208379162268, 8109.1485394035135, 8141.14517975604, 28589.856405743536, 28644.0, 28798.856005719837, 29070.56394154047, 29426.411471770873, 36541.81729091337, 36913.261734764616, 37246.696365627075, 37302.626973731, 37833.81083094677, 10336.638217662347, 10595.09941654968, 10600.734981625521, 10677.466126693478, 10714.0, 11477.540898363972, 11736.354500502553, 11822.290662560274, 11835.491618589936, 11853.466594003117, 10942.069924056545, 11070.114390848874, 11147.55409783632, 11186.776264474827, 11563.0, 10848.67453976382, 11027.0, 11158.497867595815, 11236.606718764804, 11722.58970936013, 10956.890431095588, 11185.440727963407, 11273.661790146309, 11274.267172634081, 11408.94295528517, 7345.522541034816, 7508.8498230034, 7594.392448603988, 7794.103678077094, 7981.496219657687, 8823.250023748053, 9109.817803644022, 9160.679376222068, 9296.302777291596, 9432.245420366491], "unit": "score", "name": "yui.html", "value": 5750.751115900929}], "name": "dromaeo_css", "value": 6109.217944413658}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 115.0, 108.0, 114.0, 115.0, 115.0, 105.0, 116.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [152.0, 130.0, 159.0, 172.0, 132.0, 166.0, 152.0, 146.0, 173.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 151.4}, {"lowerIsBetter": true, "replicates": [165.0, 161.0, 162.0, 161.0, 163.0, 164.0, 162.0, 162.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 103.0, 100.0, 74.0, 73.0, 74.0, 111.0, 92.0, 75.0], "unit": "score", "name": "audio-fft", "value": 85.3}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 132.0, 95.0, 97.0, 97.0, 143.0, 98.0, 97.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [120.0, 117.0, 114.0, 115.0, 115.0, 115.0, 115.0, 114.0, 114.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 98.0, 97.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 67.0, 78.0, 66.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 68.5}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 71.0, 71.0, 71.0, 71.0, 71.0, 70.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.8}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 86.0, 85.0, 85.0, 85.0, 87.0, 85.0, 84.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [129.0, 126.0, 141.0, 123.0, 131.0, 139.0, 124.0, 130.0, 122.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.6}, {"lowerIsBetter": true, "replicates": [155.0, 136.0, 152.0, 149.0, 153.0, 138.0, 150.0, 140.0, 155.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 71.0, 72.0, 71.0, 71.0, 71.0, 75.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.6}], "name": "kraken", "value": 1552.1999999999998}]} 20:55:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1552.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6109.22"}}} 20:55:01 INFO - Return code: 0 20:55:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:55:01 INFO - # TBPL SUCCESS # 20:55:01 INFO - Running post-action listener: _resource_record_post_action 20:55:01 INFO - Running post-run listener: _resource_record_post_run 20:55:02 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 24576; Write bytes: 304951296; Read time: 32; Write time: 214520 20:55:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 14589952; Read time: 0; Write time: 14128 20:55:02 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 24576; Write bytes: 289464320; Read time: 32; Write time: 199972 20:55:02 INFO - Running post-run listener: _upload_blobber_files 20:55:02 INFO - Blob upload gear active. 20:55:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:55:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:55:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:55:03 INFO - (blobuploader) - INFO - Open directory for files ... 20:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:55:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:04 INFO - (blobuploader) - INFO - Done attempting. 20:55:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:55:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:55:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:04 INFO - (blobuploader) - INFO - Done attempting. 20:55:04 INFO - (blobuploader) - INFO - Iteration through files over. 20:55:04 INFO - Return code: 0 20:55:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:55:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:55:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/417e8fa79ac6f4f92ab158d1fa491dc6006a5a454eab21d0948438d12e979aa69f0a27c3be5d60c9b32f4cf7e4881b11050c5405d29b9b33d5fbf59cb648f84a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5bcf5066e0dc4a89d317814fba3f224947275a6984e4891873ca94b701926f5563ee45732261003c495656761b661961edc63b32956a7099d428921bc814435"} 20:55:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:55:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:55:04 INFO - Contents: 20:55:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/417e8fa79ac6f4f92ab158d1fa491dc6006a5a454eab21d0948438d12e979aa69f0a27c3be5d60c9b32f4cf7e4881b11050c5405d29b9b33d5fbf59cb648f84a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5bcf5066e0dc4a89d317814fba3f224947275a6984e4891873ca94b701926f5563ee45732261003c495656761b661961edc63b32956a7099d428921bc814435"} 20:55:04 INFO - Running post-run listener: copy_logs_to_upload_dir 20:55:04 INFO - Copying logs to upload dir... 20:55:04 INFO - mkdir: /builds/slave/test/build/upload/logs 20:55:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1297.010776 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-02-15 20:55:04.765629) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-15 20:55:04.768772) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/417e8fa79ac6f4f92ab158d1fa491dc6006a5a454eab21d0948438d12e979aa69f0a27c3be5d60c9b32f4cf7e4881b11050c5405d29b9b33d5fbf59cb648f84a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5bcf5066e0dc4a89d317814fba3f224947275a6984e4891873ca94b701926f5563ee45732261003c495656761b661961edc63b32956a7099d428921bc814435"} build_url:https://queue.taskcluster.net/v1/task/OfgprqkfRfe845VEbd9slQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/OfgprqkfRfe845VEbd9slQ/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/Fx-Team-Non-PGO/sha512/417e8fa79ac6f4f92ab158d1fa491dc6006a5a454eab21d0948438d12e979aa69f0a27c3be5d60c9b32f4cf7e4881b11050c5405d29b9b33d5fbf59cb648f84a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5bcf5066e0dc4a89d317814fba3f224947275a6984e4891873ca94b701926f5563ee45732261003c495656761b661961edc63b32956a7099d428921bc814435"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-15 20:55:04.793165) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 20:55:04.795531) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1455596960.810045-83314608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 20:55:04.879115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 20:55:04.882494) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 20:55:04.882794) ========= ========= Total master_lag: 0.33 =========