builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-089 starttime: 1489416702.53 results: success (0) revision: 419c70029023afa80bee2f534bee483224e303bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-13 07:51:42.531120) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-13 07:51:42.531560) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-13 07:51:42.531828) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-13 07:51:42.546731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 07:51:42.547044) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-13 07:51:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 49.7M=0s 2017-03-13 07:51:42 (49.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153696 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 07:51:42.715387) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 07:51:42.715729) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014800 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 07:51:42.767588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-13 07:51:42.768166) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 419c70029023afa80bee2f534bee483224e303bd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 419c70029023afa80bee2f534bee483224e303bd --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=8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-13 07:51:42,878 truncating revision to first 12 chars 2017-03-13 07:51:42,879 Setting DEBUG logging. 2017-03-13 07:51:42,879 attempt 1/10 2017-03-13 07:51:42,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/419c70029023?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-13 07:51:43,919 unpacking tar archive at: mozilla-central-419c70029023/testing/mozharness/ program finished with exit code 0 elapsedTime=1.352935 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-13 07:51:44.135552) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-13 07:51:44.135857) ========= script_repo_revision: 419c70029023afa80bee2f534bee483224e303bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-13 07:51:44.136302) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-13 07:51:44.136571) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-13 07:51:44.145364) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-13 07:51:44.145733) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:51:44 INFO - MultiFileLogger online at 20170313 07:51:44 in /builds/slave/test 07:51:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:51:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:51:44 INFO - {'append_to_log': False, 07:51:44 INFO - 'base_work_dir': '/builds/slave/test', 07:51:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:51:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:51:44 INFO - 'branch': 'Firefox-Non-PGO', 07:51:44 INFO - 'buildbot_json_path': 'buildprops.json', 07:51:44 INFO - 'config_files': ('talos/linux_config.py',), 07:51:44 INFO - 'default_actions': ('clobber', 07:51:44 INFO - 'read-buildbot-config', 07:51:44 INFO - 'download-and-extract', 07:51:44 INFO - 'populate-webroot', 07:51:44 INFO - 'create-virtualenv', 07:51:44 INFO - 'install', 07:51:44 INFO - 'run-tests'), 07:51:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:51:44 INFO - 'download_minidump_stackwalk': True, 07:51:44 INFO - 'download_symbols': 'ondemand', 07:51:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:51:44 INFO - 'tooltool.py': '/tools/tooltool.py', 07:51:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:51:44 INFO - '/tools/misc-python/virtualenv.py')}, 07:51:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:51:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:51:44 INFO - 'gecko_profile': False, 07:51:44 INFO - 'gecko_profile_interval': 0, 07:51:44 INFO - 'installer_path': 'installer.exe', 07:51:44 INFO - 'log_level': 'info', 07:51:44 INFO - 'log_name': 'talos', 07:51:44 INFO - 'log_to_console': True, 07:51:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:51:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:51:44 INFO - 'opt_config_files': (), 07:51:44 INFO - 'pip_index': False, 07:51:44 INFO - 'suite': 'dromaeojs-e10s', 07:51:44 INFO - 'system_bits': '32', 07:51:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:51:44 INFO - 'title': 'talos-linux64-ix-089', 07:51:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:51:44 INFO - 'use_talos_json': True, 07:51:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:51:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:51:44 INFO - 'work_dir': 'build'} 07:51:44 INFO - [mozharness: 2017-03-13 14:51:44.351192Z] Running clobber step. 07:51:44 INFO - Running pre-action listener: _resource_record_pre_action 07:51:44 INFO - Running main action method: clobber 07:51:44 INFO - rmtree: /builds/slave/test/build 07:51:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:51:45 INFO - Running post-action listener: _resource_record_post_action 07:51:45 INFO - [mozharness: 2017-03-13 14:51:45.786588Z] Finished clobber step (success) 07:51:45 INFO - [mozharness: 2017-03-13 14:51:45.786687Z] Running read-buildbot-config step. 07:51:45 INFO - Running pre-action listener: _resource_record_pre_action 07:51:45 INFO - Running main action method: read_buildbot_config 07:51:45 INFO - Using buildbot properties: 07:51:45 INFO - { 07:51:45 INFO - "project": "", 07:51:45 INFO - "product": "firefox", 07:51:45 INFO - "who": "cbook@mozilla.com", 07:51:45 INFO - "installer_path": "public/build/target.tar.bz2", 07:51:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:51:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:51:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:51:45 INFO - "stage_platform": "linux64", 07:51:45 INFO - "basedir": "/builds/slave/test", 07:51:45 INFO - "buildnumber": 459, 07:51:45 INFO - "platform": "ubuntu64_hw", 07:51:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:51:45 INFO - "slavebuilddir": "test", 07:51:45 INFO - "taskId": "Pquf1bHWR8q2A9VRxoxX2A", 07:51:45 INFO - "branch": "mozilla-central", 07:51:45 INFO - "script_repo_revision": "production", 07:51:45 INFO - "revision": "419c70029023afa80bee2f534bee483224e303bd", 07:51:45 INFO - "slavename": "talos-linux64-ix-089", 07:51:45 INFO - "repo_path": "mozilla-central" 07:51:45 INFO - } 07:51:45 INFO - Finding installer, test and symbols from parent task. 07:51:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pquf1bHWR8q2A9VRxoxX2A'}, attempt #1 07:51:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pquf1bHWR8q2A9VRxoxX2A'}, attempt #1 07:51:46 INFO - Task dependencies: EnFxVZKkSnKX8H9_NSlwfg 07:51:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg'}, attempt #1 07:51:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.tar.bz2 07:51:47 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/test_packages.json 07:51:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.crashreporter-symbols.zip 07:51:47 INFO - Running post-action listener: _resource_record_post_action 07:51:47 INFO - [mozharness: 2017-03-13 14:51:47.216437Z] Finished read-buildbot-config step (success) 07:51:47 INFO - [mozharness: 2017-03-13 14:51:47.216652Z] Running download-and-extract step. 07:51:47 INFO - Running pre-action listener: _resource_record_pre_action 07:51:47 INFO - Running main action method: download_and_extract 07:51:47 INFO - mkdir: /builds/slave/test/build/tests 07:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:47 INFO - trying https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.test_packages.json 07:51:47 INFO - Downloading https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:51:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:51:47 INFO - Downloaded 896 bytes. 07:51:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:51:47 INFO - Using the following test package requirements: 07:51:47 INFO - {u'common': [u'target.common.tests.zip'], 07:51:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:51:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:51:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:51:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:51:47 INFO - u'mozbase': [u'target.common.tests.zip'], 07:51:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:51:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:51:47 INFO - u'web-platform': [u'target.common.tests.zip', 07:51:47 INFO - u'target.web-platform.tests.zip'], 07:51:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:51:47 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:51:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.common.tests.zip 07:51:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:51:47 INFO - Fetch https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.common.tests.zip into memory 07:51:48 INFO - Expected file size: 57499505 07:51:48 INFO - Obtained file size: 57499505 07:51:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:51:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.common.tests.zip 07:51:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:51:58 INFO - Fetch https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.common.tests.zip into memory 07:52:00 INFO - Expected file size: 57499505 07:52:00 INFO - Obtained file size: 57499505 07:52:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.talos.tests.zip 07:52:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:52:10 INFO - Fetch https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.talos.tests.zip into memory 07:52:11 INFO - Expected file size: 14404438 07:52:11 INFO - Obtained file size: 14404438 07:52:11 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:11 INFO - trying https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.tar.bz2 07:52:11 INFO - Downloading https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:52:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:52:12 INFO - Downloaded 61670958 bytes. 07:52:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.tar.bz2 07:52:12 INFO - mkdir: /builds/slave/test/properties 07:52:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:52:12 INFO - Writing to file /builds/slave/test/properties/build_url 07:52:12 INFO - Contents: 07:52:12 INFO - build_url:https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.tar.bz2 07:52:12 INFO - Running post-action listener: _resource_record_post_action 07:52:12 INFO - Running post-action listener: set_extra_try_arguments 07:52:12 INFO - [mozharness: 2017-03-13 14:52:12.751370Z] Finished download-and-extract step (success) 07:52:12 INFO - [mozharness: 2017-03-13 14:52:12.751467Z] Running populate-webroot step. 07:52:12 INFO - Running pre-action listener: _resource_record_pre_action 07:52:12 INFO - Running main action method: populate_webroot 07:52:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:52:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:52:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:52:12 INFO - '--tppagecycles', 07:52:12 INFO - '7'], 07:52:12 INFO - 'tests': ['tsvgm']}}, 07:52:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:52:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:52:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:52:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:52:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:52:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:52:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:52:12 INFO - 'talos_options': ['--disable-e10s'], 07:52:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:52:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:52:12 INFO - 'talos_options': ['--disable-e10s'], 07:52:12 INFO - 'tests': ['damp', 'tps']}, 07:52:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:52:12 INFO - 'tests': ['damp', 'tps']}, 07:52:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:52:12 INFO - 'tests': ['dromaeo_dom']}, 07:52:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:52:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:52:12 INFO - 'tests': ['basic_compositor_video']}, 07:52:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:52:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:52:12 INFO - 'tests': ['a11yr', 07:52:12 INFO - 'ts_paint', 07:52:12 INFO - 'tpaint', 07:52:12 INFO - 'sessionrestore', 07:52:12 INFO - 'sessionrestore_no_auto_restore', 07:52:12 INFO - 'tabpaint']}, 07:52:12 INFO - 'other-e10s': {'tests': ['a11yr', 07:52:12 INFO - 'ts_paint', 07:52:12 INFO - 'tpaint', 07:52:12 INFO - 'sessionrestore', 07:52:12 INFO - 'sessionrestore_no_auto_restore', 07:52:12 INFO - 'tabpaint']}, 07:52:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:52:12 INFO - 'ts_paint', 07:52:12 INFO - 'tpaint', 07:52:12 INFO - 'sessionrestore', 07:52:12 INFO - 'sessionrestore_no_auto_restore', 07:52:12 INFO - 'tabpaint']}, 07:52:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:52:12 INFO - 'ts_paint', 07:52:12 INFO - 'tpaint', 07:52:12 INFO - 'sessionrestore', 07:52:12 INFO - 'sessionrestore_no_auto_restore', 07:52:12 INFO - 'tabpaint']}, 07:52:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:52:12 INFO - 'tests': ['a11yr', 07:52:12 INFO - 'ts_paint', 07:52:12 INFO - 'tpaint', 07:52:12 INFO - 'sessionrestore', 07:52:12 INFO - 'sessionrestore_no_auto_restore', 07:52:12 INFO - 'tabpaint']}, 07:52:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:52:12 INFO - 'tests': ['a11yr', 07:52:12 INFO - 'ts_paint', 07:52:12 INFO - 'tpaint', 07:52:12 INFO - 'sessionrestore', 07:52:12 INFO - 'sessionrestore_no_auto_restore', 07:52:12 INFO - 'tabpaint']}, 07:52:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:52:12 INFO - 'tests': ['tsvgx', 07:52:12 INFO - 'tsvgr_opacity', 07:52:12 INFO - 'tart', 07:52:12 INFO - 'tscrollx', 07:52:12 INFO - 'cart', 07:52:12 INFO - 'tsvg_static']}, 07:52:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:52:12 INFO - 'tsvgr_opacity', 07:52:12 INFO - 'tart', 07:52:12 INFO - 'tscrollx', 07:52:12 INFO - 'cart', 07:52:12 INFO - 'tsvg_static']}, 07:52:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:52:12 INFO - 'talos_options': ['--disable-e10s'], 07:52:12 INFO - 'tests': ['tp5o']}, 07:52:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:52:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:52:12 INFO - 'talos_options': ['--disable-e10s', 07:52:12 INFO - '--xperf_path', 07:52:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:12 INFO - 'tests': ['tp5n']}, 07:52:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:52:12 INFO - 'talos_options': ['--xperf_path', 07:52:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:12 INFO - 'tests': ['tp5n']}}, 07:52:12 INFO - 'talos.zip': {'path': '', 07:52:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:52:12 INFO - Running post-action listener: _resource_record_post_action 07:52:12 INFO - [mozharness: 2017-03-13 14:52:12.764617Z] Finished populate-webroot step (success) 07:52:12 INFO - [mozharness: 2017-03-13 14:52:12.764707Z] Running create-virtualenv step. 07:52:12 INFO - Running pre-action listener: _resource_record_pre_action 07:52:12 INFO - Running main action method: create_virtualenv 07:52:12 INFO - Creating virtualenv /builds/slave/test/build/venv 07:52:12 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 07:52:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:52:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:52:12 INFO - Using real prefix '/usr' 07:52:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:52:13 INFO - Installing distribute.............................................................................................................................................................................................done. 07:52:15 INFO - Installing pip.................done. 07:52:15 INFO - Return code: 0 07:52:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:52:15 INFO - Reading from file tmpfile_stdout 07:52:15 INFO - Output received: 07:52:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:52:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:15 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 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458290>, '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 0x2458b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', '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 07:52:15 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 07:52:15 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 07:52:15 INFO - Using env: {'DISPLAY': ':0', 07:52:15 INFO - 'HOME': '/home/cltbld', 07:52:15 INFO - 'LANG': 'en_US.UTF-8', 07:52:15 INFO - 'LANGUAGE': 'en_US:en', 07:52:15 INFO - 'LOGNAME': 'cltbld', 07:52:15 INFO - 'MAIL': '/var/mail/cltbld', 07:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:15 INFO - 'MOZ_NO_REMOTE': '1', 07:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:15 INFO - 'NO_EM_RESTART': '1', 07:52:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:15 INFO - 'PWD': '/builds/slave/test', 07:52:15 INFO - 'SHELL': '/bin/bash', 07:52:15 INFO - 'SHLVL': '1', 07:52:15 INFO - 'TERM': 'linux', 07:52:15 INFO - 'TMOUT': '86400', 07:52:15 INFO - 'USER': 'cltbld', 07:52:15 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', 07:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:15 INFO - '_': '/tools/buildbot/bin/python'} 07:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:15 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 07:52:15 INFO - Cleaning up... 07:52:15 INFO - Return code: 0 07:52:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:15 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458290>, '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 0x2458b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', '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 07:52:15 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>=3.1.1'] in /builds/slave/test/build 07:52:15 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>=3.1.1 07:52:15 INFO - Using env: {'DISPLAY': ':0', 07:52:15 INFO - 'HOME': '/home/cltbld', 07:52:15 INFO - 'LANG': 'en_US.UTF-8', 07:52:15 INFO - 'LANGUAGE': 'en_US:en', 07:52:15 INFO - 'LOGNAME': 'cltbld', 07:52:15 INFO - 'MAIL': '/var/mail/cltbld', 07:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:15 INFO - 'MOZ_NO_REMOTE': '1', 07:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:15 INFO - 'NO_EM_RESTART': '1', 07:52:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:15 INFO - 'PWD': '/builds/slave/test', 07:52:15 INFO - 'SHELL': '/bin/bash', 07:52:15 INFO - 'SHLVL': '1', 07:52:15 INFO - 'TERM': 'linux', 07:52:15 INFO - 'TMOUT': '86400', 07:52:15 INFO - 'USER': 'cltbld', 07:52:15 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', 07:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:15 INFO - '_': '/tools/buildbot/bin/python'} 07:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:16 INFO - Downloading/unpacking psutil>=3.1.1 07:52:16 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 07:52:16 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 07:52:16 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 07:52:16 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 07:52:16 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 07:52:16 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 07:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:52:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:18 INFO - Installing collected packages: psutil 07:52:18 INFO - Running setup.py install for psutil 07:52:18 INFO - building 'psutil._psutil_linux' extension 07:52:18 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 07:52:18 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 07:52:18 INFO - building 'psutil._psutil_posix' extension 07:52:18 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 07:52:18 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 07:52:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:18 INFO - Successfully installed psutil 07:52:18 INFO - Cleaning up... 07:52:18 INFO - Return code: 0 07:52:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:52:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:18 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458290>, '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 0x2458b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', '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 07:52:18 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.3'] in /builds/slave/test/build 07:52:18 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.3 07:52:18 INFO - Using env: {'DISPLAY': ':0', 07:52:18 INFO - 'HOME': '/home/cltbld', 07:52:18 INFO - 'LANG': 'en_US.UTF-8', 07:52:18 INFO - 'LANGUAGE': 'en_US:en', 07:52:18 INFO - 'LOGNAME': 'cltbld', 07:52:18 INFO - 'MAIL': '/var/mail/cltbld', 07:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:18 INFO - 'MOZ_NO_REMOTE': '1', 07:52:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:18 INFO - 'NO_EM_RESTART': '1', 07:52:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:18 INFO - 'PWD': '/builds/slave/test', 07:52:18 INFO - 'SHELL': '/bin/bash', 07:52:18 INFO - 'SHLVL': '1', 07:52:18 INFO - 'TERM': 'linux', 07:52:18 INFO - 'TMOUT': '86400', 07:52:18 INFO - 'USER': 'cltbld', 07:52:18 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', 07:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:18 INFO - '_': '/tools/buildbot/bin/python'} 07:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:52:19 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 07:52:19 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 07:52:19 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 07:52:19 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 07:52:19 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 07:52:19 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 07:52:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:52:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:52:21 INFO - Installing collected packages: mozsystemmonitor 07:52:21 INFO - Running setup.py install for mozsystemmonitor 07:52:21 INFO - Successfully installed mozsystemmonitor 07:52:21 INFO - Cleaning up... 07:52:21 INFO - Return code: 0 07:52:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:52:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:21 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458290>, '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 0x2458b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', '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 07:52:21 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==2.5.1'] in /builds/slave/test/build 07:52:21 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==2.5.1 07:52:21 INFO - Using env: {'DISPLAY': ':0', 07:52:21 INFO - 'HOME': '/home/cltbld', 07:52:21 INFO - 'LANG': 'en_US.UTF-8', 07:52:21 INFO - 'LANGUAGE': 'en_US:en', 07:52:21 INFO - 'LOGNAME': 'cltbld', 07:52:21 INFO - 'MAIL': '/var/mail/cltbld', 07:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:21 INFO - 'MOZ_NO_REMOTE': '1', 07:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:21 INFO - 'NO_EM_RESTART': '1', 07:52:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:21 INFO - 'PWD': '/builds/slave/test', 07:52:21 INFO - 'SHELL': '/bin/bash', 07:52:21 INFO - 'SHLVL': '1', 07:52:21 INFO - 'TERM': 'linux', 07:52:21 INFO - 'TMOUT': '86400', 07:52:21 INFO - 'USER': 'cltbld', 07:52:21 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', 07:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:21 INFO - '_': '/tools/buildbot/bin/python'} 07:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:21 INFO - Downloading/unpacking jsonschema==2.5.1 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 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 07:52:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:52:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:23 INFO - Downloading functools32-3.2.3-2.tar.gz 07:52:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:52:23 INFO - warning: no files found matching '*.txt' 07:52:23 INFO - no previously-included directories found matching 'build' 07:52:23 INFO - no previously-included directories found matching 'dist' 07:52:23 INFO - no previously-included directories found matching '.git*' 07:52:23 INFO - Installing collected packages: jsonschema, functools32 07:52:23 INFO - Running setup.py install for functools32 07:52:23 INFO - warning: no files found matching '*.txt' 07:52:23 INFO - no previously-included directories found matching 'build' 07:52:23 INFO - no previously-included directories found matching 'dist' 07:52:23 INFO - no previously-included directories found matching '.git*' 07:52:23 INFO - Successfully installed jsonschema functools32 07:52:23 INFO - Cleaning up... 07:52:23 INFO - Return code: 0 07:52:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458290>, '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 0x2458b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', '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 07:52:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:52:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:52:23 INFO - Using env: {'DISPLAY': ':0', 07:52:23 INFO - 'HOME': '/home/cltbld', 07:52:23 INFO - 'LANG': 'en_US.UTF-8', 07:52:23 INFO - 'LANGUAGE': 'en_US:en', 07:52:23 INFO - 'LOGNAME': 'cltbld', 07:52:23 INFO - 'MAIL': '/var/mail/cltbld', 07:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:23 INFO - 'MOZ_NO_REMOTE': '1', 07:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:23 INFO - 'NO_EM_RESTART': '1', 07:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:23 INFO - 'PWD': '/builds/slave/test', 07:52:23 INFO - 'SHELL': '/bin/bash', 07:52:23 INFO - 'SHLVL': '1', 07:52:23 INFO - 'TERM': 'linux', 07:52:23 INFO - 'TMOUT': '86400', 07:52:23 INFO - 'USER': 'cltbld', 07:52:23 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', 07:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:23 INFO - '_': '/tools/buildbot/bin/python'} 07:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:52:24 INFO - Cleaning up... 07:52:24 INFO - Return code: 0 07:52:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458290>, '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 0x2458b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', '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 07:52:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:52:24 INFO - Using env: {'DISPLAY': ':0', 07:52:24 INFO - 'HOME': '/home/cltbld', 07:52:24 INFO - 'LANG': 'en_US.UTF-8', 07:52:24 INFO - 'LANGUAGE': 'en_US:en', 07:52:24 INFO - 'LOGNAME': 'cltbld', 07:52:24 INFO - 'MAIL': '/var/mail/cltbld', 07:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:24 INFO - 'MOZ_NO_REMOTE': '1', 07:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:24 INFO - 'NO_EM_RESTART': '1', 07:52:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:24 INFO - 'PWD': '/builds/slave/test', 07:52:24 INFO - 'SHELL': '/bin/bash', 07:52:24 INFO - 'SHLVL': '1', 07:52:24 INFO - 'TERM': 'linux', 07:52:24 INFO - 'TMOUT': '86400', 07:52:24 INFO - 'USER': 'cltbld', 07:52:24 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', 07:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:24 INFO - '_': '/tools/buildbot/bin/python'} 07:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:24 INFO - Downloading/unpacking blobuploader==1.2.4 07:52:24 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 07:52:24 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 07:52:24 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 07:52:24 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 07:52:24 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 07:52:24 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 07:52:26 INFO - Downloading blobuploader-1.2.4.tar.gz 07:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:52:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:52:26 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 07:52:26 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 07:52:26 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 07:52:26 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 07:52:26 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 07:52:26 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 07:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:52:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:52:26 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 07:52:26 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 07:52:26 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 07:52:26 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 07:52:26 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 07:52:26 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 07:52:27 INFO - Downloading docopt-0.6.1.tar.gz 07:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:52:27 INFO - Installing collected packages: blobuploader, requests, docopt 07:52:27 INFO - Running setup.py install for blobuploader 07:52:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:52:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:52:27 INFO - Running setup.py install for requests 07:52:27 INFO - Running setup.py install for docopt 07:52:27 INFO - Successfully installed blobuploader requests docopt 07:52:27 INFO - Cleaning up... 07:52:27 INFO - Return code: 0 07:52:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:27 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 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458290>, '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 0x2458b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', '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 07:52:27 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 07:52:27 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 07:52:27 INFO - Using env: {'DISPLAY': ':0', 07:52:27 INFO - 'HOME': '/home/cltbld', 07:52:27 INFO - 'LANG': 'en_US.UTF-8', 07:52:27 INFO - 'LANGUAGE': 'en_US:en', 07:52:27 INFO - 'LOGNAME': 'cltbld', 07:52:27 INFO - 'MAIL': '/var/mail/cltbld', 07:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:27 INFO - 'MOZ_NO_REMOTE': '1', 07:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:27 INFO - 'NO_EM_RESTART': '1', 07:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:27 INFO - 'PWD': '/builds/slave/test', 07:52:27 INFO - 'SHELL': '/bin/bash', 07:52:27 INFO - 'SHLVL': '1', 07:52:27 INFO - 'TERM': 'linux', 07:52:27 INFO - 'TMOUT': '86400', 07:52:27 INFO - 'USER': 'cltbld', 07:52:27 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', 07:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:27 INFO - '_': '/tools/buildbot/bin/python'} 07:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:28 INFO - Running setup.py (path:/tmp/pip-KMMRyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:28 INFO - Running setup.py (path:/tmp/pip-Y4d4KO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:28 INFO - Running setup.py (path:/tmp/pip-tzVSKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:28 INFO - Running setup.py (path:/tmp/pip-VSWkCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:28 INFO - Running setup.py (path:/tmp/pip-zeSFI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:28 INFO - Running setup.py (path:/tmp/pip-3rNE3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:28 INFO - Running setup.py (path:/tmp/pip-WylNPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:28 INFO - Running setup.py (path:/tmp/pip-qe92dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:28 INFO - Running setup.py (path:/tmp/pip-vxoO40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:28 INFO - Running setup.py (path:/tmp/pip-kb1xH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:28 INFO - Running setup.py (path:/tmp/pip-wbrYc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:28 INFO - Running setup.py (path:/tmp/pip-l4qYhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:28 INFO - Running setup.py (path:/tmp/pip-0UWp1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:29 INFO - Running setup.py (path:/tmp/pip-nPCMos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:29 INFO - Running setup.py (path:/tmp/pip-aOm7Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:29 INFO - Running setup.py (path:/tmp/pip-D66SBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:29 INFO - Running setup.py (path:/tmp/pip-L6HuIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:52:29 INFO - Running setup.py install for manifestparser 07:52:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:52:29 INFO - Running setup.py install for mozcrash 07:52:29 INFO - Running setup.py install for mozdebug 07:52:29 INFO - Running setup.py install for mozdevice 07:52:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:52:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:52:29 INFO - Running setup.py install for mozfile 07:52:29 INFO - Running setup.py install for mozhttpd 07:52:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:52:29 INFO - Running setup.py install for mozinfo 07:52:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:52:30 INFO - Running setup.py install for mozInstall 07:52:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:52:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:52:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:52:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:52:30 INFO - Running setup.py install for mozleak 07:52:30 INFO - Running setup.py install for mozlog 07:52:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:52:30 INFO - Running setup.py install for moznetwork 07:52:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:52:30 INFO - Running setup.py install for mozprocess 07:52:30 INFO - Running setup.py install for mozprofile 07:52:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:52:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:52:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:52:30 INFO - Running setup.py install for mozrunner 07:52:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:52:30 INFO - Running setup.py install for mozscreenshot 07:52:30 INFO - Running setup.py install for moztest 07:52:30 INFO - Running setup.py install for mozversion 07:52:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:52:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:52:31 INFO - Cleaning up... 07:52:31 INFO - Return code: 0 07:52:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:31 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 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458290>, '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 0x2458b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', '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 07:52:31 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 07:52:31 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 07:52:31 INFO - Using env: {'DISPLAY': ':0', 07:52:31 INFO - 'HOME': '/home/cltbld', 07:52:31 INFO - 'LANG': 'en_US.UTF-8', 07:52:31 INFO - 'LANGUAGE': 'en_US:en', 07:52:31 INFO - 'LOGNAME': 'cltbld', 07:52:31 INFO - 'MAIL': '/var/mail/cltbld', 07:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:31 INFO - 'MOZ_NO_REMOTE': '1', 07:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:31 INFO - 'NO_EM_RESTART': '1', 07:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:31 INFO - 'PWD': '/builds/slave/test', 07:52:31 INFO - 'SHELL': '/bin/bash', 07:52:31 INFO - 'SHLVL': '1', 07:52:31 INFO - 'TERM': 'linux', 07:52:31 INFO - 'TMOUT': '86400', 07:52:31 INFO - 'USER': 'cltbld', 07:52:31 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', 07:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:31 INFO - '_': '/tools/buildbot/bin/python'} 07:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:31 INFO - Running setup.py (path:/tmp/pip-xwyzKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:31 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)) 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:31 INFO - Running setup.py (path:/tmp/pip-6btcDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:31 INFO - Running setup.py (path:/tmp/pip-6hRwWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:31 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)) 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:31 INFO - Running setup.py (path:/tmp/pip-gE5Zjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:31 INFO - Running setup.py (path:/tmp/pip-1C7tUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:31 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)) 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:31 INFO - Running setup.py (path:/tmp/pip-Ssdvcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:31 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)) 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:31 INFO - Running setup.py (path:/tmp/pip-u0GazW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:31 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)) 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:31 INFO - Running setup.py (path:/tmp/pip-jmoN8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:31 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)) 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:31 INFO - Running setup.py (path:/tmp/pip-IzP1pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:31 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)) 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:32 INFO - Running setup.py (path:/tmp/pip-QXkilt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 07:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:32 INFO - Running setup.py (path:/tmp/pip-21ayl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:32 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)) 07:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:32 INFO - Running setup.py (path:/tmp/pip-31EnVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 07:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:32 INFO - Running setup.py (path:/tmp/pip-ltPxwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:32 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)) 07:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:32 INFO - Running setup.py (path:/tmp/pip-TD4HGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 07:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:32 INFO - Running setup.py (path:/tmp/pip-GL3Ie2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:32 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)) 07:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:32 INFO - Running setup.py (path:/tmp/pip-awVFCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 07:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:32 INFO - Running setup.py (path:/tmp/pip-enUPTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:32 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)) 07:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:52:32 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)) 07:52:32 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:52:32 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:52:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:52:32 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 07:52:32 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 07:52:32 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 07:52:32 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 07:52:32 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 07:52:32 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 07:52:34 INFO - Downloading blessings-1.6.tar.gz 07:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:52:34 INFO - Installing collected packages: blessings 07:52:34 INFO - Running setup.py install for blessings 07:52:34 INFO - Successfully installed blessings 07:52:34 INFO - Cleaning up... 07:52:34 INFO - Return code: 0 07:52:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:52:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:35 INFO - Reading from file tmpfile_stdout 07:52:35 INFO - Current package versions: 07:52:35 INFO - argparse == 1.2.1 07:52:35 INFO - blessings == 1.6 07:52:35 INFO - blobuploader == 1.2.4 07:52:35 INFO - docopt == 0.6.1 07:52:35 INFO - functools32 == 3.2.3-2 07:52:35 INFO - jsonschema == 2.5.1 07:52:35 INFO - manifestparser == 1.1 07:52:35 INFO - mozInstall == 1.12 07:52:35 INFO - mozcrash == 1.0 07:52:35 INFO - mozdebug == 0.1 07:52:35 INFO - mozdevice == 0.49 07:52:35 INFO - mozfile == 1.2 07:52:35 INFO - mozhttpd == 0.7 07:52:35 INFO - mozinfo == 0.9 07:52:35 INFO - mozleak == 0.1 07:52:35 INFO - mozlog == 3.4 07:52:35 INFO - moznetwork == 0.27 07:52:35 INFO - mozprocess == 0.25 07:52:35 INFO - mozprofile == 0.28 07:52:35 INFO - mozrunner == 6.13 07:52:35 INFO - mozscreenshot == 0.1 07:52:35 INFO - mozsystemmonitor == 0.3 07:52:35 INFO - moztest == 0.8 07:52:35 INFO - mozversion == 1.4 07:52:35 INFO - psutil == 3.1.1 07:52:35 INFO - requests == 1.2.3 07:52:35 INFO - wsgiref == 0.1.2 07:52:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:35 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 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458290>, '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 0x2458b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', '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 07:52:35 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 07:52:35 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 07:52:35 INFO - Using env: {'DISPLAY': ':0', 07:52:35 INFO - 'HOME': '/home/cltbld', 07:52:35 INFO - 'LANG': 'en_US.UTF-8', 07:52:35 INFO - 'LANGUAGE': 'en_US:en', 07:52:35 INFO - 'LOGNAME': 'cltbld', 07:52:35 INFO - 'MAIL': '/var/mail/cltbld', 07:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:35 INFO - 'MOZ_NO_REMOTE': '1', 07:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:35 INFO - 'NO_EM_RESTART': '1', 07:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:35 INFO - 'PWD': '/builds/slave/test', 07:52:35 INFO - 'SHELL': '/bin/bash', 07:52:35 INFO - 'SHLVL': '1', 07:52:35 INFO - 'TERM': 'linux', 07:52:35 INFO - 'TMOUT': '86400', 07:52:35 INFO - 'USER': 'cltbld', 07:52:35 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', 07:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:35 INFO - '_': '/tools/buildbot/bin/python'} 07:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:35 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)) 07:52:35 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)) 07:52:35 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)) 07:52:35 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)) 07:52:35 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)) 07:52:35 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)) 07:52:35 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)) 07:52:35 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)) 07:52:35 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)) 07:52:35 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)) 07:52:35 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)) 07:52:35 INFO - Cleaning up... 07:52:35 INFO - Return code: 0 07:52:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:52:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:35 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 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458290>, '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 0x2458b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', '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 07:52:35 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 07:52:35 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 07:52:35 INFO - Using env: {'DISPLAY': ':0', 07:52:35 INFO - 'HOME': '/home/cltbld', 07:52:35 INFO - 'LANG': 'en_US.UTF-8', 07:52:35 INFO - 'LANGUAGE': 'en_US:en', 07:52:35 INFO - 'LOGNAME': 'cltbld', 07:52:35 INFO - 'MAIL': '/var/mail/cltbld', 07:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:35 INFO - 'MOZ_NO_REMOTE': '1', 07:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:35 INFO - 'NO_EM_RESTART': '1', 07:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:35 INFO - 'PWD': '/builds/slave/test', 07:52:35 INFO - 'SHELL': '/bin/bash', 07:52:35 INFO - 'SHLVL': '1', 07:52:35 INFO - 'TERM': 'linux', 07:52:35 INFO - 'TMOUT': '86400', 07:52:35 INFO - 'USER': 'cltbld', 07:52:35 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', 07:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:35 INFO - '_': '/tools/buildbot/bin/python'} 07:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:52:35 INFO - Cleaning up... 07:52:35 INFO - Return code: 0 07:52:35 INFO - Running post-action listener: _resource_record_post_action 07:52:35 INFO - Running post-action listener: _start_resource_monitoring 07:52:35 INFO - Starting resource monitoring. 07:52:35 INFO - [mozharness: 2017-03-13 14:52:35.581551Z] Finished create-virtualenv step (success) 07:52:35 INFO - [mozharness: 2017-03-13 14:52:35.582026Z] Running install step. 07:52:35 INFO - Running pre-action listener: _resource_record_pre_action 07:52:35 INFO - Running main action method: install 07:52:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:35 INFO - Reading from file tmpfile_stdout 07:52:35 INFO - Detecting whether we're running mozinstall >=1.0... 07:52:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:52:35 INFO - Reading from file tmpfile_stdout 07:52:35 INFO - Output received: 07:52:35 INFO - Usage: mozinstall [options] installer 07:52:35 INFO - Options: 07:52:35 INFO - -h, --help show this help message and exit 07:52:35 INFO - -d DEST, --destination=DEST 07:52:35 INFO - Directory to install application into. [default: 07:52:35 INFO - "/builds/slave/test"] 07:52:35 INFO - --app=APP Application being installed. [default: firefox] 07:52:35 INFO - mkdir: /builds/slave/test/build/application 07:52:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:52:51 INFO - Reading from file tmpfile_stdout 07:52:51 INFO - Output received: 07:52:51 INFO - /builds/slave/test/build/application/firefox/firefox 07:52:51 INFO - Running post-action listener: _resource_record_post_action 07:52:51 INFO - [mozharness: 2017-03-13 14:52:51.306279Z] Finished install step (success) 07:52:51 INFO - [mozharness: 2017-03-13 14:52:51.306552Z] Running run-tests step. 07:52:51 INFO - Running pre-action listener: _resource_record_pre_action 07:52:51 INFO - Running main action method: run_tests 07:52:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:52:51 INFO - Python 2.7.3 07:52:51 INFO - Return code: 0 07:52:51 INFO - grabbing minidump binary from tooltool 07:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:51 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2458290>, '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 0x2458b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2459040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:52:51 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 07:52:51 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 07:52:51 INFO - Calling ['/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'] with output_timeout 600 07:52:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:52:51 INFO - Return code: 0 07:52:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:52:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:52:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:52:51 INFO - ENV: RUST_BACKTRACE is now 1 07:52:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:52:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:52:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:52:51 INFO - Using env: {'DISPLAY': ':0', 07:52:51 INFO - 'HOME': '/home/cltbld', 07:52:51 INFO - 'LANG': 'en_US.UTF-8', 07:52:51 INFO - 'LANGUAGE': 'en_US:en', 07:52:51 INFO - 'LOGNAME': 'cltbld', 07:52:51 INFO - 'MAIL': '/var/mail/cltbld', 07:52:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:52:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:51 INFO - 'MOZ_NO_REMOTE': '1', 07:52:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:51 INFO - 'NO_EM_RESTART': '1', 07:52:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:51 INFO - 'PWD': '/builds/slave/test', 07:52:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:52:51 INFO - 'RUST_BACKTRACE': '1', 07:52:51 INFO - 'SHELL': '/bin/bash', 07:52:51 INFO - 'SHLVL': '1', 07:52:51 INFO - 'TERM': 'linux', 07:52:51 INFO - 'TMOUT': '86400', 07:52:51 INFO - 'USER': 'cltbld', 07:52:51 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969', 07:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:51 INFO - '_': '/tools/buildbot/bin/python'} 07:52:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:52:51 INFO - mozversion application_buildid: 20170313141954 07:52:51 INFO - mozversion application_changeset: 419c70029023afa80bee2f534bee483224e303bd 07:52:51 INFO - mozversion application_display_name: Nightly 07:52:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:52:51 INFO - mozversion application_name: Firefox 07:52:51 INFO - mozversion application_remotingname: firefox 07:52:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:52:51 INFO - mozversion application_vendor: Mozilla 07:52:51 INFO - mozversion application_version: 55.0a1 07:52:51 INFO - mozversion platform_buildid: 20170313141954 07:52:51 INFO - mozversion platform_changeset: 419c70029023afa80bee2f534bee483224e303bd 07:52:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:52:51 INFO - mozversion platform_version: 55.0a1 07:52:51 INFO - using testdate: 1489416771 07:52:51 INFO - actual date: 1489416771 07:52:51 INFO - starting webserver on 'localhost:55681' 07:52:51 INFO - SUITE-START | Running 2 tests 07:52:51 INFO - TEST-START | dromaeo_css 07:52:51 INFO - operating with platform_type : linux_ 07:52:51 INFO - Initialising browser for dromaeo_css test... 07:52:51 INFO - TEST-INFO | started process 11646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6BZnBG/profile http://localhost:55681/getInfo.html) 07:52:56 INFO - PID 11646 | __metrics Screen width/height:1600/1200 07:52:56 INFO - PID 11646 | colorDepth:24 07:52:56 INFO - PID 11646 | Browser inner width/height: 1024/697 07:52:56 INFO - PID 11646 | __metrics 07:52:57 ERROR - PID 11646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 07:52:58 INFO - TEST-INFO | 11646: exit 0 07:52:58 INFO - Browser initialized. 07:52:58 INFO - Running cycle 1/1 for dromaeo_css test... 07:52:58 INFO - TEST-INFO | started process 11775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6BZnBG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:53:10 INFO - PID 11775 | RSS: Main: 155959296 07:53:10 INFO - PID 11775 | 07:56:14 INFO - PID 11775 | Cycle 1(1): loaded http://localhost:55681/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55681/tests/dromaeo/cssquery-ext.html) 07:56:15 INFO - PID 11775 | RSS: Main: 167006208 07:56:15 INFO - PID 11775 | 07:57:58 INFO - PID 11775 | ************************* 07:57:58 INFO - PID 11775 | A coding exception was thrown and uncaught in a Task. 07:57:58 INFO - PID 11775 | 07:57:58 ERROR - PID 11775 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:57:58 INFO - PID 11775 | Full stack: 07:57:58 INFO - PID 11775 | ************************* 07:59:18 INFO - PID 11775 | Cycle 1(1): loaded http://localhost:55681/tests/dromaeo/cssquery-ext.html (next: http://localhost:55681/tests/dromaeo/cssquery-jquery.html) 07:59:19 INFO - PID 11775 | RSS: Main: 161513472 07:59:19 INFO - PID 11775 | 08:02:21 INFO - PID 11775 | Cycle 1(1): loaded http://localhost:55681/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55681/tests/dromaeo/cssquery-mootools.html) 08:02:21 INFO - PID 11775 | RSS: Main: 169205760 08:02:21 INFO - PID 11775 | 08:05:23 INFO - PID 11775 | Cycle 1(1): loaded http://localhost:55681/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55681/tests/dromaeo/cssquery-prototype.html) 08:05:24 INFO - PID 11775 | RSS: Main: 160923648 08:05:24 INFO - PID 11775 | 08:08:27 INFO - PID 11775 | Cycle 1(1): loaded http://localhost:55681/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55681/tests/dromaeo/cssquery-yui.html) 08:08:28 INFO - PID 11775 | RSS: Main: 168402944 08:08:28 INFO - PID 11775 | 08:11:30 INFO - PID 11775 | Cycle 1(1): loaded http://localhost:55681/tests/dromaeo/cssquery-yui.html (next: http://localhost:55681/tests/dromaeo/cssquery-dojo.html) 08:11:31 INFO - PID 11775 | RSS: Main: 162164736 08:11:31 INFO - PID 11775 | 08:11:31 INFO - PID 11775 | __start_tp_report 08:11:31 INFO - PID 11775 | _x_x_mozilla_page_load 08:11:31 INFO - PID 11775 | _x_x_mozilla_page_load_details 08:11:31 INFO - PID 11775 | |i|pagename|runs| 08:11:31 INFO - PID 11775 | |0;dojo.html;2668.052841241359;2672.291842661694;2672.6926403463594;2686.2075687672136;2694.2321438390063;4937.234728617061;5016.974915125419;5021.196608542634;5051.873703157423;5060.5951523878;4998.525140111684;5009.524095210958;5019.422766381867;5033.471485494026;5049.9747501262445;4544.636429085674;4652;4658.9517358594385;4662.160811054009;4673.719576825384;4655.185342565054;4671.182543054969;4687.531246875302;4697.67116301859;4734.881627959294;4593.747343896084;4620.052889157714;4639.327297541838;4655.837045703418;4669.906601867943;4644.651651126179;4647.53524647536;4658.161530924433;4699.78850951708;4702.341672165865;4565.5206203348835;4607.585317321424;4609.147307748078;4621.168189725848;4653.976730116362;4899.387576552931;4913.410390753133;4933.333999910038;4964.131277026506;5007.223880298559;5330.147176451749;5341.1187154119525;5362.034833729927;5390.78436862525;5394.91907621386;5401.864953376158;5411.702356370398;5413.350397952271;5418.91871621926;5424.240606315119;4906.607471402351;5046.39443266803;5060.671056381323;5063.670861393997;5104.2088476286235;5447.863803404867;5457.563394928476;5460.34475862899;5501.284832971768;5519.806806761824;5124.205748108974;5138.58891288696;5277.261183434322;5328.280682107866;5335.413104558495;5303.575713942875;5397.433269506645;5422.349318081855;5423;5437.238786569884;5211.931554031415;5385.676859388449;5398.433164517748;5398.892022159614;5457.672539647634;5272.288241087481;5311.442298558673;5334.039872822929;5345.412004679482;5376.059189641797;4479.10417916418;4508.616767574727;4515.2549829277805;4515.277555591089;4549.567791059844;3812.694984401241;3842.135519508144;3865.0917034497434;3891.8832435026993;3895.376739721631;4563.338315944236;4595.862124136282;4614.054118905617;4614.515475874985;4682.812687492462;5410.513053825174;5425.457454254622;5431.2396264522995;5434.701091440009;5481.725913704378;4649.814007439664;4650.116477869194;4654.883627909262;4655.534446555317;4683.086798074411;4740.336352910595;4785.665003449794;4793.952060479421;4797.160496913027;4835.419749629997;5019.092744756969;5037.942032173138;5040.243963405518;5062.139436295765;5062.31658726082;5392.218128371285;5430.15832545956;5439;5468.589855760913;5480.671159730429;5073.264376665436;5078.238264260391;5078.365204349457;5080.390353157644;5122.129238029469;5201.635885488131;5211.9478805212975;5300.893982120258;5322.387925388475;5333.439988801275;5297.54970827484;5431.185322201702;5439.782408703608;5490.423505532021;5500.092484740133;5204.401493828258;5231.89536209266;5269;5285.312909321764;5303.681779093266;5182.300389447376;5253.238280449237;5272.736363181903;5279.023380674587;5280.260763493191;5051.368578927634;5103.362079740033;5115.053715062725;5148.4851514848215;5157.020166168416;5308.124159513792;5315.282436870973;5331.067063263991;5359.356877174764;5386.380566234777;5121.795128194831;5153.768080436314;5157.638965272395;5180.896382072413;5208.479152084913 08:11:31 INFO - PID 11775 | |1;ext.html;671.3420847569382;708.2138825903246;729.7008226627082;848.2196379331015;863.1497974495118;33915.66084339156;34267.82866085669;36784.26431471372;36922.446163307504;37037.44443833345;32847.67152328476;33062.504062439024;33071.83464082676;33081.17297067575;33131.33737325252;6387.425131738131;9289.628414863431;9475.952620236923;9716.271279654018;9728.51357432129;9259.074092590754;9266.860997085048;9270.39742416744;9273.562597797352;9316.813663726722;9305.906940930572;9336;9361.20429763471;9391.859122113174;9404.153626173644;9300.348975571713;9328.300377471716;9331.25349972004;9343.672971446034;9368.859467107999;9174.587143578556;9180.31147663928;9195.172434480863;9224;9224.538773061387;34657.48013779795;34665;34862;34907.1273218169;35077.64922350795;3341.866325346983;3440.34633419652;3445.3453843769603;3474.1488335358;3493.1791029108394;24034.87982560076;24479.632805507932;24493.755062449327;24560.385990350205;24604.138855139983;3305.9669403305898;3467.739919506047;3586.3903136466865;3593.281343731238;3594.02961200477;157005;157742;159486.20256898756;162164;172820.99999999875;44726.32910506345;44736.55263447389;44929.101417971455;44972.77513612411;45012.77493612577;45839.54160458419;46166.53833461623;46443;46470.767646161556;46755.76622116868;11494.770104597861;11558;11569.479373428216;11590.304581724955;11624.825627615592;8994.775130621656;9006.86489702655;9007;9027.819443611092;9032.909670903338;11129.443527823576;11421.885781142082;13389.464421423034;13464.730705385837;13570.796438053438;5311.176767601028;5465.699386533779;5483.698396588146;5551.639143455663;5600.719964001865;958.1233171648004;1003.6587560229557;1008.6822650864954;1012.711377257478;1054.7204990677476;22900.65649015266;23247;23371.88314058419;23373.181938632068;23534.882325588605;1061.2836335473523;1075.2473268711933;1082.4804094034907;1082.4804094034907;1097.846301517788;11729.941350293195;12403.75192496163;12448.128630995743;12579.182353147016;12586.87413125857;217000;218367;218399;218853;218930;43115.56884431178;43355.34966975498;43439.782801086425;43511.34732979008;43639.563604364186;1182.5717031667027;1222.9633111006683;1229.551213806954;1231.2612432540404;1240.4294024748717;21647.675284870424;21748.23881164215;22640;22780;22923.083076676747;35830;35835.82082089573;35844.462333064504;35852.64147358493;35864.28271434609;177941;178603;178877;178960;179569;29383.853080734458;29542.852285738434;30751;31714;34197.82901085479;37634.24731505409;37929;38063.429048564845;38856.41715374215;39144.217115658095;32696.019119426455;33039.174020649676;33209.33581328311;33514.664853351154;33629;32300.515492268103;32521.373931302867;32853.67146328506;32997.83501082479;33638.49542256917;31780.205494862814;32361.838190809838;32487.837560812044;32791.8360408206;32815.179620509676;26463.470730584897;28934.42131157407;29543.704562954095;29606.555901661923;29631.555526666685;22894.656580151644;23027;23053.308400748003;23140.950333691875;23221.88389058044 08:11:31 INFO - PID 11775 | |2;jquery.html;365.4755425963741;382.45500162268775;383.313868175965;384.62499063413173;399.1657435958845;17319.220635071422;18694.345697900575;18881.433556993295;19009.144588493516;19093.331733389336;17769;18061.548461288443;18321.633567328645;18536.165872535734;18547.629047419043;5537.833864984037;5570.693611851347;5809.7676092956235;5811.593188476787;5821.097729851858;5617.157426386034;5769.855753606173;5773.076307790754;5774;5778.942210577903;5515.779368825242;5719.571032172583;5774.682392468412;5781.219535362735;5797.652140871562;5630.605857589971;5717.656940583578;5719.971400143014;5733.684647344395;5743.684097374643;5575.665460072409;5578.163275508706;5612.915806262909;5626.212330273765;5631;21447.356579302646;21629;21642.783572164233;21755.456113597127;21862.344129675977;2376.940576485584;2388.749181335952;2418.576749068906;2445.9950820735053;2453.116877923946;13813.51652692161;14209.36057877398;14230.217338046403;14254.501092461818;14758.852411475855;1865.6175484025878;1908.2176307713771;1914.3586898389055;1923.855710821694;1933.806619338069;88633.55683221543;90450.5477472615;90552;92235.07764922331;93166;15281.38874445032;16193.761247750497;16542.66914661724;16598.502044938672;16606;28976.71023289782;29007.85496072506;29017.41965160685;29036;29231;7911.446198766032;8058.234467725557;8062.193780621891;8349.03986041613;8415.705450309331;6449.6130232186215;6505.772297969548;6650.567713098633;6672.331067572913;6694.125644819458;8628.396012279205;8835.514046727363;8918.598663060178;8928.375013749104;9013.504257265913;3420.9828950855085;3532.876349327761;3594.3170797548382;3772.5475691858283;3888.2612303662213;965.56066989521;1013.4679293370892;1049.2864851900629;1049.7795462952865;1050.9369437833602;17543.649127017386;18965.336213232746;18998.24007039703;18999.145038473303;19223.231070757294;978.8189185000798;989.5497548615363;991.2268430624125;1016.1312078173204;1021.300409219672;9975;10067.748306292402;10386.844197337046;10458.424786636655;10515.84226236607;309020;313254;467205;471196;485557;67625.6618716913;82436.17563824284;88180.55909720539;88958;93809;1096.3421946831998;1109.417555783204;1157.5254145800182;1185.2769810415639;1189.958351457712;17545.122743863012;17596.208170632097;18189.18148683339;18246.908765456617;18252.908735456767;28776.85611571929;31445.213869653442;41117.79441102775;41883.581164189185;42225.155496890504;53246.73376633092;53434.732826337175;53628;56498.43501564932;57835.84328313326;10682.305650132717;11023.126068568523;11054.557817687202;11361.375124367909;11913.642590722293;12244.204126731735;12356.505739770308;12384.690382740504;12795.808062878878;13164.14433061848;10510.632127875488;10550.525226364985;10686.465676715978;10920.2901811382;11048.613298534512;11009.83485247738;11041.619797525309;11086.002259796656;11271.211015228855;11491;10654.840177397191;10805.891941080488;10849.891501084889;11045.116390688887;11177;10869.347839129678;10909.890901090888;11019.83470247963;11137.99758021782;11177.099893018369;10268.948655256676;10565.894341056492;10601.204909631655;10663.093637040938;10832.079273261861 08:11:31 INFO - PID 11775 | |3;mootools.html;1425.3657122580444;1461.6345913521627;1462.692834504754;1470.125275461101;1472.006395682914;9077.137671921166;9643.951780241088;9733.221342292618;9733.318667693264;9932.851007234898;9454.101860323275;9595.232381409487;9604.183644390218;9607.567659455324;9651.517424128782;1845.2065611786927;1867.057136146251;1867.1691097461635;1876.2963888541797;1878.7088001359812;1848.7966323704381;1874.2690350763214;1900.3633782682748;1900.6483800496953;1906.3994841624913;1897.848172146232;1898.8860668359873;1904.780950190725;1907.2561700936647;1915.6551820672273;1711.6747817914618;1744.7557341972133;1745.3018792483044;1748.1521462090875;1754.999650199387;1768.7612172356696;1769.973450398245;1819.0540918722322;1820.4356649438716;1834.5688763140786;9605.087516685904;9672.75818104546;9681.322307438482;9686.806263874754;9714.465704386255;4561.657875659305;4745.359376484165;4746.83386081489;4748.240281554969;4763.737994410306;2491.402063504746;2556.348131226544;2602.128287023849;2619.9214023579134;2634.0254105980716;897.174599368576;910.2081189365229;928.3130483442204;931.8602209668536;952.0764858087643;11606.70983225426;11926.165168438212;12991.480340786262;13491.527796527173;13680;3689.6494832990825;3737.8131093445218;3845.1540661054523;3877.2746127973346;3895.7467764595776;10410.219233557362;10423.791524169626;10437.68686939393;10468.162546996222;10493.790124197474;4630.884227894329;4632.791524381411;4647.024124933801;4656.837010704609;4685.508021657745;4070.1859628074503;4242.44848169736;4267.317229243306;4267.743935363826;4289.82840686369;3109.2693217093965;3132.6084239470065;3193.936121277608;3197.184717896968;3218.6137663480063;768.9702571866827;770.2836362183224;780.7969927818694;782.1904329019437;782.2255966593032;845.966161353539;851.3529717414685;862.8533149364498;876.2420506262165;883.3992884838372;5553.611247212656;5741.224934633771;5755.181154018173;5765.798197063166;5988.071848863433;925.1950802801606;937.5452905340904;950.7385468995943;963.633819148719;967.9467629280316;3629.201575653352;3843.8078096095082;3850.845966161322;3867.3425517662067;3933.6853051755793;11606.477708503138;11946.462409191607;11984.940075299568;11998.160128790902;12022.819657705142;11776.52893884235;11882;11883.524659013543;11994.280343179436;12006.819897701542;8774.298056155492;8850.601722922484;8909.420887642282;8971.102889710846;9001.369904106781;5090.796368145233;5707.514861236841;5777.451142141658;5780.94219057804;5924.140999555127;9915.504224788876;10069.848952265575;10166.390016599027;10214.795704086026;10249.897501025192;10064.899351006688;10511.211659125443;10634.84047739269;10692.305000174963;10867.891321086689;7791.948087008182;7941;7941.086775020946;7945.404094693036;7946.483478573874;8825.69110081144;8953.776155596162;9085.182333590008;9130.223930965942;9154.267658587163;7913.050433947733;8051.83896322082;8054.476459030145;8162.306203972729;8303.543305118035;7910.604469776603;8032.83934321322;8069.072056713553;8092.514449133071;8151.83696326082;6903.89644155328;6975.651217439006;7016.5088443808445;7021.332973367522;7038.718451262097;4945.579625731853;4965.50344965515;5018.749062546931;5029.044481548494;5236.659617124875;5352.116900711495;5385.3268341457315;5414.3232095988005;5427;5662.688552129673 08:11:31 INFO - PID 11775 | |4;prototype.html;351.1729876141686;362.96733294003536;365.66541614422823;371.73235270605153;371.7712958671591;4719.339292499053;4842.443119041312;4921.557059864612;4961.950380496194;4967.155583550801;4747;4786.401699787527;4795;4802.663813533054;4846.515348465152;4191.742477256826;4202.369644553319;4206.768627725489;4221.366794980762;4249.915001699964;3878.5151856017997;4242.409096588779;4257.510386305568;4268;4273.081287523182;4040.151568170688;4052.5136983562015;4055.3308704063793;4060.4315395844606;4080.4491393661774;4049.8785036448953;4063.0136849415953;4072.9592704073025;4096;4100.425940368321;3816.790076545789;3828.559715632682;3848.1149335652676;3854.807259637007;3859.112404147062;4559.695953855127;4683.906321873577;4713.198756211452;4758.78585463655;4759.214729569617;4664.253719404913;4669.509701481329;4678.204705200124;4687.5781179693995;4698.3689134085025;5069.949300506984;5116.488351164891;5124.743762811881;5132.3568362293445;5143.614228932845;3891.750388425668;4098.7950602469755;4100.36444351126;4163.2298024865195;4204.411382406465;5073.695578265316;5181.248718935771;5207.791688332462;5293.544275324278;5305.442928492491;4231.196072746168;4237.576242375738;4240.70658449176;4276.187524370422;4280.636145927631;4323.459567554056;4328.98268906813;4341.848035318749;4344.847930322424;4344.869653910388;4433.224185767478;4667.603253723471;4669.883252918704;4679.262631360624;4692.882677933079;5060.7722652480725;5079.466656001141;5087.97456012725;5094.643374963717;5098.311727916684;1513.1980050573213;1528.7324718174275;1533.9079655220723;1534.511523821891;1534.608674787922;1090.4220762995626;1161.9012383947459;1163.778882012432;1165.8018136916744;1180.403896032498;4444.622207112367;4468.597826195593;4493.662975276802;4506.526814684476;4523.638108951276;5198.818041368534;5202.843914682566;5240.9213861792105;5245;5261.71088083422;4233.740020184441;4470.508244093147;4513.172165273069;4521.892136426596;4526.524714904954;2746.8489233091973;2758.7517123458583;2760.6963234044238;2764.9308767280577;2773.0987429085226;4868.172410690191;4916.901661966741;4927.708615493741;4931.58081563064;4942.505749425029;5110.66780659256;5312.7343632818975;5338.199270109515;5348.812791552355;5361.839144825662;4881.755912204376;4894.290327902434;4901.054651005975;4902.955062073732;4904.828331008326;5174;5229;5276.680829792552;5300.416954134965;5327.147656374961;4966.602671786321;5177.378714554277;5199.818006369759;5238.659487133325;5251.789928402821;4826.782794774173;4852.95147048525;4873.1959226727195;4907.852764417074;4920.360353154067;4248.553901840262;4262.786860656893;4298.591633794785;4310.676699247631;4322.675799315127;5149.613778966667;5289.523942845162;5323.653962492425;5327.893442131213;5345.358556973188;5145.14774681122;5147.897042059213;5168.508991645787;5176.482351764794;5184.185535062697;5054.140796064751;5094.7962081516325;5119.436861945258;5126.436092029949;5150.630709873501;4897.926531101965;5005.34930459038;5028.2960385546785;5056.710538812579;5078.746062696924;5089.338386009795;5104.285400043923;5116;5127.820526281562;5148.279240906351;4969;5045.672031317952;5065.341505604248;5067.214581739836;5110.437851836369 08:11:31 INFO - PID 11775 | |5;yui.html;715.6064164709409;732.4835990626609;759.3431681595422;760.444875241074;772.9111152217494;12793.616191514246;14194;14203.360848761804;14204.218767967757;14297.785533216997;13583.660408489794;13879.236641984688;13918.721625567508;14003.859961400383;14025.859741402583;827.3960009193278;845.4546817302836;859.2352806002632;859.3125499600326;859.4370687199894;847.3306088190322;853.1809462915578;853.338662536536;854.0221446443818;856.1866227084264;898.3980732908934;903.6249956268141;906.650939388337;906.7325139083986;909.1454033208796;896.8385690575726;898.4654130792168;900.5677274908015;906.1708536688922;906.9773255668628;661.4642139866723;665.4643012375036;668.1147479589563;668.7826456401689;670.1957650819037;11272.154588405903;11459.713507162303;11822.113341499422;11891.227070240408;11952.880471195263;10746.24776265654;10837.252684011037;10991.285566438157;11273.210875238736;11433.256838305484;9324.580393882292;9378.906210937872;9450.43297402158;9659.130678238993;9666.081722236377;3176.301213732975;3209.6950789674943;3226.9677303226904;3238.426537355536;3289.4243507386113;48522.75738621284;50590;55715.721421392635;61844.69077654583;62943;10702.46487675613;10703.1437485001;10776.730581735363;10897.073748731447;11028.669139925814;20503.28238511645;20583.794162058486;20606.690899636516;20610.38168854937;20619.69070463944;5861.589688721749;6070.089486577049;6605.933940660628;6630.5027122965;6808.5914845109455;3110.5023196288485;3249.382617302705;3298.5876765404323;3326.2183386904057;3327.500874868789;2632.552466080771;2681.6245725598433;2701.6622922134734;2706.174616741913;2717.212008517508;440.90961352922574;444.4022789348386;449.3978069387037;449.99201787994656;452.0258842195075;576.1591714472221;589.4606435111824;591.1989254560095;592.5259792166249;628.8082134948885;7670.7315243966195;8327.625256863455;8351.624176912053;8614.87077693835;8695.347848911357;548.3967635600807;561.4049107945509;565.9688717120515;583.3087790967717;627.595201095291;3786.450964610171;3849.2533304149533;3853.556840963269;3889.727719059695;4004.199160167978;63291;64327.67836160883;64396.356036439036;66339.66830165914;66476.66761666257;43442;50770.49229507732;54187;54326.45673543214;54909.450905491234;49397.50602493929;49615.75192124016;50299.24551131736;52021.47978520166;54740;8964.910350896407;9540.809183816424;9575.808483830424;9583.808323833624;9738.561764720464;33118.337633246716;33274.33451330911;34363.65636343705;34390.82804585961;34566.82716586502;40332.59667403289;40464.79767601143;41101;42151.7892410536;42300.36549451699;12242;12276.938615306866;12302;12572.685682858002;12635.557755478882;13001.869981300066;13358.198508089547;13699.45202191901;13797.724045519235;13826;11371;11578.373015873016;11936.940315298716;11979.76040479203;12231.938840305742;11484.425778711198;12051.276923384625;12085.456154472893;12154.02767778558;13073.215607063607;11682.591109311474;11960.342181180118;12479.438425270702;12542.1847579907;12602.936985315015;9689.934077331955;9715.514224288898;10134.645287414905;10237;10430.217733669853;8845.946646980146;10131.08820206185;10132.696019119438;10186.643467478603;10215.591376344863 08:11:31 INFO - PID 11775 | __end_tp_report 08:11:31 INFO - PID 11775 | __start_cc_report 08:11:31 INFO - PID 11775 | _x_x_mozilla_cycle_collect,390 08:11:31 INFO - PID 11775 | __end_cc_report 08:11:31 INFO - PID 11775 | __startTimestamp1489417891240__endTimestamp 08:11:31 INFO - PID 11775 | 08:11:31 INFO - PID 11775 | ------- Summary: start ------- 08:11:31 INFO - PID 11775 | Number of tests: 6 08:11:31 INFO - PID 11775 | 08:11:31 INFO - PID 11775 | [#0] dojo.html Cycles:165 Average:4964.26 Median:5078.37 stddev:546.71 (10.8%) stddev-sans-first:517.87 08:11:31 INFO - PID 11775 | Values: 2668.1 2672.3 2672.7 2686.2 2694.2 4937.2 5017.0 5021.2 5051.9 5060.6 4998.5 5009.5 5019.4 5033.5 5050.0 4544.6 4652.0 4659.0 4662.2 4673.7 4655.2 4671.2 4687.5 4697.7 4734.9 4593.7 4620.1 4639.3 4655.8 4669.9 4644.7 4647.5 4658.2 4699.8 4702.3 4565.5 4607.6 4609.1 4621.2 4654.0 4899.4 4913.4 4933.3 4964.1 5007.2 5330.1 5341.1 5362.0 5390.8 5394.9 5401.9 5411.7 5413.4 5418.9 5424.2 4906.6 5046.4 5060.7 5063.7 5104.2 5447.9 5457.6 5460.3 5501.3 5519.8 5124.2 5138.6 5277.3 5328.3 5335.4 5303.6 5397.4 5422.3 5423.0 5437.2 5211.9 5385.7 5398.4 5398.9 5457.7 5272.3 5311.4 5334.0 5345.4 5376.1 4479.1 4508.6 4515.3 4515.3 4549.6 3812.7 3842.1 3865.1 3891.9 3895.4 4563.3 4595.9 4614.1 4614.5 4682.8 5410.5 5425.5 5431.2 5434.7 5481.7 4649.8 4650.1 4654.9 4655.5 4683.1 4740.3 4785.7 4794.0 4797.2 4835.4 5019.1 5037.9 5040.2 5062.1 5062.3 5392.2 5430.2 5439.0 5468.6 5480.7 5073.3 5078.2 5078.4 5080.4 5122.1 5201.6 5211.9 5300.9 5322.4 5333.4 5297.5 5431.2 5439.8 5490.4 5500.1 5204.4 5231.9 5269.0 5285.3 5303.7 5182.3 5253.2 5272.7 5279.0 5280.3 5051.4 5103.4 5115.1 5148.5 5157.0 5308.1 5315.3 5331.1 5359.4 5386.4 5121.8 5153.8 5157.6 5180.9 5208.5 08:11:31 INFO - PID 11775 | 08:11:31 INFO - PID 11775 | [#1] ext.html Cycles:180 Average:34198.15 Median:18275.60 stddev:48543.57 (265.6%) stddev-sans-first:48614.47 08:11:31 INFO - PID 11775 | Values: 671.3 708.2 729.7 848.2 863.1 33915.7 34267.8 36784.3 36922.4 37037.4 32847.7 33062.5 33071.8 33081.2 33131.3 6387.4 9289.6 9476.0 9716.3 9728.5 9259.1 9266.9 9270.4 9273.6 9316.8 9305.9 9336.0 9361.2 9391.9 9404.2 9300.3 9328.3 9331.3 9343.7 9368.9 9174.6 9180.3 9195.2 9224.0 9224.5 34657.5 34665.0 34862.0 34907.1 35077.6 3341.9 3440.3 3445.3 3474.1 3493.2 24034.9 24479.6 24493.8 24560.4 24604.1 3306.0 3467.7 3586.4 3593.3 3594.0 157005.0 157742.0 159486.2 162164.0 172821.0 44726.3 44736.6 44929.1 44972.8 45012.8 45839.5 46166.5 46443.0 46470.8 46755.8 11494.8 11558.0 11569.5 11590.3 11624.8 8994.8 9006.9 9007.0 9027.8 9032.9 11129.4 11421.9 13389.5 13464.7 13570.8 5311.2 5465.7 5483.7 5551.6 5600.7 958.1 1003.7 1008.7 1012.7 1054.7 22900.7 23247.0 23371.9 23373.2 23534.9 1061.3 1075.2 1082.5 1082.5 1097.8 11729.9 12403.8 12448.1 12579.2 12586.9 217000.0 218367.0 218399.0 218853.0 218930.0 43115.6 43355.3 43439.8 43511.3 43639.6 1182.6 1223.0 1229.6 1231.3 1240.4 21647.7 21748.2 22640.0 22780.0 22923.1 35830.0 35835.8 35844.5 35852.6 35864.3 177941.0 178603.0 178877.0 178960.0 179569.0 29383.9 29542.9 30751.0 31714.0 34197.8 37634.2 37929.0 38063.4 38856.4 39144.2 32696.0 33039.2 33209.3 33514.7 33629.0 32300.5 32521.4 32853.7 32997.8 33638.5 31780.2 32361.8 32487.8 32791.8 32815.2 26463.5 28934.4 29543.7 29606.6 29631.6 22894.7 23027.0 23053.3 23141.0 23221.9 08:11:31 INFO - PID 11775 | 08:11:31 INFO - PID 11775 | [#2] jquery.html Cycles:180 Average:27316.51 Median:2382.84 stddev:69204.89 (2904.3%) stddev-sans-first:69369.44 08:11:31 INFO - PID 11775 | Values: 365.5 382.5 383.3 384.6 399.2 17319.2 18694.3 18881.4 19009.1 19093.3 17769.0 18061.5 18321.6 18536.2 18547.6 5537.8 5570.7 5809.8 5811.6 5821.1 5617.2 5769.9 5773.1 5774.0 5778.9 5515.8 5719.6 5774.7 5781.2 5797.7 5630.6 5717.7 5720.0 5733.7 5743.7 5575.7 5578.2 5612.9 5626.2 5631.0 21447.4 21629.0 21642.8 21755.5 21862.3 2376.9 2388.7 2418.6 2446.0 2453.1 13813.5 14209.4 14230.2 14254.5 14758.9 1865.6 1908.2 1914.4 1923.9 1933.8 88633.6 90450.5 90552.0 92235.1 93166.0 15281.4 16193.8 16542.7 16598.5 16606.0 28976.7 29007.9 29017.4 29036.0 29231.0 7911.4 8058.2 8062.2 8349.0 8415.7 6449.6 6505.8 6650.6 6672.3 6694.1 8628.4 8835.5 8918.6 8928.4 9013.5 3421.0 3532.9 3594.3 3772.5 3888.3 965.6 1013.5 1049.3 1049.8 1050.9 17543.6 18965.3 18998.2 18999.1 19223.2 978.8 989.5 991.2 1016.1 1021.3 9975.0 10067.7 10386.8 10458.4 10515.8 309020.0 313254.0 467205.0 471196.0 485557.0 67625.7 82436.2 88180.6 88958.0 93809.0 1096.3 1109.4 1157.5 1185.3 1190.0 17545.1 17596.2 18189.2 18246.9 18252.9 28776.9 31445.2 41117.8 41883.6 42225.2 53246.7 53434.7 53628.0 56498.4 57835.8 10682.3 11023.1 11054.6 11361.4 11913.6 12244.2 12356.5 12384.7 12795.8 13164.1 10510.6 10550.5 10686.5 10920.3 11048.6 11009.8 11041.6 11086.0 11271.2 11491.0 10654.8 10805.9 10849.9 11045.1 11177.0 10869.3 10909.9 11019.8 11138.0 11177.1 10268.9 10565.9 10601.2 10663.1 10832.1 08:11:31 INFO - PID 11775 | 08:11:31 INFO - PID 11775 | [#3] mootools.html Cycles:180 Average:5794.47 Median:4746.10 stddev:3707.30 (78.1%) stddev-sans-first:3703.17 08:11:31 INFO - PID 11775 | Values: 1425.4 1461.6 1462.7 1470.1 1472.0 9077.1 9644.0 9733.2 9733.3 9932.9 9454.1 9595.2 9604.2 9607.6 9651.5 1845.2 1867.1 1867.2 1876.3 1878.7 1848.8 1874.3 1900.4 1900.6 1906.4 1897.8 1898.9 1904.8 1907.3 1915.7 1711.7 1744.8 1745.3 1748.2 1755.0 1768.8 1770.0 1819.1 1820.4 1834.6 9605.1 9672.8 9681.3 9686.8 9714.5 4561.7 4745.4 4746.8 4748.2 4763.7 2491.4 2556.3 2602.1 2619.9 2634.0 897.2 910.2 928.3 931.9 952.1 11606.7 11926.2 12991.5 13491.5 13680.0 3689.6 3737.8 3845.2 3877.3 3895.7 10410.2 10423.8 10437.7 10468.2 10493.8 4630.9 4632.8 4647.0 4656.8 4685.5 4070.2 4242.4 4267.3 4267.7 4289.8 3109.3 3132.6 3193.9 3197.2 3218.6 769.0 770.3 780.8 782.2 782.2 846.0 851.4 862.9 876.2 883.4 5553.6 5741.2 5755.2 5765.8 5988.1 925.2 937.5 950.7 963.6 967.9 3629.2 3843.8 3850.8 3867.3 3933.7 11606.5 11946.5 11984.9 11998.2 12022.8 11776.5 11882.0 11883.5 11994.3 12006.8 8774.3 8850.6 8909.4 8971.1 9001.4 5090.8 5707.5 5777.5 5780.9 5924.1 9915.5 10069.8 10166.4 10214.8 10249.9 10064.9 10511.2 10634.8 10692.3 10867.9 7791.9 7941.0 7941.1 7945.4 7946.5 8825.7 8953.8 9085.2 9130.2 9154.3 7913.1 8051.8 8054.5 8162.3 8303.5 7910.6 8032.8 8069.1 8092.5 8151.8 6903.9 6975.7 7016.5 7021.3 7038.7 4945.6 4965.5 5018.7 5029.0 5236.7 5352.1 5385.3 5414.3 5427.0 5662.7 08:11:31 INFO - PID 11775 | 08:11:31 INFO - PID 11775 | [#4] prototype.html Cycles:180 Average:4377.03 Median:4759.00 stddev:1153.34 (24.2%) stddev-sans-first:1116.29 08:11:31 INFO - PID 11775 | Values: 351.2 363.0 365.7 371.7 371.8 4719.3 4842.4 4921.6 4962.0 4967.2 4747.0 4786.4 4795.0 4802.7 4846.5 4191.7 4202.4 4206.8 4221.4 4249.9 3878.5 4242.4 4257.5 4268.0 4273.1 4040.2 4052.5 4055.3 4060.4 4080.4 4049.9 4063.0 4073.0 4096.0 4100.4 3816.8 3828.6 3848.1 3854.8 3859.1 4559.7 4683.9 4713.2 4758.8 4759.2 4664.3 4669.5 4678.2 4687.6 4698.4 5069.9 5116.5 5124.7 5132.4 5143.6 3891.8 4098.8 4100.4 4163.2 4204.4 5073.7 5181.2 5207.8 5293.5 5305.4 4231.2 4237.6 4240.7 4276.2 4280.6 4323.5 4329.0 4341.8 4344.8 4344.9 4433.2 4667.6 4669.9 4679.3 4692.9 5060.8 5079.5 5088.0 5094.6 5098.3 1513.2 1528.7 1533.9 1534.5 1534.6 1090.4 1161.9 1163.8 1165.8 1180.4 4444.6 4468.6 4493.7 4506.5 4523.6 5198.8 5202.8 5240.9 5245.0 5261.7 4233.7 4470.5 4513.2 4521.9 4526.5 2746.8 2758.8 2760.7 2764.9 2773.1 4868.2 4916.9 4927.7 4931.6 4942.5 5110.7 5312.7 5338.2 5348.8 5361.8 4881.8 4894.3 4901.1 4903.0 4904.8 5174.0 5229.0 5276.7 5300.4 5327.1 4966.6 5177.4 5199.8 5238.7 5251.8 4826.8 4853.0 4873.2 4907.9 4920.4 4248.6 4262.8 4298.6 4310.7 4322.7 5149.6 5289.5 5323.7 5327.9 5345.4 5145.1 5147.9 5168.5 5176.5 5184.2 5054.1 5094.8 5119.4 5126.4 5150.6 4897.9 5005.3 5028.3 5056.7 5078.7 5089.3 5104.3 5116.0 5127.8 5148.3 4969.0 5045.7 5065.3 5067.2 5110.4 08:11:31 INFO - PID 11775 | 08:11:31 INFO - PID 11775 | [#5] yui.html Cycles:180 Average:14340.02 Median:42226.08 stddev:17238.07 (40.8%) stddev-sans-first:17256.06 08:11:31 INFO - PID 11775 | Values: 715.6 732.5 759.3 760.4 772.9 12793.6 14194.0 14203.4 14204.2 14297.8 13583.7 13879.2 13918.7 14003.9 14025.9 827.4 845.5 859.2 859.3 859.4 847.3 853.2 853.3 854.0 856.2 898.4 903.6 906.7 906.7 909.1 896.8 898.5 900.6 906.2 907.0 661.5 665.5 668.1 668.8 670.2 11272.2 11459.7 11822.1 11891.2 11952.9 10746.2 10837.3 10991.3 11273.2 11433.3 9324.6 9378.9 9450.4 9659.1 9666.1 3176.3 3209.7 3227.0 3238.4 3289.4 48522.8 50590.0 55715.7 61844.7 62943.0 10702.5 10703.1 10776.7 10897.1 11028.7 20503.3 20583.8 20606.7 20610.4 20619.7 5861.6 6070.1 6605.9 6630.5 6808.6 3110.5 3249.4 3298.6 3326.2 3327.5 2632.6 2681.6 2701.7 2706.2 2717.2 440.9 444.4 449.4 450.0 452.0 576.2 589.5 591.2 592.5 628.8 7670.7 8327.6 8351.6 8614.9 8695.3 548.4 561.4 566.0 583.3 627.6 3786.5 3849.3 3853.6 3889.7 4004.2 63291.0 64327.7 64396.4 66339.7 66476.7 43442.0 50770.5 54187.0 54326.5 54909.5 49397.5 49615.8 50299.2 52021.5 54740.0 8964.9 9540.8 9575.8 9583.8 9738.6 33118.3 33274.3 34363.7 34390.8 34566.8 40332.6 40464.8 41101.0 42151.8 42300.4 12242.0 12276.9 12302.0 12572.7 12635.6 13001.9 13358.2 13699.5 13797.7 13826.0 11371.0 11578.4 11936.9 11979.8 12231.9 11484.4 12051.3 12085.5 12154.0 13073.2 11682.6 11960.3 12479.4 12542.2 12602.9 9689.9 9715.5 10134.6 10237.0 10430.2 8845.9 10131.1 10132.7 10186.6 10215.6 08:11:31 INFO - PID 11775 | -------- Summary: end -------- 08:11:31 INFO - PID 11775 | 08:11:32 INFO - TEST-INFO | 11775: exit 0 08:11:32 INFO - TEST-OK | dromaeo_css | took 1120488ms 08:11:32 INFO - TEST-START | kraken 08:11:32 INFO - operating with platform_type : linux_ 08:11:32 INFO - Initialising browser for kraken test... 08:11:32 INFO - TEST-INFO | started process 12154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg5K2Ks/profile http://localhost:55681/getInfo.html) 08:11:36 INFO - PID 12154 | __metrics Screen width/height:1600/1200 08:11:36 INFO - PID 12154 | colorDepth:24 08:11:36 INFO - PID 12154 | Browser inner width/height: 1024/697 08:11:36 INFO - PID 12154 | __metrics 08:11:37 ERROR - PID 12154 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 08:11:38 INFO - TEST-INFO | 12154: exit 0 08:11:38 INFO - Browser initialized. 08:11:38 INFO - Running cycle 1/1 for kraken test... 08:11:38 INFO - TEST-INFO | started process 12281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg5K2Ks/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:50 INFO - PID 12281 | RSS: Main: 154718208 08:11:50 INFO - PID 12281 | 08:11:53 INFO - PID 12281 | Cycle 1(1): loaded http://localhost:55681/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55681/tests/kraken/driver.html?testName=audio-beat-detection) 08:11:54 INFO - PID 12281 | RSS: Main: 161361920 08:11:54 INFO - PID 12281 | 08:11:57 INFO - PID 12281 | Cycle 1(1): loaded http://localhost:55681/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55681/tests/kraken/driver.html?testName=audio-dft) 08:11:57 INFO - PID 12281 | RSS: Main: 160673792 08:11:57 INFO - PID 12281 | 08:12:00 INFO - PID 12281 | Cycle 1(1): loaded http://localhost:55681/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55681/tests/kraken/driver.html?testName=audio-fft) 08:12:01 INFO - PID 12281 | RSS: Main: 157544448 08:12:01 INFO - PID 12281 | 08:12:03 INFO - PID 12281 | Cycle 1(1): loaded http://localhost:55681/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55681/tests/kraken/driver.html?testName=audio-oscillator) 08:12:03 INFO - PID 12281 | RSS: Main: 158171136 08:12:03 INFO - PID 12281 | 08:12:06 INFO - PID 12281 | Cycle 1(1): loaded http://localhost:55681/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55681/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:12:06 INFO - PID 12281 | RSS: Main: 158703616 08:12:06 INFO - PID 12281 | 08:12:09 INFO - PID 12281 | Cycle 1(1): loaded http://localhost:55681/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55681/tests/kraken/driver.html?testName=imaging-darkroom) 08:12:10 INFO - PID 12281 | RSS: Main: 163246080 08:12:10 INFO - PID 12281 | 08:12:14 INFO - PID 12281 | Cycle 1(1): loaded http://localhost:55681/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55681/tests/kraken/driver.html?testName=imaging-desaturate) 08:12:14 INFO - PID 12281 | RSS: Main: 160845824 08:12:14 INFO - PID 12281 | 08:12:17 INFO - PID 12281 | Cycle 1(1): loaded http://localhost:55681/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55681/tests/kraken/driver.html?testName=json-parse-financial) 08:12:18 INFO - PID 12281 | RSS: Main: 161681408 08:12:18 INFO - PID 12281 | 08:12:20 INFO - PID 12281 | Cycle 1(1): loaded http://localhost:55681/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55681/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:12:20 INFO - PID 12281 | RSS: Main: 162045952 08:12:20 INFO - PID 12281 | 08:12:22 INFO - PID 12281 | Cycle 1(1): loaded http://localhost:55681/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55681/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:12:23 INFO - PID 12281 | RSS: Main: 162181120 08:12:23 INFO - PID 12281 | 08:12:25 INFO - PID 12281 | Cycle 1(1): loaded http://localhost:55681/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55681/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:12:26 INFO - PID 12281 | RSS: Main: 162078720 08:12:26 INFO - PID 12281 | 08:12:29 INFO - PID 12281 | Cycle 1(1): loaded http://localhost:55681/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:12:29 INFO - PID 12281 | RSS: Main: 162914304 08:12:29 INFO - PID 12281 | 08:12:32 INFO - PID 12281 | Cycle 1(1): loaded http://localhost:55681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:12:33 INFO - PID 12281 | RSS: Main: 165797888 08:12:33 INFO - PID 12281 | 08:12:35 INFO - PID 12281 | Cycle 1(1): loaded http://localhost:55681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55681/tests/kraken/driver.html?testName=ai-astar) 08:12:35 INFO - PID 12281 | RSS: Main: 167235584 08:12:35 INFO - PID 12281 | 08:12:35 INFO - PID 12281 | __start_tp_report 08:12:35 INFO - PID 12281 | _x_x_mozilla_page_load 08:12:35 INFO - PID 12281 | _x_x_mozilla_page_load_details 08:12:35 INFO - PID 12281 | |i|pagename|runs| 08:12:35 INFO - PID 12281 | |0;ai-astar;111;118;118;118;119;118;119;118;118;119 08:12:35 INFO - PID 12281 | |1;audio-beat-detection;160;133;130;173;127;124;126;128;164;126 08:12:35 INFO - PID 12281 | |2;audio-dft;164;164;166;175;169;168;161;166;163;162 08:12:35 INFO - PID 12281 | |3;audio-fft;76;76;75;105;76;78;78;76;100;76 08:12:35 INFO - PID 12281 | |4;audio-oscillator;86;84;122;84;85;85;101;86;85;111 08:12:35 INFO - PID 12281 | |5;imaging-gaussian-blur;113;114;113;114;114;115;114;113;114;115 08:12:35 INFO - PID 12281 | |6;imaging-darkroom;151;150;149;150;150;151;151;151;151;152 08:12:35 INFO - PID 12281 | |7;imaging-desaturate;95;95;99;95;95;95;94;94;95;95 08:12:35 INFO - PID 12281 | |8;json-parse-financial;72;67;69;69;70;69;68;68;69;80 08:12:35 INFO - PID 12281 | |9;json-stringify-tinderbox;55;56;54;56;55;54;56;59;55;56 08:12:35 INFO - PID 12281 | |10;stanford-crypto-aes;86;85;86;86;86;86;92;85;85;84 08:12:35 INFO - PID 12281 | |11;stanford-crypto-ccm;139;138;132;134;140;140;135;136;190;145 08:12:35 INFO - PID 12281 | |12;stanford-crypto-pbkdf2;184;188;187;184;184;185;189;181;193;186 08:12:35 INFO - PID 12281 | |13;stanford-crypto-sha256-iterative;69;70;69;73;69;69;68;68;68;67 08:12:35 INFO - PID 12281 | __end_tp_report 08:12:35 INFO - PID 12281 | __start_cc_report 08:12:35 INFO - PID 12281 | _x_x_mozilla_cycle_collect,889 08:12:35 INFO - PID 12281 | __end_cc_report 08:12:35 INFO - PID 12281 | __startTimestamp1489417955616__endTimestamp 08:12:35 INFO - PID 12281 | 08:12:35 INFO - PID 12281 | ------- Summary: start ------- 08:12:35 INFO - PID 12281 | Number of tests: 14 08:12:35 INFO - PID 12281 | 08:12:35 INFO - PID 12281 | [#0] ai-astar Cycles:10 Average:117.60 Median:118.00 stddev:2.37 (2.0%) stddev-sans-first:0.50 08:12:35 INFO - PID 12281 | Values: 111.0 118.0 118.0 118.0 119.0 118.0 119.0 118.0 118.0 119.0 08:12:35 INFO - PID 12281 | 08:12:35 INFO - PID 12281 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:131.50 stddev:18.76 (14.3%) stddev-sans-first:18.31 08:12:35 INFO - PID 12281 | Values: 160.0 133.0 130.0 173.0 127.0 124.0 126.0 128.0 164.0 126.0 08:12:35 INFO - PID 12281 | 08:12:35 INFO - PID 12281 | [#2] audio-dft Cycles:10 Average:165.80 Median:166.00 stddev:4.10 (2.5%) stddev-sans-first:4.30 08:12:35 INFO - PID 12281 | Values: 164.0 164.0 166.0 175.0 169.0 168.0 161.0 166.0 163.0 162.0 08:12:35 INFO - PID 12281 | 08:12:35 INFO - PID 12281 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:11.12 (14.6%) stddev-sans-first:11.61 08:12:35 INFO - PID 12281 | Values: 76.0 76.0 75.0 105.0 76.0 78.0 78.0 76.0 100.0 76.0 08:12:35 INFO - PID 12281 | 08:12:35 INFO - PID 12281 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:85.00 stddev:13.67 (16.1%) stddev-sans-first:14.27 08:12:35 INFO - PID 12281 | Values: 86.0 84.0 122.0 84.0 85.0 85.0 101.0 86.0 85.0 111.0 08:12:35 INFO - PID 12281 | 08:12:35 INFO - PID 12281 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 08:12:35 INFO - PID 12281 | Values: 113.0 114.0 113.0 114.0 114.0 115.0 114.0 113.0 114.0 115.0 08:12:35 INFO - PID 12281 | 08:12:35 INFO - PID 12281 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 08:12:35 INFO - PID 12281 | Values: 151.0 150.0 149.0 150.0 150.0 151.0 151.0 151.0 151.0 152.0 08:12:35 INFO - PID 12281 | 08:12:35 INFO - PID 12281 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.40 (1.5%) stddev-sans-first:1.48 08:12:35 INFO - PID 12281 | Values: 95.0 95.0 99.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 08:12:35 INFO - PID 12281 | 08:12:35 INFO - PID 12281 | [#8] json-parse-financial Cycles:10 Average:70.10 Median:69.00 stddev:3.73 (5.4%) stddev-sans-first:3.89 08:12:35 INFO - PID 12281 | Values: 72.0 67.0 69.0 69.0 70.0 69.0 68.0 68.0 69.0 80.0 08:12:35 INFO - PID 12281 | 08:12:35 INFO - PID 12281 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:1.43 (2.6%) stddev-sans-first:1.50 08:12:35 INFO - PID 12281 | Values: 55.0 56.0 54.0 56.0 55.0 54.0 56.0 59.0 55.0 56.0 08:12:35 INFO - PID 12281 | 08:12:35 INFO - PID 12281 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:2.18 (2.5%) stddev-sans-first:2.32 08:12:35 INFO - PID 12281 | Values: 86.0 85.0 86.0 86.0 86.0 86.0 92.0 85.0 85.0 84.0 08:12:35 INFO - PID 12281 | 08:12:35 INFO - PID 12281 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:139.50 stddev:16.95 (12.2%) stddev-sans-first:17.92 08:12:35 INFO - PID 12281 | Values: 139.0 138.0 132.0 134.0 140.0 140.0 135.0 136.0 190.0 145.0 08:12:35 INFO - PID 12281 | 08:12:35 INFO - PID 12281 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.10 Median:186.50 stddev:3.35 (1.8%) stddev-sans-first:3.46 08:12:35 INFO - PID 12281 | Values: 184.0 188.0 187.0 184.0 184.0 185.0 189.0 181.0 193.0 186.0 08:12:35 INFO - PID 12281 | 08:12:35 INFO - PID 12281 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.63 (2.4%) stddev-sans-first:1.73 08:12:35 INFO - PID 12281 | Values: 69.0 70.0 69.0 73.0 69.0 69.0 68.0 68.0 68.0 67.0 08:12:35 INFO - PID 12281 | -------- Summary: end -------- 08:12:35 INFO - PID 12281 | 08:12:36 INFO - TEST-INFO | 12281: exit 0 08:12:36 INFO - TEST-OK | kraken | took 64788ms 08:12:36 INFO - SUITE-END | took 1185s 08:12:37 INFO - Completed test suite (00:19:45) 08:12:37 INFO - javascript benchmark 08:12:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6634.007666556886, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2668.052841241359, 2672.291842661694, 2672.6926403463594, 2686.2075687672136, 2694.2321438390063, 4937.234728617061, 5016.974915125419, 5021.196608542634, 5051.873703157423, 5060.5951523878, 4998.525140111684, 5009.524095210958, 5019.422766381867, 5033.471485494026, 5049.9747501262445, 4544.636429085674, 4652.0, 4658.9517358594385, 4662.160811054009, 4673.719576825384, 4655.185342565054, 4671.182543054969, 4687.531246875302, 4697.67116301859, 4734.881627959294, 4593.747343896084, 4620.052889157714, 4639.327297541838, 4655.837045703418, 4669.906601867943, 4644.651651126179, 4647.53524647536, 4658.161530924433, 4699.78850951708, 4702.341672165865, 4565.5206203348835, 4607.585317321424, 4609.147307748078, 4621.168189725848, 4653.976730116362, 4899.387576552931, 4913.410390753133, 4933.333999910038, 4964.131277026506, 5007.223880298559, 5330.147176451749, 5341.1187154119525, 5362.034833729927, 5390.78436862525, 5394.91907621386, 5401.864953376158, 5411.702356370398, 5413.350397952271, 5418.91871621926, 5424.240606315119, 4906.607471402351, 5046.39443266803, 5060.671056381323, 5063.670861393997, 5104.2088476286235, 5447.863803404867, 5457.563394928476, 5460.34475862899, 5501.284832971768, 5519.806806761824, 5124.205748108974, 5138.58891288696, 5277.261183434322, 5328.280682107866, 5335.413104558495, 5303.575713942875, 5397.433269506645, 5422.349318081855, 5423.0, 5437.238786569884, 5211.931554031415, 5385.676859388449, 5398.433164517748, 5398.892022159614, 5457.672539647634, 5272.288241087481, 5311.442298558673, 5334.039872822929, 5345.412004679482, 5376.059189641797, 4479.10417916418, 4508.616767574727, 4515.2549829277805, 4515.277555591089, 4549.567791059844, 3812.694984401241, 3842.135519508144, 3865.0917034497434, 3891.8832435026993, 3895.376739721631, 4563.338315944236, 4595.862124136282, 4614.054118905617, 4614.515475874985, 4682.812687492462, 5410.513053825174, 5425.457454254622, 5431.2396264522995, 5434.701091440009, 5481.725913704378, 4649.814007439664, 4650.116477869194, 4654.883627909262, 4655.534446555317, 4683.086798074411, 4740.336352910595, 4785.665003449794, 4793.952060479421, 4797.160496913027, 4835.419749629997, 5019.092744756969, 5037.942032173138, 5040.243963405518, 5062.139436295765, 5062.31658726082, 5392.218128371285, 5430.15832545956, 5439.0, 5468.589855760913, 5480.671159730429, 5073.264376665436, 5078.238264260391, 5078.365204349457, 5080.390353157644, 5122.129238029469, 5201.635885488131, 5211.9478805212975, 5300.893982120258, 5322.387925388475, 5333.439988801275, 5297.54970827484, 5431.185322201702, 5439.782408703608, 5490.423505532021, 5500.092484740133, 5204.401493828258, 5231.89536209266, 5269.0, 5285.312909321764, 5303.681779093266, 5182.300389447376, 5253.238280449237, 5272.736363181903, 5279.023380674587, 5280.260763493191, 5051.368578927634, 5103.362079740033, 5115.053715062725, 5148.4851514848215, 5157.020166168416, 5308.124159513792, 5315.282436870973, 5331.067063263991, 5359.356877174764, 5386.380566234777, 5121.795128194831, 5153.768080436314, 5157.638965272395, 5180.896382072413, 5208.479152084913], "value": 4926.619821743692, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.3420847569382, 708.2138825903246, 729.7008226627082, 848.2196379331015, 863.1497974495118, 33915.66084339156, 34267.82866085669, 36784.26431471372, 36922.446163307504, 37037.44443833345, 32847.67152328476, 33062.504062439024, 33071.83464082676, 33081.17297067575, 33131.33737325252, 6387.425131738131, 9289.628414863431, 9475.952620236923, 9716.271279654018, 9728.51357432129, 9259.074092590754, 9266.860997085048, 9270.39742416744, 9273.562597797352, 9316.813663726722, 9305.906940930572, 9336.0, 9361.20429763471, 9391.859122113174, 9404.153626173644, 9300.348975571713, 9328.300377471716, 9331.25349972004, 9343.672971446034, 9368.859467107999, 9174.587143578556, 9180.31147663928, 9195.172434480863, 9224.0, 9224.538773061387, 34657.48013779795, 34665.0, 34862.0, 34907.1273218169, 35077.64922350795, 3341.866325346983, 3440.34633419652, 3445.3453843769603, 3474.1488335358, 3493.1791029108394, 24034.87982560076, 24479.632805507932, 24493.755062449327, 24560.385990350205, 24604.138855139983, 3305.9669403305898, 3467.739919506047, 3586.3903136466865, 3593.281343731238, 3594.02961200477, 157005.0, 157742.0, 159486.20256898756, 162164.0, 172820.99999999875, 44726.32910506345, 44736.55263447389, 44929.101417971455, 44972.77513612411, 45012.77493612577, 45839.54160458419, 46166.53833461623, 46443.0, 46470.767646161556, 46755.76622116868, 11494.770104597861, 11558.0, 11569.479373428216, 11590.304581724955, 11624.825627615592, 8994.775130621656, 9006.86489702655, 9007.0, 9027.819443611092, 9032.909670903338, 11129.443527823576, 11421.885781142082, 13389.464421423034, 13464.730705385837, 13570.796438053438, 5311.176767601028, 5465.699386533779, 5483.698396588146, 5551.639143455663, 5600.719964001865, 958.1233171648004, 1003.6587560229557, 1008.6822650864954, 1012.711377257478, 1054.7204990677476, 22900.65649015266, 23247.0, 23371.88314058419, 23373.181938632068, 23534.882325588605, 1061.2836335473523, 1075.2473268711933, 1082.4804094034907, 1082.4804094034907, 1097.846301517788, 11729.941350293195, 12403.75192496163, 12448.128630995743, 12579.182353147016, 12586.87413125857, 217000.0, 218367.0, 218399.0, 218853.0, 218930.0, 43115.56884431178, 43355.34966975498, 43439.782801086425, 43511.34732979008, 43639.563604364186, 1182.5717031667027, 1222.9633111006683, 1229.551213806954, 1231.2612432540404, 1240.4294024748717, 21647.675284870424, 21748.23881164215, 22640.0, 22780.0, 22923.083076676747, 35830.0, 35835.82082089573, 35844.462333064504, 35852.64147358493, 35864.28271434609, 177941.0, 178603.0, 178877.0, 178960.0, 179569.0, 29383.853080734458, 29542.852285738434, 30751.0, 31714.0, 34197.82901085479, 37634.24731505409, 37929.0, 38063.429048564845, 38856.41715374215, 39144.217115658095, 32696.019119426455, 33039.174020649676, 33209.33581328311, 33514.664853351154, 33629.0, 32300.515492268103, 32521.373931302867, 32853.67146328506, 32997.83501082479, 33638.49542256917, 31780.205494862814, 32361.838190809838, 32487.837560812044, 32791.8360408206, 32815.179620509676, 26463.470730584897, 28934.42131157407, 29543.704562954095, 29606.555901661923, 29631.555526666685, 22894.656580151644, 23027.0, 23053.308400748003, 23140.950333691875, 23221.88389058044], "value": 15991.674859842005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.4755425963741, 382.45500162268775, 383.313868175965, 384.62499063413173, 399.1657435958845, 17319.220635071422, 18694.345697900575, 18881.433556993295, 19009.144588493516, 19093.331733389336, 17769.0, 18061.548461288443, 18321.633567328645, 18536.165872535734, 18547.629047419043, 5537.833864984037, 5570.693611851347, 5809.7676092956235, 5811.593188476787, 5821.097729851858, 5617.157426386034, 5769.855753606173, 5773.076307790754, 5774.0, 5778.942210577903, 5515.779368825242, 5719.571032172583, 5774.682392468412, 5781.219535362735, 5797.652140871562, 5630.605857589971, 5717.656940583578, 5719.971400143014, 5733.684647344395, 5743.684097374643, 5575.665460072409, 5578.163275508706, 5612.915806262909, 5626.212330273765, 5631.0, 21447.356579302646, 21629.0, 21642.783572164233, 21755.456113597127, 21862.344129675977, 2376.940576485584, 2388.749181335952, 2418.576749068906, 2445.9950820735053, 2453.116877923946, 13813.51652692161, 14209.36057877398, 14230.217338046403, 14254.501092461818, 14758.852411475855, 1865.6175484025878, 1908.2176307713771, 1914.3586898389055, 1923.855710821694, 1933.806619338069, 88633.55683221543, 90450.5477472615, 90552.0, 92235.07764922331, 93166.0, 15281.38874445032, 16193.761247750497, 16542.66914661724, 16598.502044938672, 16606.0, 28976.71023289782, 29007.85496072506, 29017.41965160685, 29036.0, 29231.0, 7911.446198766032, 8058.234467725557, 8062.193780621891, 8349.03986041613, 8415.705450309331, 6449.6130232186215, 6505.772297969548, 6650.567713098633, 6672.331067572913, 6694.125644819458, 8628.396012279205, 8835.514046727363, 8918.598663060178, 8928.375013749104, 9013.504257265913, 3420.9828950855085, 3532.876349327761, 3594.3170797548382, 3772.5475691858283, 3888.2612303662213, 965.56066989521, 1013.4679293370892, 1049.2864851900629, 1049.7795462952865, 1050.9369437833602, 17543.649127017386, 18965.336213232746, 18998.24007039703, 18999.145038473303, 19223.231070757294, 978.8189185000798, 989.5497548615363, 991.2268430624125, 1016.1312078173204, 1021.300409219672, 9975.0, 10067.748306292402, 10386.844197337046, 10458.424786636655, 10515.84226236607, 309020.0, 313254.0, 467205.0, 471196.0, 485557.0, 67625.6618716913, 82436.17563824284, 88180.55909720539, 88958.0, 93809.0, 1096.3421946831998, 1109.417555783204, 1157.5254145800182, 1185.2769810415639, 1189.958351457712, 17545.122743863012, 17596.208170632097, 18189.18148683339, 18246.908765456617, 18252.908735456767, 28776.85611571929, 31445.213869653442, 41117.79441102775, 41883.581164189185, 42225.155496890504, 53246.73376633092, 53434.732826337175, 53628.0, 56498.43501564932, 57835.84328313326, 10682.305650132717, 11023.126068568523, 11054.557817687202, 11361.375124367909, 11913.642590722293, 12244.204126731735, 12356.505739770308, 12384.690382740504, 12795.808062878878, 13164.14433061848, 10510.632127875488, 10550.525226364985, 10686.465676715978, 10920.2901811382, 11048.613298534512, 11009.83485247738, 11041.619797525309, 11086.002259796656, 11271.211015228855, 11491.0, 10654.840177397191, 10805.891941080488, 10849.891501084889, 11045.116390688887, 11177.0, 10869.347839129678, 10909.890901090888, 11019.83470247963, 11137.99758021782, 11177.099893018369, 10268.948655256676, 10565.894341056492, 10601.204909631655, 10663.093637040938, 10832.079273261861], "value": 9816.953484810023, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1425.3657122580444, 1461.6345913521627, 1462.692834504754, 1470.125275461101, 1472.006395682914, 9077.137671921166, 9643.951780241088, 9733.221342292618, 9733.318667693264, 9932.851007234898, 9454.101860323275, 9595.232381409487, 9604.183644390218, 9607.567659455324, 9651.517424128782, 1845.2065611786927, 1867.057136146251, 1867.1691097461635, 1876.2963888541797, 1878.7088001359812, 1848.7966323704381, 1874.2690350763214, 1900.3633782682748, 1900.6483800496953, 1906.3994841624913, 1897.848172146232, 1898.8860668359873, 1904.780950190725, 1907.2561700936647, 1915.6551820672273, 1711.6747817914618, 1744.7557341972133, 1745.3018792483044, 1748.1521462090875, 1754.999650199387, 1768.7612172356696, 1769.973450398245, 1819.0540918722322, 1820.4356649438716, 1834.5688763140786, 9605.087516685904, 9672.75818104546, 9681.322307438482, 9686.806263874754, 9714.465704386255, 4561.657875659305, 4745.359376484165, 4746.83386081489, 4748.240281554969, 4763.737994410306, 2491.402063504746, 2556.348131226544, 2602.128287023849, 2619.9214023579134, 2634.0254105980716, 897.174599368576, 910.2081189365229, 928.3130483442204, 931.8602209668536, 952.0764858087643, 11606.70983225426, 11926.165168438212, 12991.480340786262, 13491.527796527173, 13680.0, 3689.6494832990825, 3737.8131093445218, 3845.1540661054523, 3877.2746127973346, 3895.7467764595776, 10410.219233557362, 10423.791524169626, 10437.68686939393, 10468.162546996222, 10493.790124197474, 4630.884227894329, 4632.791524381411, 4647.024124933801, 4656.837010704609, 4685.508021657745, 4070.1859628074503, 4242.44848169736, 4267.317229243306, 4267.743935363826, 4289.82840686369, 3109.2693217093965, 3132.6084239470065, 3193.936121277608, 3197.184717896968, 3218.6137663480063, 768.9702571866827, 770.2836362183224, 780.7969927818694, 782.1904329019437, 782.2255966593032, 845.966161353539, 851.3529717414685, 862.8533149364498, 876.2420506262165, 883.3992884838372, 5553.611247212656, 5741.224934633771, 5755.181154018173, 5765.798197063166, 5988.071848863433, 925.1950802801606, 937.5452905340904, 950.7385468995943, 963.633819148719, 967.9467629280316, 3629.201575653352, 3843.8078096095082, 3850.845966161322, 3867.3425517662067, 3933.6853051755793, 11606.477708503138, 11946.462409191607, 11984.940075299568, 11998.160128790902, 12022.819657705142, 11776.52893884235, 11882.0, 11883.524659013543, 11994.280343179436, 12006.819897701542, 8774.298056155492, 8850.601722922484, 8909.420887642282, 8971.102889710846, 9001.369904106781, 5090.796368145233, 5707.514861236841, 5777.451142141658, 5780.94219057804, 5924.140999555127, 9915.504224788876, 10069.848952265575, 10166.390016599027, 10214.795704086026, 10249.897501025192, 10064.899351006688, 10511.211659125443, 10634.84047739269, 10692.305000174963, 10867.891321086689, 7791.948087008182, 7941.0, 7941.086775020946, 7945.404094693036, 7946.483478573874, 8825.69110081144, 8953.776155596162, 9085.182333590008, 9130.223930965942, 9154.267658587163, 7913.050433947733, 8051.83896322082, 8054.476459030145, 8162.306203972729, 8303.543305118035, 7910.604469776603, 8032.83934321322, 8069.072056713553, 8092.514449133071, 8151.83696326082, 6903.89644155328, 6975.651217439006, 7016.5088443808445, 7021.332973367522, 7038.718451262097, 4945.579625731853, 4965.50344965515, 5018.749062546931, 5029.044481548494, 5236.659617124875, 5352.116900711495, 5385.3268341457315, 5414.3232095988005, 5427.0, 5662.688552129673], "value": 4345.8520499636925, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.1729876141686, 362.96733294003536, 365.66541614422823, 371.73235270605153, 371.7712958671591, 4719.339292499053, 4842.443119041312, 4921.557059864612, 4961.950380496194, 4967.155583550801, 4747.0, 4786.401699787527, 4795.0, 4802.663813533054, 4846.515348465152, 4191.742477256826, 4202.369644553319, 4206.768627725489, 4221.366794980762, 4249.915001699964, 3878.5151856017997, 4242.409096588779, 4257.510386305568, 4268.0, 4273.081287523182, 4040.151568170688, 4052.5136983562015, 4055.3308704063793, 4060.4315395844606, 4080.4491393661774, 4049.8785036448953, 4063.0136849415953, 4072.9592704073025, 4096.0, 4100.425940368321, 3816.790076545789, 3828.559715632682, 3848.1149335652676, 3854.807259637007, 3859.112404147062, 4559.695953855127, 4683.906321873577, 4713.198756211452, 4758.78585463655, 4759.214729569617, 4664.253719404913, 4669.509701481329, 4678.204705200124, 4687.5781179693995, 4698.3689134085025, 5069.949300506984, 5116.488351164891, 5124.743762811881, 5132.3568362293445, 5143.614228932845, 3891.750388425668, 4098.7950602469755, 4100.36444351126, 4163.2298024865195, 4204.411382406465, 5073.695578265316, 5181.248718935771, 5207.791688332462, 5293.544275324278, 5305.442928492491, 4231.196072746168, 4237.576242375738, 4240.70658449176, 4276.187524370422, 4280.636145927631, 4323.459567554056, 4328.98268906813, 4341.848035318749, 4344.847930322424, 4344.869653910388, 4433.224185767478, 4667.603253723471, 4669.883252918704, 4679.262631360624, 4692.882677933079, 5060.7722652480725, 5079.466656001141, 5087.97456012725, 5094.643374963717, 5098.311727916684, 1513.1980050573213, 1528.7324718174275, 1533.9079655220723, 1534.511523821891, 1534.608674787922, 1090.4220762995626, 1161.9012383947459, 1163.778882012432, 1165.8018136916744, 1180.403896032498, 4444.622207112367, 4468.597826195593, 4493.662975276802, 4506.526814684476, 4523.638108951276, 5198.818041368534, 5202.843914682566, 5240.9213861792105, 5245.0, 5261.71088083422, 4233.740020184441, 4470.508244093147, 4513.172165273069, 4521.892136426596, 4526.524714904954, 2746.8489233091973, 2758.7517123458583, 2760.6963234044238, 2764.9308767280577, 2773.0987429085226, 4868.172410690191, 4916.901661966741, 4927.708615493741, 4931.58081563064, 4942.505749425029, 5110.66780659256, 5312.7343632818975, 5338.199270109515, 5348.812791552355, 5361.839144825662, 4881.755912204376, 4894.290327902434, 4901.054651005975, 4902.955062073732, 4904.828331008326, 5174.0, 5229.0, 5276.680829792552, 5300.416954134965, 5327.147656374961, 4966.602671786321, 5177.378714554277, 5199.818006369759, 5238.659487133325, 5251.789928402821, 4826.782794774173, 4852.95147048525, 4873.1959226727195, 4907.852764417074, 4920.360353154067, 4248.553901840262, 4262.786860656893, 4298.591633794785, 4310.676699247631, 4322.675799315127, 5149.613778966667, 5289.523942845162, 5323.653962492425, 5327.893442131213, 5345.358556973188, 5145.14774681122, 5147.897042059213, 5168.508991645787, 5176.482351764794, 5184.185535062697, 5054.140796064751, 5094.7962081516325, 5119.436861945258, 5126.436092029949, 5150.630709873501, 4897.926531101965, 5005.34930459038, 5028.2960385546785, 5056.710538812579, 5078.746062696924, 5089.338386009795, 5104.285400043923, 5116.0, 5127.820526281562, 5148.279240906351, 4969.0, 5045.672031317952, 5065.341505604248, 5067.214581739836, 5110.437851836369], "value": 4038.227730048157, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.6064164709409, 732.4835990626609, 759.3431681595422, 760.444875241074, 772.9111152217494, 12793.616191514246, 14194.0, 14203.360848761804, 14204.218767967757, 14297.785533216997, 13583.660408489794, 13879.236641984688, 13918.721625567508, 14003.859961400383, 14025.859741402583, 827.3960009193278, 845.4546817302836, 859.2352806002632, 859.3125499600326, 859.4370687199894, 847.3306088190322, 853.1809462915578, 853.338662536536, 854.0221446443818, 856.1866227084264, 898.3980732908934, 903.6249956268141, 906.650939388337, 906.7325139083986, 909.1454033208796, 896.8385690575726, 898.4654130792168, 900.5677274908015, 906.1708536688922, 906.9773255668628, 661.4642139866723, 665.4643012375036, 668.1147479589563, 668.7826456401689, 670.1957650819037, 11272.154588405903, 11459.713507162303, 11822.113341499422, 11891.227070240408, 11952.880471195263, 10746.24776265654, 10837.252684011037, 10991.285566438157, 11273.210875238736, 11433.256838305484, 9324.580393882292, 9378.906210937872, 9450.43297402158, 9659.130678238993, 9666.081722236377, 3176.301213732975, 3209.6950789674943, 3226.9677303226904, 3238.426537355536, 3289.4243507386113, 48522.75738621284, 50590.0, 55715.721421392635, 61844.69077654583, 62943.0, 10702.46487675613, 10703.1437485001, 10776.730581735363, 10897.073748731447, 11028.669139925814, 20503.28238511645, 20583.794162058486, 20606.690899636516, 20610.38168854937, 20619.69070463944, 5861.589688721749, 6070.089486577049, 6605.933940660628, 6630.5027122965, 6808.5914845109455, 3110.5023196288485, 3249.382617302705, 3298.5876765404323, 3326.2183386904057, 3327.500874868789, 2632.552466080771, 2681.6245725598433, 2701.6622922134734, 2706.174616741913, 2717.212008517508, 440.90961352922574, 444.4022789348386, 449.3978069387037, 449.99201787994656, 452.0258842195075, 576.1591714472221, 589.4606435111824, 591.1989254560095, 592.5259792166249, 628.8082134948885, 7670.7315243966195, 8327.625256863455, 8351.624176912053, 8614.87077693835, 8695.347848911357, 548.3967635600807, 561.4049107945509, 565.9688717120515, 583.3087790967717, 627.595201095291, 3786.450964610171, 3849.2533304149533, 3853.556840963269, 3889.727719059695, 4004.199160167978, 63291.0, 64327.67836160883, 64396.356036439036, 66339.66830165914, 66476.66761666257, 43442.0, 50770.49229507732, 54187.0, 54326.45673543214, 54909.450905491234, 49397.50602493929, 49615.75192124016, 50299.24551131736, 52021.47978520166, 54740.0, 8964.910350896407, 9540.809183816424, 9575.808483830424, 9583.808323833624, 9738.561764720464, 33118.337633246716, 33274.33451330911, 34363.65636343705, 34390.82804585961, 34566.82716586502, 40332.59667403289, 40464.79767601143, 41101.0, 42151.7892410536, 42300.36549451699, 12242.0, 12276.938615306866, 12302.0, 12572.685682858002, 12635.557755478882, 13001.869981300066, 13358.198508089547, 13699.45202191901, 13797.724045519235, 13826.0, 11371.0, 11578.373015873016, 11936.940315298716, 11979.76040479203, 12231.938840305742, 11484.425778711198, 12051.276923384625, 12085.456154472893, 12154.02767778558, 13073.215607063607, 11682.591109311474, 11960.342181180118, 12479.438425270702, 12542.1847579907, 12602.936985315015, 9689.934077331955, 9715.514224288898, 10134.645287414905, 10237.0, 10430.217733669853, 8845.946646980146, 10131.08820206185, 10132.696019119438, 10186.643467478603, 10215.591376344863], "value": 6279.527253936191, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1566.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 118.0, 118.0, 118.0, 119.0, 118.0, 119.0, 118.0, 118.0, 119.0], "value": 117.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 133.0, 130.0, 173.0, 127.0, 124.0, 126.0, 128.0, 164.0, 126.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 166.0, 175.0, 169.0, 168.0, 161.0, 166.0, 163.0, 162.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 105.0, 76.0, 78.0, 78.0, 76.0, 100.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 122.0, 84.0, 85.0, 85.0, 101.0, 86.0, 85.0, 111.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 149.0, 150.0, 150.0, 151.0, 151.0, 151.0, 151.0, 152.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 99.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 69.0, 69.0, 70.0, 69.0, 68.0, 68.0, 69.0, 80.0], "value": 70.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 56.0, 55.0, 54.0, 56.0, 59.0, 55.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 86.0, 86.0, 86.0, 92.0, 85.0, 85.0, 84.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 132.0, 134.0, 140.0, 140.0, 135.0, 136.0, 190.0, 145.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 188.0, 187.0, 184.0, 184.0, 185.0, 189.0, 181.0, 193.0, 186.0], "value": 186.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 73.0, 69.0, 69.0, 68.0, 68.0, 68.0, 67.0], "value": 69.0, "unit": "score"}]}]} 08:12:37 INFO - Return code: 0 08:12:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:12:37 ERROR - # TBPL SUCCESS # 08:12:37 INFO - Running post-action listener: _resource_record_post_action 08:12:37 INFO - [mozharness: 2017-03-13 15:12:37.444658Z] Finished run-tests step (success) 08:12:37 INFO - Running post-run listener: _resource_record_post_run 08:12:37 INFO - Total resource usage - Wall time: 1201s; CPU: 14.0%; Read bytes: 0; Write bytes: 362348544; Read time: 0; Write time: 186776 08:12:37 INFO - TinderboxPrint: CPU usage
13.6% 08:12:37 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:12:37 INFO - TinderboxPrint: I/O write bytes / time
362,348,544 / 186,776 08:12:37 INFO - TinderboxPrint: CPU idle
8,281.8 (86.4%) 08:12:37 INFO - TinderboxPrint: CPU user
1,242.8 (13.0%) 08:12:37 INFO - TinderboxPrint: Swap in / out
0 / 0 08:12:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 104996864; Read time: 0; Write time: 55592 08:12:37 INFO - run-tests - Wall time: 1186s; CPU: 14.0%; Read bytes: 0; Write bytes: 257351680; Read time: 0; Write time: 131184 08:12:38 INFO - Running post-run listener: _upload_blobber_files 08:12:38 INFO - Blob upload gear active. 08:12:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:12:38 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 08:12:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:12:38 INFO - (blobuploader) - INFO - Open directory for files ... 08:12:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:12:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:12:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:39 INFO - (blobuploader) - INFO - Done attempting. 08:12:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:12:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:12:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:40 INFO - (blobuploader) - INFO - Done attempting. 08:12:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:12:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:12:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:41 INFO - (blobuploader) - INFO - Done attempting. 08:12:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:12:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:12:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:44 INFO - (blobuploader) - INFO - Done attempting. 08:12:44 INFO - (blobuploader) - INFO - Iteration through files over. 08:12:44 INFO - Return code: 0 08:12:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:12:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:12:44 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2a7f70c4719488e7133f6e39c6bf2579db17cc2866cc268cb1be3daef5388bd64a6d34011cb9536b7ec690f53cc8f10eb012395f09c8ad97170794e63f4de47", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/200c1e88e31a35a07b70c488fc9cdd9ca0ab6317c130e69a7645e0125f9bb80932adb9fa3ed85f53b497fe444941f627896c0d53d1dcbb03bcb10b8d4effaca5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c67ddce6990d043be859bef4c3e4ccebec4bda8a6cd17e81c9e0230e62b1cab3ca8d37cb13dae7d3738dcd92c6ea439aef100e3c1ca966c75f6a370bff6aac3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60bea1adeb445b86b74d6251ffa68a6d4092555c348463344eed9b24dfb529ae8e52319678ca45585137d68c4b4324b6227e41e2c3c20322a761b4e012e0d866"} 08:12:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:12:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:12:44 INFO - Contents: 08:12:44 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2a7f70c4719488e7133f6e39c6bf2579db17cc2866cc268cb1be3daef5388bd64a6d34011cb9536b7ec690f53cc8f10eb012395f09c8ad97170794e63f4de47", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/200c1e88e31a35a07b70c488fc9cdd9ca0ab6317c130e69a7645e0125f9bb80932adb9fa3ed85f53b497fe444941f627896c0d53d1dcbb03bcb10b8d4effaca5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c67ddce6990d043be859bef4c3e4ccebec4bda8a6cd17e81c9e0230e62b1cab3ca8d37cb13dae7d3738dcd92c6ea439aef100e3c1ca966c75f6a370bff6aac3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60bea1adeb445b86b74d6251ffa68a6d4092555c348463344eed9b24dfb529ae8e52319678ca45585137d68c4b4324b6227e41e2c3c20322a761b4e012e0d866"} 08:12:44 INFO - Running post-run listener: copy_logs_to_upload_dir 08:12:44 INFO - Copying logs to upload dir... 08:12:44 INFO - mkdir: /builds/slave/test/build/upload/logs 08:12:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.237395 ========= master_lag: 0.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-13 08:12:44.873841) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-13 08:12:44.878394) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2a7f70c4719488e7133f6e39c6bf2579db17cc2866cc268cb1be3daef5388bd64a6d34011cb9536b7ec690f53cc8f10eb012395f09c8ad97170794e63f4de47", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/200c1e88e31a35a07b70c488fc9cdd9ca0ab6317c130e69a7645e0125f9bb80932adb9fa3ed85f53b497fe444941f627896c0d53d1dcbb03bcb10b8d4effaca5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c67ddce6990d043be859bef4c3e4ccebec4bda8a6cd17e81c9e0230e62b1cab3ca8d37cb13dae7d3738dcd92c6ea439aef100e3c1ca966c75f6a370bff6aac3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60bea1adeb445b86b74d6251ffa68a6d4092555c348463344eed9b24dfb529ae8e52319678ca45585137d68c4b4324b6227e41e2c3c20322a761b4e012e0d866"} build_url:https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/EnFxVZKkSnKX8H9_NSlwfg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2a7f70c4719488e7133f6e39c6bf2579db17cc2866cc268cb1be3daef5388bd64a6d34011cb9536b7ec690f53cc8f10eb012395f09c8ad97170794e63f4de47", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/200c1e88e31a35a07b70c488fc9cdd9ca0ab6317c130e69a7645e0125f9bb80932adb9fa3ed85f53b497fe444941f627896c0d53d1dcbb03bcb10b8d4effaca5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c67ddce6990d043be859bef4c3e4ccebec4bda8a6cd17e81c9e0230e62b1cab3ca8d37cb13dae7d3738dcd92c6ea439aef100e3c1ca966c75f6a370bff6aac3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60bea1adeb445b86b74d6251ffa68a6d4092555c348463344eed9b24dfb529ae8e52319678ca45585137d68c4b4324b6227e41e2c3c20322a761b4e012e0d866"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-13 08:12:44.911045) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 08:12:44.911460) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1489416615.174808-1310529969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 08:12:44.960678) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-13 08:12:44.964031) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-13 08:12:44.964333) ========= ========= Total master_lag: 0.62 =========